builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1459768849.38 results: success (0) buildid: 20160404025621 builduid: 29637d11b10f4c288fc24e5d9d09fcc9 revision: 9bd90088875399347b05d87c67d3709e31539dcd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.382288) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.382849) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.383204) ========= 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.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005621 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.406417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.406751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.422863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.423172) ========= 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.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005124 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.471395) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.471735) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.472159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.472498) ========= 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.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-04 04:20:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-04 04:20:49 (46.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.647430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.647808) ========= 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.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.020655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:49.697713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 04:20:49.698110) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9bd90088875399347b05d87c67d3709e31539dcd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9bd90088875399347b05d87c67d3709e31539dcd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-04 04:20:49,770 truncating revision to first 12 chars 2016-04-04 04:20:49,770 Setting DEBUG logging. 2016-04-04 04:20:49,770 attempt 1/10 2016-04-04 04:20:49,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9bd900888753?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 04:20:50,688 unpacking tar archive at: mozilla-central-9bd900888753/testing/mozharness/ program finished with exit code 0 elapsedTime=1.170658 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 04:20:51.138763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:51.139216) ========= echo 9bd90088875399347b05d87c67d3709e31539dcd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9bd90088875399347b05d87c67d3709e31539dcd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 9bd90088875399347b05d87c67d3709e31539dcd program finished with exit code 0 elapsedTime=0.004474 script_repo_revision: '9bd90088875399347b05d87c67d3709e31539dcd' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:51.163869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:51.164192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 04:20:51.177958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-04-04 04:20:51.178286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:20:51 INFO - MultiFileLogger online at 20160404 04:20:51 in /builds/slave/test 04:20:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:20:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:51 INFO - {'append_to_log': False, 04:20:51 INFO - 'base_work_dir': '/builds/slave/test', 04:20:51 INFO - 'blob_upload_branch': 'Firefox', 04:20:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:51 INFO - 'branch': 'Firefox', 04:20:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:51 INFO - 'config_files': ('talos/mac_config.py',), 04:20:51 INFO - 'default_actions': ('clobber', 04:20:51 INFO - 'read-buildbot-config', 04:20:51 INFO - 'download-and-extract', 04:20:51 INFO - 'populate-webroot', 04:20:51 INFO - 'create-virtualenv', 04:20:51 INFO - 'install', 04:20:51 INFO - 'run-tests'), 04:20:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:51 INFO - 'download_minidump_stackwalk': True, 04:20:51 INFO - 'download_symbols': 'ondemand', 04:20:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:51 INFO - 'installer_path': 'installer.exe', 04:20:51 INFO - 'log_level': 'info', 04:20:51 INFO - 'log_name': 'talos', 04:20:51 INFO - 'log_to_console': True, 04:20:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:20:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:20:51 INFO - 'opt_config_files': (), 04:20:51 INFO - 'pip_index': False, 04:20:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:20:51 INFO - 'cmd': ('bash', 04:20:51 INFO - '-c', 04:20:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:20:51 INFO - 'enabled': True, 04:20:51 INFO - 'halt_on_failure': False, 04:20:51 INFO - 'name': 'check_screen_resolution'},), 04:20:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:20:51 INFO - 'cmd': ('bash', 04:20:51 INFO - '-c', 04:20:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:20:51 INFO - 'enabled': True, 04:20:51 INFO - 'halt_on_failure': False, 04:20:51 INFO - 'name': 'check_screen_resolution'},), 04:20:51 INFO - 'run_cmd_checks_enabled': True, 04:20:51 INFO - 'sps_profile': False, 04:20:51 INFO - 'sps_profile_interval': 0, 04:20:51 INFO - 'suite': 'dromaeojs', 04:20:51 INFO - 'system_bits': '32', 04:20:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:51 INFO - 'title': 't-yosemite-r7-0038', 04:20:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:51 INFO - 'use_talos_json': True, 04:20:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:51 INFO - 'work_dir': 'build'} 04:20:51 INFO - ##### 04:20:51 INFO - ##### Running clobber step. 04:20:51 INFO - ##### 04:20:51 INFO - Running pre-action listener: _resource_record_pre_action 04:20:51 INFO - Running main action method: clobber 04:20:51 INFO - rmtree: /builds/slave/test/build 04:20:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:53 INFO - Running post-action listener: _resource_record_post_action 04:20:53 INFO - ##### 04:20:53 INFO - ##### Running read-buildbot-config step. 04:20:53 INFO - ##### 04:20:53 INFO - Running pre-action listener: _resource_record_pre_action 04:20:53 INFO - Running main action method: read_buildbot_config 04:20:53 INFO - Using buildbot properties: 04:20:53 INFO - { 04:20:53 INFO - "project": "", 04:20:53 INFO - "product": "firefox", 04:20:53 INFO - "script_repo_revision": "production", 04:20:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:20:53 INFO - "repository": "", 04:20:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:20:53 INFO - "buildid": "20160404025621", 04:20:53 INFO - "pgo_build": "False", 04:20:53 INFO - "basedir": "/builds/slave/test", 04:20:53 INFO - "buildnumber": 191, 04:20:53 INFO - "slavename": "t-yosemite-r7-0038", 04:20:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:20:53 INFO - "platform": "yosemite_r7", 04:20:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:20:53 INFO - "branch": "mozilla-central", 04:20:53 INFO - "repo_path": "mozilla-central", 04:20:53 INFO - "revision": "9bd90088875399347b05d87c67d3709e31539dcd", 04:20:53 INFO - "stage_platform": "macosx64", 04:20:53 INFO - "builduid": "29637d11b10f4c288fc24e5d9d09fcc9", 04:20:53 INFO - "slavebuilddir": "test" 04:20:53 INFO - } 04:20:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:20:53 INFO - Running post-action listener: _resource_record_post_action 04:20:53 INFO - ##### 04:20:53 INFO - ##### Running download-and-extract step. 04:20:53 INFO - ##### 04:20:53 INFO - Running pre-action listener: _resource_record_pre_action 04:20:53 INFO - Running main action method: download_and_extract 04:20:53 INFO - mkdir: /builds/slave/test/build/tests 04:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:53 INFO - https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:21:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json: timed out 04:21:23 INFO - retry: attempt #1 caught exception: timed out 04:21:23 INFO - retry: Failed, sleeping 30 seconds before retrying 04:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 #2 04:21:54 INFO - Downloaded 1199 bytes. 04:21:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:21:54 INFO - Using the following test package requirements: 04:21:54 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:21:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:21:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:21:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'jsshell-mac.zip'], 04:21:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:21:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:21:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:21:54 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:21:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:21:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:21:54 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:21:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:54 INFO - https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:21:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:21:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:21:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:21:55 INFO - Downloaded 17959497 bytes. 04:21:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:21:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:21:59 INFO - Return code: 0 04:21:59 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 04:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:21:59 INFO - https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:21:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:21:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:21:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:22:00 INFO - Downloaded 17959497 bytes. 04:22:00 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'] 04:22:00 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 04:22:04 INFO - Return code: 0 04:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:04 INFO - https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:22:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:22:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:22:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:22:05 INFO - Downloaded 10847584 bytes. 04:22:05 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'] 04:22:05 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 04:22:06 INFO - Return code: 0 04:22: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')]} 04:22:06 INFO - https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:22:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:22:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:22:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:22:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JL8c5z2mSA-kObSE_bDRPw/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 04:22:09 INFO - Downloaded 111250575 bytes. 04:22:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:22:09 INFO - mkdir: /builds/slave/test/properties 04:22:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:09 INFO - Contents: 04:22:09 INFO - build_url:https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:22:10 INFO - Running post-action listener: _resource_record_post_action 04:22:10 INFO - Running post-action listener: set_extra_try_arguments 04:22:10 INFO - ##### 04:22:10 INFO - ##### Running populate-webroot step. 04:22:10 INFO - ##### 04:22:10 INFO - Running pre-action listener: _resource_record_pre_action 04:22:10 INFO - Running main action method: populate_webroot 04:22:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:10 INFO - '--tppagecycles', 04:22:10 INFO - '7'], 04:22:10 INFO - 'tests': ['tsvgm']}}, 04:22:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:22:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:22:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'tests': ['damp', 'tps']}, 04:22:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['damp', 'tps']}, 04:22:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:22:10 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['dromaeo_dom']}, 04:22:10 INFO - 'other': {'tests': ['a11yr', 04:22:10 INFO - 'ts_paint', 04:22:10 INFO - 'tpaint', 04:22:10 INFO - 'sessionrestore', 04:22:10 INFO - 'sessionrestore_no_auto_restore', 04:22:10 INFO - 'tabpaint']}, 04:22:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['a11yr', 04:22:10 INFO - 'ts_paint', 04:22:10 INFO - 'tpaint', 04:22:10 INFO - 'sessionrestore', 04:22:10 INFO - 'sessionrestore_no_auto_restore', 04:22:10 INFO - 'tabpaint']}, 04:22:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['a11yr', 04:22:10 INFO - 'ts_paint', 04:22:10 INFO - 'tpaint', 04:22:10 INFO - 'sessionrestore', 04:22:10 INFO - 'sessionrestore_no_auto_restore', 04:22:10 INFO - 'tabpaint']}, 04:22:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['a11yr', 04:22:10 INFO - 'ts_paint', 04:22:10 INFO - 'tpaint', 04:22:10 INFO - 'sessionrestore', 04:22:10 INFO - 'sessionrestore_no_auto_restore', 04:22:10 INFO - 'tabpaint']}, 04:22:10 INFO - 'other_l64': {'tests': ['a11yr', 04:22:10 INFO - 'ts_paint', 04:22:10 INFO - 'tpaint', 04:22:10 INFO - 'sessionrestore', 04:22:10 INFO - 'sessionrestore_no_auto_restore', 04:22:10 INFO - 'tabpaint']}, 04:22:10 INFO - 'other_nol64': {'tests': ['a11yr', 04:22:10 INFO - 'ts_paint', 04:22:10 INFO - 'tpaint', 04:22:10 INFO - 'sessionrestore', 04:22:10 INFO - 'sessionrestore_no_auto_restore', 04:22:10 INFO - 'tabpaint']}, 04:22:10 INFO - 'svgr': {'tests': ['tsvgx', 04:22:10 INFO - 'tsvgr_opacity', 04:22:10 INFO - 'tart', 04:22:10 INFO - 'tscrollx', 04:22:10 INFO - 'cart']}, 04:22:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['tsvgx', 04:22:10 INFO - 'tsvgr_opacity', 04:22:10 INFO - 'tart', 04:22:10 INFO - 'tscrollx', 04:22:10 INFO - 'cart']}, 04:22:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'tests': ['tp5o']}, 04:22:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'talos_options': ['--e10s'], 04:22:10 INFO - 'tests': ['tp5o']}, 04:22:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'talos_options': ['--xperf_path', 04:22:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:10 INFO - 'tests': ['tp5n']}, 04:22:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:10 INFO - 'talos_options': ['--e10s', 04:22:10 INFO - '--xperf_path', 04:22:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:10 INFO - 'tests': ['tp5n']}}, 04:22:10 INFO - 'talos.zip': {'path': '', 04:22:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:10 INFO - Running post-action listener: _resource_record_post_action 04:22:10 INFO - ##### 04:22:10 INFO - ##### Running create-virtualenv step. 04:22:10 INFO - ##### 04:22:10 INFO - Running pre-action listener: _resource_record_pre_action 04:22:10 INFO - Running main action method: create_virtualenv 04:22:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:22:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:10 INFO - Using real prefix '/tools/python27' 04:22:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:14 INFO - Installing pip.................done. 04:22:14 INFO - Return code: 0 04:22:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22: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', 'pip>=1.5'] in /builds/slave/test/build 04:22: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 pip>=1.5 04:22:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:14 INFO - 'HOME': '/Users/cltbld', 04:22:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:14 INFO - 'LOGNAME': 'cltbld', 04:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:14 INFO - 'MOZ_NO_REMOTE': '1', 04:22:14 INFO - 'NO_EM_RESTART': '1', 04:22:14 INFO - 'PAGER': '/bin/cat', 04:22:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:14 INFO - 'PWD': '/builds/slave/test', 04:22:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:14 INFO - 'SHELL': '/bin/bash', 04:22:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:14 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:14 INFO - 'USER': 'cltbld', 04:22:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:14 INFO - 'XPC_FLAGS': '0x0', 04:22:14 INFO - 'XPC_SERVICE_NAME': '0', 04:22:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:22:14 INFO - Cleaning up... 04:22:14 INFO - Return code: 0 04:22:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:22: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 psutil>=0.7.1 04:22:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:14 INFO - 'HOME': '/Users/cltbld', 04:22:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:14 INFO - 'LOGNAME': 'cltbld', 04:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:14 INFO - 'MOZ_NO_REMOTE': '1', 04:22:14 INFO - 'NO_EM_RESTART': '1', 04:22:14 INFO - 'PAGER': '/bin/cat', 04:22:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:14 INFO - 'PWD': '/builds/slave/test', 04:22:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:14 INFO - 'SHELL': '/bin/bash', 04:22:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:14 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:14 INFO - 'USER': 'cltbld', 04:22:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:14 INFO - 'XPC_FLAGS': '0x0', 04:22:14 INFO - 'XPC_SERVICE_NAME': '0', 04:22:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:14 INFO - Downloading/unpacking psutil>=0.7.1 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:17 INFO - Installing collected packages: psutil 04:22:17 INFO - Running setup.py install for psutil 04:22:17 INFO - building 'psutil._psutil_osx' extension 04:22:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:22:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:22:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:22:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:22:18 INFO - building 'psutil._psutil_posix' extension 04:22:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:22:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:22:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:22:18 INFO - ^ 04:22:18 INFO - 1 warning generated. 04:22:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:18 INFO - Successfully installed psutil 04:22:18 INFO - Cleaning up... 04:22:18 INFO - Return code: 0 04:22:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:18 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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:22:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:18 INFO - 'HOME': '/Users/cltbld', 04:22:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:18 INFO - 'LOGNAME': 'cltbld', 04:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:18 INFO - 'MOZ_NO_REMOTE': '1', 04:22:18 INFO - 'NO_EM_RESTART': '1', 04:22:18 INFO - 'PAGER': '/bin/cat', 04:22:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:18 INFO - 'PWD': '/builds/slave/test', 04:22:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:18 INFO - 'SHELL': '/bin/bash', 04:22:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:18 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:18 INFO - 'USER': 'cltbld', 04:22:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:18 INFO - 'XPC_FLAGS': '0x0', 04:22:18 INFO - 'XPC_SERVICE_NAME': '0', 04:22:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:22:21 INFO - Installing collected packages: mozsystemmonitor 04:22:21 INFO - Running setup.py install for mozsystemmonitor 04:22:21 INFO - Successfully installed mozsystemmonitor 04:22:21 INFO - Cleaning up... 04:22:21 INFO - Return code: 0 04:22:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:21 INFO - 'HOME': '/Users/cltbld', 04:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:21 INFO - 'LOGNAME': 'cltbld', 04:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:21 INFO - 'MOZ_NO_REMOTE': '1', 04:22:21 INFO - 'NO_EM_RESTART': '1', 04:22:21 INFO - 'PAGER': '/bin/cat', 04:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:21 INFO - 'PWD': '/builds/slave/test', 04:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:21 INFO - 'SHELL': '/bin/bash', 04:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:21 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:21 INFO - 'USER': 'cltbld', 04:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:21 INFO - 'XPC_FLAGS': '0x0', 04:22:21 INFO - 'XPC_SERVICE_NAME': '0', 04:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:24 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:25 INFO - Downloading docopt-0.6.1.tar.gz 04:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:25 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:25 INFO - Running setup.py install for blobuploader 04:22:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:25 INFO - Running setup.py install for requests 04:22:26 INFO - Running setup.py install for docopt 04:22:26 INFO - Successfully installed blobuploader requests docopt 04:22:26 INFO - Cleaning up... 04:22:26 INFO - Return code: 0 04:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:26 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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:26 INFO - 'HOME': '/Users/cltbld', 04:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:26 INFO - 'LOGNAME': 'cltbld', 04:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:26 INFO - 'MOZ_NO_REMOTE': '1', 04:22:26 INFO - 'NO_EM_RESTART': '1', 04:22:26 INFO - 'PAGER': '/bin/cat', 04:22:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:26 INFO - 'PWD': '/builds/slave/test', 04:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:26 INFO - 'SHELL': '/bin/bash', 04:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:26 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:26 INFO - 'USER': 'cltbld', 04:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:26 INFO - 'XPC_FLAGS': '0x0', 04:22:26 INFO - 'XPC_SERVICE_NAME': '0', 04:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ypz03k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dwPNdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:26 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kC9md1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ilti4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ngZYcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-_ED7wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RpDE42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qWlnbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ewTsT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-RTaZ_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-0lATk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:27 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-t858FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-MpABtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-6fEa2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PzYFcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-S35oQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:28 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-plJfzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:28 INFO - Running setup.py install for manifestparser 04:22:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:28 INFO - Running setup.py install for mozcrash 04:22:28 INFO - Running setup.py install for mozdebug 04:22:28 INFO - Running setup.py install for mozdevice 04:22:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Running setup.py install for mozfile 04:22:29 INFO - Running setup.py install for mozhttpd 04:22:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Running setup.py install for mozinfo 04:22:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Running setup.py install for mozInstall 04:22:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:29 INFO - Running setup.py install for mozleak 04:22:29 INFO - Running setup.py install for mozlog 04:22:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Running setup.py install for moznetwork 04:22:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Running setup.py install for mozprocess 04:22:30 INFO - Running setup.py install for mozprofile 04:22:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Running setup.py install for mozrunner 04:22:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:30 INFO - Running setup.py install for mozscreenshot 04:22:30 INFO - Running setup.py install for moztest 04:22:30 INFO - Running setup.py install for mozversion 04:22:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:31 INFO - Cleaning up... 04:22:31 INFO - Return code: 0 04:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:31 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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:31 INFO - 'HOME': '/Users/cltbld', 04:22:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:31 INFO - 'LOGNAME': 'cltbld', 04:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:31 INFO - 'MOZ_NO_REMOTE': '1', 04:22:31 INFO - 'NO_EM_RESTART': '1', 04:22:31 INFO - 'PAGER': '/bin/cat', 04:22:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:31 INFO - 'PWD': '/builds/slave/test', 04:22:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:31 INFO - 'SHELL': '/bin/bash', 04:22:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:31 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:31 INFO - 'USER': 'cltbld', 04:22:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:31 INFO - 'XPC_FLAGS': '0x0', 04:22:31 INFO - 'XPC_SERVICE_NAME': '0', 04:22:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LLNQVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8JFCF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:31 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)) 04:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-JUoyoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Rf4zZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-yTJb7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:31 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-fq1HwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-bz4Mv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tIgtzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-JR165k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-HOMhYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-UrcCpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BFs27h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-sV0_0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-VOYLuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-saMgWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:32 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-eTol5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:33 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-bB645i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:22:33 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)) 04:22:33 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)) 04:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:35 INFO - Downloading blessings-1.6.tar.gz 04:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:35 INFO - Installing collected packages: blessings 04:22:35 INFO - Running setup.py install for blessings 04:22:35 INFO - Successfully installed blessings 04:22:35 INFO - Cleaning up... 04:22:35 INFO - Return code: 0 04:22:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:36 INFO - Reading from file tmpfile_stdout 04:22:36 INFO - Current package versions: 04:22:36 INFO - blessings == 1.6 04:22:36 INFO - blobuploader == 1.2.4 04:22:36 INFO - docopt == 0.6.1 04:22:36 INFO - manifestparser == 1.1 04:22:36 INFO - mozInstall == 1.12 04:22:36 INFO - mozcrash == 0.17 04:22:36 INFO - mozdebug == 0.1 04:22:36 INFO - mozdevice == 0.48 04:22:36 INFO - mozfile == 1.2 04:22:36 INFO - mozhttpd == 0.7 04:22:36 INFO - mozinfo == 0.9 04:22:36 INFO - mozleak == 0.1 04:22:36 INFO - mozlog == 3.1 04:22:36 INFO - moznetwork == 0.27 04:22:36 INFO - mozprocess == 0.22 04:22:36 INFO - mozprofile == 0.28 04:22:36 INFO - mozrunner == 6.11 04:22:36 INFO - mozscreenshot == 0.1 04:22:36 INFO - mozsystemmonitor == 0.0 04:22:36 INFO - moztest == 0.7 04:22:36 INFO - mozversion == 1.4 04:22:36 INFO - psutil == 3.1.1 04:22:36 INFO - requests == 1.2.3 04:22:36 INFO - wsgiref == 0.1.2 04:22:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:36 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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:36 INFO - 'HOME': '/Users/cltbld', 04:22:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:36 INFO - 'LOGNAME': 'cltbld', 04:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:36 INFO - 'MOZ_NO_REMOTE': '1', 04:22:36 INFO - 'NO_EM_RESTART': '1', 04:22:36 INFO - 'PAGER': '/bin/cat', 04:22:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:36 INFO - 'PWD': '/builds/slave/test', 04:22:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:36 INFO - 'SHELL': '/bin/bash', 04:22:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:36 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:36 INFO - 'USER': 'cltbld', 04:22:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:36 INFO - 'XPC_FLAGS': '0x0', 04:22:36 INFO - 'XPC_SERVICE_NAME': '0', 04:22:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:22:36 INFO - Cleaning up... 04:22:36 INFO - Return code: 0 04:22:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:22:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:36 INFO - 'HOME': '/Users/cltbld', 04:22:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:36 INFO - 'LOGNAME': 'cltbld', 04:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:36 INFO - 'MOZ_NO_REMOTE': '1', 04:22:36 INFO - 'NO_EM_RESTART': '1', 04:22:36 INFO - 'PAGER': '/bin/cat', 04:22:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:36 INFO - 'PWD': '/builds/slave/test', 04:22:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:36 INFO - 'SHELL': '/bin/bash', 04:22:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:36 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:36 INFO - 'USER': 'cltbld', 04:22:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:36 INFO - 'XPC_FLAGS': '0x0', 04:22:36 INFO - 'XPC_SERVICE_NAME': '0', 04:22:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:36 INFO - Downloading/unpacking jsonschema 04:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:40 INFO - Downloading/unpacking functools32 (from jsonschema) 04:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:40 INFO - warning: no files found matching '*.txt' 04:22:40 INFO - no previously-included directories found matching 'build' 04:22:40 INFO - no previously-included directories found matching 'dist' 04:22:40 INFO - no previously-included directories found matching '.git*' 04:22:40 INFO - Installing collected packages: jsonschema, functools32 04:22:40 INFO - Running setup.py install for functools32 04:22:40 INFO - warning: no files found matching '*.txt' 04:22:40 INFO - no previously-included directories found matching 'build' 04:22:40 INFO - no previously-included directories found matching 'dist' 04:22:40 INFO - no previously-included directories found matching '.git*' 04:22:40 INFO - Successfully installed jsonschema functools32 04:22:40 INFO - Cleaning up... 04:22:40 INFO - Return code: 0 04:22:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:40 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 0x1068c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb8345ced0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, '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.wDwYrc4lqA/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.CbZveL5vY2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:22:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:40 INFO - 'HOME': '/Users/cltbld', 04:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:40 INFO - 'LOGNAME': 'cltbld', 04:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:40 INFO - 'MOZ_NO_REMOTE': '1', 04:22:40 INFO - 'NO_EM_RESTART': '1', 04:22:40 INFO - 'PAGER': '/bin/cat', 04:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:40 INFO - 'PWD': '/builds/slave/test', 04:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:40 INFO - 'SHELL': '/bin/bash', 04:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:22:40 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:40 INFO - 'USER': 'cltbld', 04:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:40 INFO - 'XPC_FLAGS': '0x0', 04:22:40 INFO - 'XPC_SERVICE_NAME': '0', 04:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:41 INFO - Downloading/unpacking flake8 04:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:22:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:22:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:46 INFO - no previously-included directories found matching 'docs/_build' 04:22:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:22:46 INFO - Running setup.py install for pep8 04:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:22:46 INFO - no previously-included directories found matching 'docs/_build' 04:22:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:22:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:22:46 INFO - Cleaning up... 04:22:46 INFO - Return code: 0 04:22:46 INFO - Running post-action listener: _resource_record_post_action 04:22:46 INFO - Running post-action listener: _start_resource_monitoring 04:22:47 INFO - Starting resource monitoring. 04:22:47 INFO - ##### 04:22:47 INFO - ##### Running install step. 04:22:47 INFO - ##### 04:22:47 INFO - Running pre-action listener: _resource_record_pre_action 04:22:47 INFO - Running main action method: install 04:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:47 INFO - Reading from file tmpfile_stdout 04:22:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:47 INFO - Reading from file tmpfile_stdout 04:22:47 INFO - Output received: 04:22:47 INFO - Usage: mozinstall [options] installer 04:22:47 INFO - Options: 04:22:47 INFO - -h, --help show this help message and exit 04:22:47 INFO - -d DEST, --destination=DEST 04:22:47 INFO - Directory to install application into. [default: 04:22:47 INFO - "/builds/slave/test"] 04:22:47 INFO - --app=APP Application being installed. [default: firefox] 04:22:47 INFO - mkdir: /builds/slave/test/build/application 04:22:47 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'] 04:22:47 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 04:23:21 INFO - Reading from file tmpfile_stdout 04:23:21 INFO - Output received: 04:23:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:23:21 INFO - Running post-action listener: _resource_record_post_action 04:23:21 INFO - ##### 04:23:21 INFO - ##### Running run-tests step. 04:23:21 INFO - ##### 04:23:21 INFO - Running pre-action listener: _resource_record_pre_action 04:23:21 INFO - Running main action method: run_tests 04:23:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:23:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:23:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:23:21 INFO - 2016-04-04 04:23:21.355 screenresolution[2063:25959] starting screenresolution argv=screenresolution get 04:23:21 INFO - 2016-04-04 04:23:21.358 screenresolution[2063:25959] Display 0: 1600x1200x32@60 04:23:21 INFO - 2016-04-04 04:23:21.364 screenresolution[2064:25961] starting screenresolution argv=screenresolution list 04:23:21 INFO - Available Modes on Display 0 04:23:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:23:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:23:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:23:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:23:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:23:21 INFO - Intel Iris: 04:23:21 INFO - Chipset Model: Intel Iris 04:23:21 INFO - Type: GPU 04:23:21 INFO - Bus: Built-In 04:23:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:23:21 INFO - Vendor: Intel (0x8086) 04:23:21 INFO - Device ID: 0x0a2e 04:23:21 INFO - Revision ID: 0x0009 04:23:21 INFO - Displays: 04:23:21 INFO - Display: 04:23:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:23:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:23:21 INFO - Display Serial Number: 1600x1200 60 04:23:21 INFO - Main Display: Yes 04:23:21 INFO - Mirror: Off 04:23:21 INFO - Online: Yes 04:23:21 INFO - Rotation: Supported 04:23:21 INFO - Return code: 0 04:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:21 INFO - Python 2.7.3 04:23:21 INFO - Return code: 0 04:23:21 INFO - grabbing minidump binary from tooltool 04:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:21 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 0x106762e00>, '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 0x10658bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:23:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:23:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:21 INFO - Return code: 0 04:23:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:23:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:23:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:22 INFO - Return code: 0 04:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 04:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 04:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDwYrc4lqA/Render', 04:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:22 INFO - 'HOME': '/Users/cltbld', 04:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:22 INFO - 'LOGNAME': 'cltbld', 04:23:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:22 INFO - 'MOZ_NO_REMOTE': '1', 04:23:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:22 INFO - 'NO_EM_RESTART': '1', 04:23:22 INFO - 'PAGER': '/bin/cat', 04:23:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:22 INFO - 'PWD': '/builds/slave/test', 04:23:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:22 INFO - 'SHELL': '/bin/bash', 04:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CbZveL5vY2/Listeners', 04:23:22 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 04:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:22 INFO - 'USER': 'cltbld', 04:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:22 INFO - 'XPC_FLAGS': '0x0', 04:23:22 INFO - 'XPC_SERVICE_NAME': '0', 04:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 04:23:23 INFO - mozversion application_buildid: 20160404025621 04:23:23 INFO - mozversion application_changeset: 9bd90088875399347b05d87c67d3709e31539dcd 04:23:23 INFO - mozversion application_display_name: Nightly 04:23:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:23 INFO - mozversion application_name: Firefox 04:23:23 INFO - mozversion application_remotingname: firefox 04:23:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:23 INFO - mozversion application_vendor: Mozilla 04:23:23 INFO - mozversion application_version: 48.0a1 04:23:23 INFO - mozversion platform_buildid: 20160404025621 04:23:23 INFO - mozversion platform_changeset: 9bd90088875399347b05d87c67d3709e31539dcd 04:23:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:23 INFO - mozversion platform_version: 48.0a1 04:23:23 INFO - using testdate: 1459769003 04:23:23 INFO - actual date: 1459769003 04:23:23 INFO - starting webserver on 'localhost:57119' 04:23:23 INFO - SUITE-START | Running 2 tests 04:23:23 INFO - TEST-START | dromaeo_css 04:23:23 INFO - operating with platform_type : mac_ 04:23:23 INFO - Initialising browser for dromaeo_css test... 04:23:23 INFO - TEST-INFO | started process 2082 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpjBIw2s/profile http://localhost:57119/getInfo.html) 04:23:25 INFO - PROCESS | 2082 | __metrics Screen width/height:1600/1200 04:23:25 INFO - PROCESS | 2082 | colorDepth:24 04:23:25 INFO - PROCESS | 2082 | Browser inner width/height: 1024/689 04:23:25 INFO - PROCESS | 2082 | __metrics 04:23:25 INFO - PROCESS | 2082 | 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" 04:23:25 ERROR - PROCESS | 2082 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:23:26 INFO - TEST-INFO | 2082: exit 0 04:23:26 INFO - Browser initialized. 04:23:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:26 INFO - TEST-INFO | started process 2084 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpjBIw2s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:37 INFO - PROCESS | 2084 | RSS: Main: 235921408 04:23:37 INFO - PROCESS | 2084 | 04:24:28 INFO - PROCESS | 2084 | 1459769068989 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:26:39 INFO - PROCESS | 2084 | Cycle 1(1): loaded http://localhost:57119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57119/tests/dromaeo/cssquery-ext.html) 04:26:40 INFO - PROCESS | 2084 | RSS: Main: 364326912 04:26:40 INFO - PROCESS | 2084 | 04:29:43 INFO - PROCESS | 2084 | Cycle 1(1): loaded http://localhost:57119/tests/dromaeo/cssquery-ext.html (next: http://localhost:57119/tests/dromaeo/cssquery-jquery.html) 04:29:43 INFO - PROCESS | 2084 | RSS: Main: 363524096 04:29:43 INFO - PROCESS | 2084 | 04:32:45 INFO - PROCESS | 2084 | Cycle 1(1): loaded http://localhost:57119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57119/tests/dromaeo/cssquery-mootools.html) 04:32:46 INFO - PROCESS | 2084 | RSS: Main: 362700800 04:32:46 INFO - PROCESS | 2084 | 04:35:48 INFO - PROCESS | 2084 | Cycle 1(1): loaded http://localhost:57119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57119/tests/dromaeo/cssquery-prototype.html) 04:35:48 INFO - PROCESS | 2084 | RSS: Main: 325132288 04:35:48 INFO - PROCESS | 2084 | 04:38:52 INFO - PROCESS | 2084 | Cycle 1(1): loaded http://localhost:57119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57119/tests/dromaeo/cssquery-yui.html) 04:38:52 INFO - PROCESS | 2084 | RSS: Main: 321847296 04:38:52 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | Cycle 1(1): loaded http://localhost:57119/tests/dromaeo/cssquery-yui.html (next: http://localhost:57119/tests/dromaeo/cssquery-dojo.html) 04:41:55 INFO - PROCESS | 2084 | RSS: Main: 405184512 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | __start_tp_report 04:41:55 INFO - PROCESS | 2084 | _x_x_mozilla_page_load 04:41:55 INFO - PROCESS | 2084 | _x_x_mozilla_page_load_details 04:41:55 INFO - PROCESS | 2084 | |i|pagename|runs| 04:41:55 INFO - PROCESS | 2084 | |0;dojo.html;3428.9999999999995;3454.809985450799;3487.9651203487956;3492.9476057859138;3521.806300653463;5617.4382561743805;5655.830325090244;5701.629394089381;5711.257536520252;5712.628679135859;5704;5722.885542289162;5746.425357464252;5833.416658334165;5856.912146317809;5143.948560514385;5150.510701483362;5182.455842136578;5206.921896171561;5309.575233981292;5251.343582052244;5262.210668399752;5279.41926388097;5291.68249905005;5326.387465441485;5149.9485005149845;5169.948300517022;5223.320968274138;5253.86865328366;5285.86785330366;5170.689758614495;5183.533481986601;5183.714895680736;5186.481351864821;5220.660657057279;5114.667546609458;5140.820071297487;5149.716765577892;5167.276581278624;5169.974150129263;5508.614396992212;5559.193916882029;5613.915791263134;5626.324841019063;5670.262865827416;5168.457311982263;6234.812955611339;6250.843728906768;6266;6291.7797877074545;5493.23094766733;6134.620279381772;6325.620462772248;6329.588576742497;6335.081413195061;5794.82615521535;5803.042497987869;5811.912821307684;5863.618864773819;5867.11993201019;6296.5592408531875;6305.747770089237;6319;6329.050642403584;6332.936670633327;6029.758809647565;6043.184170137063;6147.139400483936;6155.1075094112;6181.103739957681;6189.81430557084;6238;6249.562530622813;6280.2777680566405;6282.905756413657;6185.226846644169;6223.1287619733275;6237.594556353823;6249.062640603855;6268.059791031291;6125.601835880653;6179.196704428396;6261.686915654199;6277.560570760094;6299.244090709052;4529.818807247739;4598.0803839232285;4842.83050093245;4875.536824001714;4925.630577706686;4368.759718215465;4372.453443319585;4377.649788016951;4377.8248870044845;4397.40635014269;5573.60984731073;5636.830895073154;5644.774209031592;5656.773729050874;5658.540481979385;6188.412100850412;6196.597221180609;6244.718987645567;6248.656323902229;6313.77901773445;5672.461116193955;5683.005474042026;5694.487496125369;5698.17376480408;5698.914516282259;5232.3982741985155;5378.838634840961;5383.111786555253;5389.380221274525;5400;6190.257169139642;6256.43692067707;6265.185525881698;6290.24517057956;6313.684315784284;6259.655718935503;6273.121762953099;6276.403741644536;6284.8428789278805;6297.086922396135;6214.1921550198185;6280.0893870389455;6333.113364128933;6353.4599559038;6361.554691171574;6127.769884593299;6152.323244443018;6193.318734939063;6203.16257305276;6219.875602487835;6279.120923070683;6300.2754683212015;6302.936970630235;6305.306416294112;6321;5981.7308221131025;6087.360827113266;6118.938810612015;6124.38756124384;6144.754209831557;6079.787207447718;6079.817605471843;6081.695915204311;6086.543509236736;6135.969320153371;5104.259882317117;5909.497692696169;5913.881722365614;5916.881662366814;5923.881522369442;5890.322612899571;5992.250968628921;6070;6116.204893363834;6120.387961203844;4904.2643603459765;5982.880342393215;5993.490553303018;6005.459508644243;6013.278406591062 04:41:55 INFO - PROCESS | 2084 | |1;ext.html;488.1092007087067;574.2247965246916;574.9798757043504;587.1867463562965;628.6259675493081;37997.81001094994;38414.03964900872;38471;38509.03727406813;38671.83984480463;40711;41203.9699007525;41310.58689413105;41319.793401032955;41363.17273654525;9512.667056653036;9711.465869377182;9712.368696034771;9721.125098741111;9726.249275130474;9430.858537121949;9612.279079069098;9618.42289462631;9732.805343893118;9733.415995040285;9702.932677405479;9752.26857985654;9771.413715177112;9775.071368220044;9795.363301385423;9675.080867317594;9742.366746161548;9746.610135594532;9747.90252097477;9761.316707830454;9637.855432168522;9779.902200977971;9785.412875227437;9786.461744604045;9827;39838.402423963664;40157.598424015676;40171.59828401708;40233.396499052535;40247.59752402497;3283.1792051987004;3371.2751758371824;3428.6571342865514;3660.4143337066207;3663.358912190383;28391.716082839113;28480.71519284822;28681.922654142185;28886.566701499494;29261.414771704447;2755.600437936508;2786.1362977477047;2846.4307138572367;2915.941681166365;2956.8965086222092;332328;377701.99999999726;379093;379136;379826;44086.33870491945;44693.55306446894;44708.10583788371;53658.463415365346;63612;43815.56184438115;44008.559914401085;44076.89807754832;44184;44187.337189942176;15050.698986020217;15087.321070551852;15246.466373676869;15260.847391525942;15311.693766124616;12375.071869609816;12458.937705311597;12471.5011399543;12472.939800117092;12477.688057798447;11565.901239382245;13424.798628020588;14023.298835058205;14102.929485352508;14152.150870947777;5332.360116785933;6107.854454955701;6144.354842741537;6171.321154672983;6182.814515564541;1000.9949950250202;1054.267284237463;1062.8352605346183;1096.31480324797;1116.6655846263636;24949.5010099797;27927.882884684386;28673.13980580586;29524.409511809645;29679.703202967696;1075.6342843433113;1124.2692250037378;1144.3248483394837;1166.4284500594817;1167.8248262760653;13663.454410674574;14703.970722049355;14875;14970.32633531472;15071.849281507264;531741;537512;541837;544391;544528;56549.869002619715;57052.99999999917;57168.42831571631;57187;57274.140887886715;1312.3044786263297;1433.8924580656492;1439.2731670506537;1474.837767845536;1482.7256957462903;27866.58200126959;28838.711612883602;28859.567106493;29582.408351833274;29718.554221687125;45018.549814501435;45371;45460.77269613631;45464.40874569374;45550.31674524819;368908;370780;371434;371906;372361;27611.58582621222;32533.837330813196;32945.835270823496;32971.50542741813;33031.843885463895;41400.37899431571;42046.57953420427;42133.57866421297;42589;43246.78376608097;30295.848520757256;35223.82388088043;35454.8227258862;35549.46675799813;36226.4566031515;35074.473882892285;35322;35474;35878.820605896806;35941.28117437689;35344.939651810484;35480;35571.466428003085;35950.28099438049;36140.27719445544;29586.40827183401;29665.703342966295;31259.218519537193;31310.530342045342;31620.525692114177;23532.29403117909;23851;24197.395065123514;24313.905874235348;24352.391190220387 04:41:55 INFO - PROCESS | 2084 | |2;jquery.html;362.67721727662376;362.72251727428505;368.1881451399664;373.4659437005085;376.24750499001993;19133.808661913376;19594.314199003038;20904.581908361823;20937.58124837504;20945.266915657954;11981.281123132618;12348.876511234885;12364.567240146596;12377.009839212864;12382.752344953118;5132.922086361868;5171.715555644438;5752.223449834281;5917.230760001194;5933.6439813611105;5254.712595414129;5873.383294754032;5937.020391635397;6003.339632640406;6007.4893634041155;5183.922241166386;5358;5390.703511306877;5615.241942337773;5870.88258234835;5339.679619222839;5355.946440535584;5359.38367087786;5363.651362661434;5410.756515956772;5160.509751573594;5168.457311982225;5286.3392075990505;5528.9723551381985;5539.861503462405;13230.801537976939;13397.66505837352;13436.932815335958;13453.932730336384;21260.574788504142;1930.855185861066;2052.84603654725;2069.0378973777265;2214.2360885494477;2765.9170224893287;9547.809043819085;9562.952185239099;9959.402435853872;10111.949440252825;11824.527018919232;1671.1059583122972;1696.6606678664193;1706.385701147586;1751.9474415767547;1752.5793809485758;94846.52576737072;96399;96945.54581681281;97259.5685107871;97484;10898.673039808818;10996.780064398827;11089.585476187944;11099.5560177592;11239.438028098562;13762.24307663068;13813.447462101403;13836.308184590931;13844.653883652989;13878.306084695725;8302.682605045342;8454.704085357105;8458.74623761288;8579.270761985177;8583.914160858436;8575;8604.268637165786;8626.201274699772;8735.25750311218;8809.779755506164;4303.720258183208;4376.059147283349;4380.69335146543;4422.469303683579;4436.689431739747;1831.8717689761854;1860.339579449303;1861.8231268029515;1877.1365172021024;1886.6698327792856;860.6144107986262;930.7114794413618;971.3540495570367;1042.3537406807677;1074.0762943868267;15759.448419305269;19822;19878.50303742418;20249.493762656053;20314.695279570817;958.9808203836023;959.491469521155;977.3207620703685;1000.394761169482;1005.9127310829911;10317.174626029899;10525.21060920434;10670.57317707283;10711.517981690842;10728.302660327054;560141;592482;627560;646290;648335;110451.44774276238;111617.44191279155;111876;113636;116072;987.5457289646699;995.4027583449872;1011.6560369474267;1016.4561959351711;1016.7051555049101;13187.802182967454;17429.73855392145;17501.64996700084;18090.638187236444;18224;35344.29311413809;36698.44952325771;46885;49155.01689966252;49817.75091124521;66917;66985;67412.662936685;67982.66008669925;68258;5834.504067154339;7168.354848063699;7831.843363132592;7867.252611001945;8174.141715119827;10306.433146177033;11330.433478325886;12128.696782580153;12304.569340073054;12349.93825030869;10540.209484288862;10646.254762166884;10865.239433239914;10878.292910960763;10907.454627268764;10281.177505799667;10545.767895478724;10656.413897235727;10873.836892446461;10983.890161098607;10662.946685266525;10751.838722419014;10757.67726968161;10911.491161027116;11171.72070698239;7808.453408261367;7820.452568320163;7900.209979002284;7919.802004949923;8196.795080123045;9438;10589;10854.620088296871;11016.06363459083;11146.108311335236 04:41:55 INFO - PROCESS | 2084 | |3;mootools.html;1424.6794471243966;1561.3442354211234;1594.6730920161365;1856.2667746240236;1996.7204591357213;7982.401319901009;8666.263367613752;8782.692605758799;8796.824063518727;8804.64781408743;8438.789030274245;8698.043215246318;8699.565021748904;8701.91298087019;8712.738617841474;2102.463871712715;2166.5666866626657;2441.9755802441928;2512.057978258153;2521.13021007752;2519.433127546306;2535.733747956466;2535.9746402535925;2537.974620253792;2539.415934335104;2399.5081008393236;2482.615194644833;2483;2483.5653760591913;2489.962650560243;2450.3629056445366;2493.7132229793533;2505.8621775802326;2508.7240403555593;2513.673222481084;2035.592881423721;2404.3748625357357;2435.549423356667;2438.5976313908186;2454;8784.736457906209;8862.423942443786;8873.73378798637;8885.422447540954;8885.511296878669;5332.680039197622;5515;5522;5524.392316845144;5529.142982837667;3556.1820781220204;3632.291703117893;3714.052916506301;3741.1956429367815;3745.9625403745886;1053.952572134256;1070.5129166229424;1076;1085.7394225385929;1087.782443511301;11975.401229938469;11992.460339284753;12002.099842511847;12011.759764804743;12017.918387345093;4114.979425102855;4841.540053694894;4881;4982.227754698028;4984.37695288089;10028.949855250678;10050.748731281776;10062.547185376676;10086.546105425274;10112.898871011195;5539.612227144061;5545.195946587723;5551.861203469945;5587.1339942309005;5596.300462442195;4527.8641640750175;4696.953030469652;4848.660593758403;4984.950150498521;5023.070731914608;3725.6088110748524;3795.962040379616;3831.4635950966886;3831.540215174197;3851.537815462106;1302.9674258143623;1309.4958441000283;1309.862464441239;1322.8081928120562;1325.5360623781792;1343.1202562321696;1357.9253141077336;1380.6065271397604;1381.1436909116412;1387.1330418488444;8170.673173073011;8251.968503937007;8269.21442462965;8276.172382761795;8276.420650554403;511.5447251945697;522.6237109281311;528.2683483375553;530.0194639916124;532.597888594109;6220.160278362454;6247.312795592481;6315.989441689308;6324;6333.46165575922;10394.740131496774;10773.78452430947;10787.892121078688;10874.836877446845;10910.34537927711;10274;10645.680629581126;10675.626353077605;10731.034206921415;10851.240413171161;8351.164883511721;8405.495670259805;8423;8466.57667116654;8492.57537123129;7750.534967901944;7999.32005779492;8009.239122283374;8012.439129260896;8017.198280171936;9492.240620750461;9743.9025609743;9776.511174441392;9796.412215266822;9813.362131461432;9739.513024348613;9870.802583948138;9943.552540135566;10149.137323327599;10157.136643385395;6666.666666666589;6815.829604259735;7343.237622970555;7523.811904702427;7582.924170758221;8220.260176584135;8228;8249.876251856347;8270.503769773833;8292.792680183044;7218.169910460364;7286.271372862671;7343.3390994810725;7456.552606843607;7531.88702169457;7146.678399471933;7193.424526038009;7229.277072292939;7248.710051597877;7252.89120663201;7655.732049378245;7776.300132988058;7781.416393770377;7798.337141342822;7806.180351063056;6975.232724400211;6983.441324694114;7082.822929426806;7085.078939738008;7099.07711997437;7072.681729322296;7158.749443769651;7161.713531458683;7176.174739904769;7176.605286709281 04:41:55 INFO - PROCESS | 2084 | |4;prototype.html;324.5845317992969;325.9478483442648;332.5643407136651;333.80806036529003;338.08042125418865;6445.9677701611545;6511.283758786536;6513.576617519858;6568.835779105525;6591.307912669173;6489.351064893508;6496.935030649692;6501.577397469161;6522.57603255788;6526.477881769459;4588.655850811186;4672.299155126724;4689.507601701806;4777.18787806072;4825.179719447694;3862.7489213201193;3896.5324161100707;4773.92839107412;4792.185328494164;4820.734859582722;3877.2827027000094;4756.785944632483;4757.619390448773;4786.282057691356;4791.209450440673;4545.659075569345;4611.708721557986;4737.289406589005;4770.880727981794;4781.474037855833;4090.9386359204636;4098.959010409888;4099.85650502234;4105.630493255591;4107.54816970133;5207.3490813648295;6119.204503414572;6253.78111766086;6263.968680156616;6279.8744025119695;4689.710329659337;5095.235714642796;5182.274481572583;5565.5825813063775;5631.60578759487;6879.071325371061;6880.139982502187;6880.415164711006;6904.861902761967;6934.167899851999;3981.820818063194;4507.481639611454;4650.907146747409;4697.3893393858925;4712.986707857793;7161.462890283249;7307.232740562217;7317.780466585958;7346.52247603904;7416.7774966751085;4773.403324584427;4792.113459010095;4792.376990991149;4794.4486384065585;4795.784189711471;4847.127517046895;4854.368932038883;4859.902801943941;4868.2210846264425;4879.999600081975;4711.670183087151;5694.402087780806;5698.629589076697;5714.085746280575;5727.914081288784;5574.470425309589;6907.585544867324;6930.995005724142;6932.792016239521;6933.410660093848;1380.3581334679423;1647.604574902015;1661.8753593480537;1670.548951783036;1674.6566953774447;830.2403300979536;1019.8572199892021;1079.5304042741275;1084.728817795551;1112.5382966069153;6404;6547.508936829757;6585.9012114818315;6684.665766711645;6710.899336509956;7271.490995630255;7278.163011253668;7281;7297.671604777798;7334.046573945353;5302.814401495929;6503.154589903377;6516.250631177475;6517.4134327910715;6538.509611779135;3081.260497480633;3843.9615603844163;3855.4409610606867;3860.6718428933855;3861.3242682530445;6897.3447522486285;7161.319674630901;7379.262073792578;7394.334509894135;7401.407887368998;6133.417325354084;6499.3175716549085;7196.95644131598;7274.054372931485;7429;7576.24237576249;7598.240175982468;7599.316061554487;7599.924000760032;7615.4669173157345;6948.895766563607;7078.362947334765;7295.161056478573;7301.269873012656;7307.3423391894985;7145.82135446618;7155.534890232118;7156.1770396403;7158.856822863618;7168.247334029852;7587.2412758723685;7607.4674772765375;7618.00965874455;7621.3902887769955;7630.542167469747;4789.114013907299;4790.7844147012775;4791.736454494897;4793.688410253322;4795.736234507136;6990.755323563854;7203.819904502429;7279.563226206445;7291.08861392326;7342.449316301192;5747.942520574741;6960.47796415281;7015.088038554955;7030.3321184487395;7031.1211098612675;6963.860722785617;6964.547304425196;6972.651367431709;6985.79042628722;6993.545419547713;6826.658667066726;6831.931680683129;6847.657617119224;6851.2121106071445;6856;6765.594064356154;6916.135483064617;6948.444124469929;6965.373116419547;7022.12223472066;6522.804315870531;6807.251202367835;6862.382385585322;6878.65606719672;6896.069030680794 04:41:55 INFO - PROCESS | 2084 | |5;yui.html;684.4353408438039;716.1370548489072;751.2074761127012;766.6166916541729;792.3581898662082;14811.55565333039;14934.850651493482;14959.626009349744;14961.476348327797;14980.026298290617;13450.260235687034;13597.728045439086;13879.514217002406;14218.71562568748;14271;718.3032458515232;760.0119844202542;893.1871996483185;921.7603423110006;924.3945215883573;827.6482494939627;924.4037595750737;945.9054094590555;947.1333729637373;949.9787728192186;984.4339504784778;990.8810942686888;991.1525645573039;995.1342332170985;995.6465454763563;767.7696690992735;969.6654654144379;979.6962941488162;982.513655740413;989.648674720471;709.1171491493124;726.1721637333444;740.6037769793135;744.3970383988986;745.1282000059942;14820.110793352325;14870.851291487055;14895.404183832634;14901.552953411307;14908.552743417715;10580.153587712965;12391.504339826397;12494.875051249463;12651.873481265253;12823.935880320632;9919.90080099197;10040.849387259197;10156.23828212887;10437.843432348522;10989.61536346224;4094.9967258021975;4125.278076336629;4201.6008479194425;4204.915901681979;4210.200061988213;69923;71064;71423.57152856966;71654.28345716528;71800;9095.31785116119;9215.53922303882;9250.21373183287;9266.258699304039;9313.906860931304;20793.58412831735;21009.579808403745;21048.684269735968;21051.473713157295;21089.472763181042;7552.811179720551;7618.428617853572;7634.541927484369;7727.806804829925;7748.186440423787;4143.834246630161;4154.335306350969;4182.623563879265;4186.1836941796055;4431.224535706238;3462.3940810358085;3531.434970404723;3559.1280136366754;3562.946555801665;3580.785152890835;659.970301336441;666.9199696036507;668.0747165176266;670.11210146556;672.7275453441364;555.1727925391139;557.7908284393352;563.4168635462277;585.853536615846;591.6036255708685;6868.484863635247;7088.610126442992;7401.259874012556;7534.434917381109;7840.740243799423;512.874345785285;544.9100898351807;545.5090418623271;549.9092649712752;572.9713514324351;3732.496113024707;3733;3734.8319325630414;3741.8877433677035;3754.5494540655295;85728;86521;87098.12901871027;90930;94020.52989735008;67148;67579;74538;74645.25354746492;75867.48265034778;65098.69802604016;65412;65434.69130617361;65739.67130164319;66718.99921501182;8160.551169685724;8330.416870818985;8332.16678332162;8445.87331190045;8502.404831661972;48723.5127648719;49141.75429122832;49571;50392.49607503878;50521;55173;65147.67426162839;65415.67292163509;65717;66883.66558167373;9791.608335666493;10886.29239099456;10904.264504892217;10978.451077445936;11204.551817927191;11878.680301753664;11911.40442977865;12051.096167787626;12199.3290369027;12322.137450378388;11139.275947063416;11173.441327933408;11206.271592346471;11262.155338349821;11648.708782280512;11233.269837460539;11568.190226684388;11623.59317423886;11795.882041179822;12163.391830408267;8830.867536986822;11009.889901100887;11046.226764126433;11184;11450.37022963745;7618.504797188165;9402.2948278878;9502.572384242587;9534.761630959281;9754.317197796086;8962.641494340414;9042.81914361696;9569.473678947446;9612.951935240279;9619.27855410833 04:41:55 INFO - PROCESS | 2084 | __end_tp_report 04:41:55 INFO - PROCESS | 2084 | __start_cc_report 04:41:55 INFO - PROCESS | 2084 | _x_x_mozilla_cycle_collect,1288 04:41:55 INFO - PROCESS | 2084 | __end_cc_report 04:41:55 INFO - PROCESS | 2084 | __startTimestamp1459770115629__endTimestamp 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | ------- Summary: start ------- 04:41:55 INFO - PROCESS | 2084 | Number of tests: 6 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | [#0] dojo.html Cycles:165 Average:5722.13 Median:5916.88 stddev:645.34 (10.9%) stddev-sans-first:621.74 04:41:55 INFO - PROCESS | 2084 | Values: 3429.0 3454.8 3488.0 3492.9 3521.8 5617.4 5655.8 5701.6 5711.3 5712.6 5704.0 5722.9 5746.4 5833.4 5856.9 5143.9 5150.5 5182.5 5206.9 5309.6 5251.3 5262.2 5279.4 5291.7 5326.4 5149.9 5169.9 5223.3 5253.9 5285.9 5170.7 5183.5 5183.7 5186.5 5220.7 5114.7 5140.8 5149.7 5167.3 5170.0 5508.6 5559.2 5613.9 5626.3 5670.3 5168.5 6234.8 6250.8 6266.0 6291.8 5493.2 6134.6 6325.6 6329.6 6335.1 5794.8 5803.0 5811.9 5863.6 5867.1 6296.6 6305.7 6319.0 6329.1 6332.9 6029.8 6043.2 6147.1 6155.1 6181.1 6189.8 6238.0 6249.6 6280.3 6282.9 6185.2 6223.1 6237.6 6249.1 6268.1 6125.6 6179.2 6261.7 6277.6 6299.2 4529.8 4598.1 4842.8 4875.5 4925.6 4368.8 4372.5 4377.6 4377.8 4397.4 5573.6 5636.8 5644.8 5656.8 5658.5 6188.4 6196.6 6244.7 6248.7 6313.8 5672.5 5683.0 5694.5 5698.2 5698.9 5232.4 5378.8 5383.1 5389.4 5400.0 6190.3 6256.4 6265.2 6290.2 6313.7 6259.7 6273.1 6276.4 6284.8 6297.1 6214.2 6280.1 6333.1 6353.5 6361.6 6127.8 6152.3 6193.3 6203.2 6219.9 6279.1 6300.3 6302.9 6305.3 6321.0 5981.7 6087.4 6118.9 6124.4 6144.8 6079.8 6079.8 6081.7 6086.5 6136.0 5104.3 5909.5 5913.9 5916.9 5923.9 5890.3 5992.3 6070.0 6116.2 6120.4 4904.3 5982.9 5993.5 6005.5 6013.3 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | [#1] ext.html Cycles:180 Average:56621.45 Median:186285.68 stddev:115468.79 (62.0%) stddev-sans-first:115715.80 04:41:55 INFO - PROCESS | 2084 | Values: 488.1 574.2 575.0 587.2 628.6 37997.8 38414.0 38471.0 38509.0 38671.8 40711.0 41204.0 41310.6 41319.8 41363.2 9512.7 9711.5 9712.4 9721.1 9726.2 9430.9 9612.3 9618.4 9732.8 9733.4 9702.9 9752.3 9771.4 9775.1 9795.4 9675.1 9742.4 9746.6 9747.9 9761.3 9637.9 9779.9 9785.4 9786.5 9827.0 39838.4 40157.6 40171.6 40233.4 40247.6 3283.2 3371.3 3428.7 3660.4 3663.4 28391.7 28480.7 28681.9 28886.6 29261.4 2755.6 2786.1 2846.4 2915.9 2956.9 332328.0 377702.0 379093.0 379136.0 379826.0 44086.3 44693.6 44708.1 53658.5 63612.0 43815.6 44008.6 44076.9 44184.0 44187.3 15050.7 15087.3 15246.5 15260.8 15311.7 12375.1 12458.9 12471.5 12472.9 12477.7 11565.9 13424.8 14023.3 14102.9 14152.2 5332.4 6107.9 6144.4 6171.3 6182.8 1001.0 1054.3 1062.8 1096.3 1116.7 24949.5 27927.9 28673.1 29524.4 29679.7 1075.6 1124.3 1144.3 1166.4 1167.8 13663.5 14704.0 14875.0 14970.3 15071.8 531741.0 537512.0 541837.0 544391.0 544528.0 56549.9 57053.0 57168.4 57187.0 57274.1 1312.3 1433.9 1439.3 1474.8 1482.7 27866.6 28838.7 28859.6 29582.4 29718.6 45018.5 45371.0 45460.8 45464.4 45550.3 368908.0 370780.0 371434.0 371906.0 372361.0 27611.6 32533.8 32945.8 32971.5 33031.8 41400.4 42046.6 42133.6 42589.0 43246.8 30295.8 35223.8 35454.8 35549.5 36226.5 35074.5 35322.0 35474.0 35878.8 35941.3 35344.9 35480.0 35571.5 35950.3 36140.3 29586.4 29665.7 31259.2 31310.5 31620.5 23532.3 23851.0 24197.4 24313.9 24352.4 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | [#2] jquery.html Cycles:180 Average:33133.58 Median:11737.41 stddev:101852.21 (867.8%) stddev-sans-first:102108.21 04:41:55 INFO - PROCESS | 2084 | Values: 362.7 362.7 368.2 373.5 376.2 19133.8 19594.3 20904.6 20937.6 20945.3 11981.3 12348.9 12364.6 12377.0 12382.8 5132.9 5171.7 5752.2 5917.2 5933.6 5254.7 5873.4 5937.0 6003.3 6007.5 5183.9 5358.0 5390.7 5615.2 5870.9 5339.7 5355.9 5359.4 5363.7 5410.8 5160.5 5168.5 5286.3 5529.0 5539.9 13230.8 13397.7 13436.9 13453.9 21260.6 1930.9 2052.8 2069.0 2214.2 2765.9 9547.8 9563.0 9959.4 10111.9 11824.5 1671.1 1696.7 1706.4 1751.9 1752.6 94846.5 96399.0 96945.5 97259.6 97484.0 10898.7 10996.8 11089.6 11099.6 11239.4 13762.2 13813.4 13836.3 13844.7 13878.3 8302.7 8454.7 8458.7 8579.3 8583.9 8575.0 8604.3 8626.2 8735.3 8809.8 4303.7 4376.1 4380.7 4422.5 4436.7 1831.9 1860.3 1861.8 1877.1 1886.7 860.6 930.7 971.4 1042.4 1074.1 15759.4 19822.0 19878.5 20249.5 20314.7 959.0 959.5 977.3 1000.4 1005.9 10317.2 10525.2 10670.6 10711.5 10728.3 560141.0 592482.0 627560.0 646290.0 648335.0 110451.4 111617.4 111876.0 113636.0 116072.0 987.5 995.4 1011.7 1016.5 1016.7 13187.8 17429.7 17501.6 18090.6 18224.0 35344.3 36698.4 46885.0 49155.0 49817.8 66917.0 66985.0 67412.7 67982.7 68258.0 5834.5 7168.4 7831.8 7867.3 8174.1 10306.4 11330.4 12128.7 12304.6 12349.9 10540.2 10646.3 10865.2 10878.3 10907.5 10281.2 10545.8 10656.4 10873.8 10983.9 10662.9 10751.8 10757.7 10911.5 11171.7 7808.5 7820.5 7900.2 7919.8 8196.8 9438.0 10589.0 10854.6 11016.1 11146.1 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | [#3] mootools.html Cycles:180 Average:6067.90 Median:531.31 stddev:3224.24 (606.8%) stddev-sans-first:3214.39 04:41:55 INFO - PROCESS | 2084 | Values: 1424.7 1561.3 1594.7 1856.3 1996.7 7982.4 8666.3 8782.7 8796.8 8804.6 8438.8 8698.0 8699.6 8701.9 8712.7 2102.5 2166.6 2442.0 2512.1 2521.1 2519.4 2535.7 2536.0 2538.0 2539.4 2399.5 2482.6 2483.0 2483.6 2490.0 2450.4 2493.7 2505.9 2508.7 2513.7 2035.6 2404.4 2435.5 2438.6 2454.0 8784.7 8862.4 8873.7 8885.4 8885.5 5332.7 5515.0 5522.0 5524.4 5529.1 3556.2 3632.3 3714.1 3741.2 3746.0 1054.0 1070.5 1076.0 1085.7 1087.8 11975.4 11992.5 12002.1 12011.8 12017.9 4115.0 4841.5 4881.0 4982.2 4984.4 10028.9 10050.7 10062.5 10086.5 10112.9 5539.6 5545.2 5551.9 5587.1 5596.3 4527.9 4697.0 4848.7 4985.0 5023.1 3725.6 3796.0 3831.5 3831.5 3851.5 1303.0 1309.5 1309.9 1322.8 1325.5 1343.1 1357.9 1380.6 1381.1 1387.1 8170.7 8252.0 8269.2 8276.2 8276.4 511.5 522.6 528.3 530.0 532.6 6220.2 6247.3 6316.0 6324.0 6333.5 10394.7 10773.8 10787.9 10874.8 10910.3 10274.0 10645.7 10675.6 10731.0 10851.2 8351.2 8405.5 8423.0 8466.6 8492.6 7750.5 7999.3 8009.2 8012.4 8017.2 9492.2 9743.9 9776.5 9796.4 9813.4 9739.5 9870.8 9943.6 10149.1 10157.1 6666.7 6815.8 7343.2 7523.8 7582.9 8220.3 8228.0 8249.9 8270.5 8292.8 7218.2 7286.3 7343.3 7456.6 7531.9 7146.7 7193.4 7229.3 7248.7 7252.9 7655.7 7776.3 7781.4 7798.3 7806.2 6975.2 6983.4 7082.8 7085.1 7099.1 7072.7 7158.7 7161.7 7176.2 7176.6 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | [#4] prototype.html Cycles:180 Average:5671.66 Median:6512.43 stddev:1827.01 (28.1%) stddev-sans-first:1787.51 04:41:55 INFO - PROCESS | 2084 | Values: 324.6 325.9 332.6 333.8 338.1 6446.0 6511.3 6513.6 6568.8 6591.3 6489.4 6496.9 6501.6 6522.6 6526.5 4588.7 4672.3 4689.5 4777.2 4825.2 3862.7 3896.5 4773.9 4792.2 4820.7 3877.3 4756.8 4757.6 4786.3 4791.2 4545.7 4611.7 4737.3 4770.9 4781.5 4090.9 4099.0 4099.9 4105.6 4107.5 5207.3 6119.2 6253.8 6264.0 6279.9 4689.7 5095.2 5182.3 5565.6 5631.6 6879.1 6880.1 6880.4 6904.9 6934.2 3981.8 4507.5 4650.9 4697.4 4713.0 7161.5 7307.2 7317.8 7346.5 7416.8 4773.4 4792.1 4792.4 4794.4 4795.8 4847.1 4854.4 4859.9 4868.2 4880.0 4711.7 5694.4 5698.6 5714.1 5727.9 5574.5 6907.6 6931.0 6932.8 6933.4 1380.4 1647.6 1661.9 1670.5 1674.7 830.2 1019.9 1079.5 1084.7 1112.5 6404.0 6547.5 6585.9 6684.7 6710.9 7271.5 7278.2 7281.0 7297.7 7334.0 5302.8 6503.2 6516.3 6517.4 6538.5 3081.3 3844.0 3855.4 3860.7 3861.3 6897.3 7161.3 7379.3 7394.3 7401.4 6133.4 6499.3 7197.0 7274.1 7429.0 7576.2 7598.2 7599.3 7599.9 7615.5 6948.9 7078.4 7295.2 7301.3 7307.3 7145.8 7155.5 7156.2 7158.9 7168.2 7587.2 7607.5 7618.0 7621.4 7630.5 4789.1 4790.8 4791.7 4793.7 4795.7 6990.8 7203.8 7279.6 7291.1 7342.4 5747.9 6960.5 7015.1 7030.3 7031.1 6963.9 6964.5 6972.7 6985.8 6993.5 6826.7 6831.9 6847.7 6851.2 6856.0 6765.6 6916.1 6948.4 6965.4 7022.1 6522.8 6807.3 6862.4 6878.7 6896.1 04:41:55 INFO - PROCESS | 2084 | 04:41:55 INFO - PROCESS | 2084 | [#5] yui.html Cycles:180 Average:17455.92 Median:65413.84 stddev:23947.15 (36.6%) stddev-sans-first:23981.21 04:41:55 INFO - PROCESS | 2084 | Values: 684.4 716.1 751.2 766.6 792.4 14811.6 14934.9 14959.6 14961.5 14980.0 13450.3 13597.7 13879.5 14218.7 14271.0 718.3 760.0 893.2 921.8 924.4 827.6 924.4 945.9 947.1 950.0 984.4 990.9 991.2 995.1 995.6 767.8 969.7 979.7 982.5 989.6 709.1 726.2 740.6 744.4 745.1 14820.1 14870.9 14895.4 14901.6 14908.6 10580.2 12391.5 12494.9 12651.9 12823.9 9919.9 10040.8 10156.2 10437.8 10989.6 4095.0 4125.3 4201.6 4204.9 4210.2 69923.0 71064.0 71423.6 71654.3 71800.0 9095.3 9215.5 9250.2 9266.3 9313.9 20793.6 21009.6 21048.7 21051.5 21089.5 7552.8 7618.4 7634.5 7727.8 7748.2 4143.8 4154.3 4182.6 4186.2 4431.2 3462.4 3531.4 3559.1 3562.9 3580.8 660.0 666.9 668.1 670.1 672.7 555.2 557.8 563.4 585.9 591.6 6868.5 7088.6 7401.3 7534.4 7840.7 512.9 544.9 545.5 549.9 573.0 3732.5 3733.0 3734.8 3741.9 3754.5 85728.0 86521.0 87098.1 90930.0 94020.5 67148.0 67579.0 74538.0 74645.3 75867.5 65098.7 65412.0 65434.7 65739.7 66719.0 8160.6 8330.4 8332.2 8445.9 8502.4 48723.5 49141.8 49571.0 50392.5 50521.0 55173.0 65147.7 65415.7 65717.0 66883.7 9791.6 10886.3 10904.3 10978.5 11204.6 11878.7 11911.4 12051.1 12199.3 12322.1 11139.3 11173.4 11206.3 11262.2 11648.7 11233.3 11568.2 11623.6 11795.9 12163.4 8830.9 11009.9 11046.2 11184.0 11450.4 7618.5 9402.3 9502.6 9534.8 9754.3 8962.6 9042.8 9569.5 9613.0 9619.3 04:41:55 INFO - PROCESS | 2084 | -------- Summary: end -------- 04:41:55 INFO - PROCESS | 2084 | 04:41:56 INFO - TEST-INFO | 2084: exit 0 04:41:56 INFO - TEST-OK | dromaeo_css | took 1113069ms 04:41:56 INFO - TEST-START | kraken 04:41:56 INFO - operating with platform_type : mac_ 04:41:56 INFO - Initialising browser for kraken test... 04:41:56 INFO - TEST-INFO | started process 2087 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmppnRs5o/profile http://localhost:57119/getInfo.html) 04:41:58 INFO - PROCESS | 2087 | __metrics Screen width/height:1600/1200 04:41:58 INFO - PROCESS | 2087 | colorDepth:24 04:41:58 INFO - PROCESS | 2087 | Browser inner width/height: 1024/689 04:41:58 INFO - PROCESS | 2087 | __metrics 04:41:58 INFO - PROCESS | 2087 | 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" 04:41:58 ERROR - PROCESS | 2087 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:41:59 INFO - TEST-INFO | 2087: exit 0 04:41:59 INFO - Browser initialized. 04:41:59 INFO - Running cycle 1/1 for kraken test... 04:41:59 INFO - TEST-INFO | started process 2089 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmppnRs5o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:11 INFO - PROCESS | 2089 | RSS: Main: 236003328 04:42:11 INFO - PROCESS | 2089 | 04:42:13 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57119/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:14 INFO - PROCESS | 2089 | RSS: Main: 282628096 04:42:14 INFO - PROCESS | 2089 | 04:42:17 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57119/tests/kraken/driver.html?testName=audio-dft) 04:42:17 INFO - PROCESS | 2089 | RSS: Main: 292622336 04:42:17 INFO - PROCESS | 2089 | 04:42:21 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57119/tests/kraken/driver.html?testName=audio-fft) 04:42:21 INFO - PROCESS | 2089 | RSS: Main: 279834624 04:42:21 INFO - PROCESS | 2089 | 04:42:23 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57119/tests/kraken/driver.html?testName=audio-oscillator) 04:42:24 INFO - PROCESS | 2089 | RSS: Main: 282021888 04:42:24 INFO - PROCESS | 2089 | 04:42:26 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:27 INFO - PROCESS | 2089 | RSS: Main: 280784896 04:42:27 INFO - PROCESS | 2089 | 04:42:29 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57119/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:30 INFO - PROCESS | 2089 | RSS: Main: 281022464 04:42:30 INFO - PROCESS | 2089 | 04:42:33 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57119/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:33 INFO - PROCESS | 2089 | RSS: Main: 282079232 04:42:33 INFO - PROCESS | 2089 | 04:42:36 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57119/tests/kraken/driver.html?testName=json-parse-financial) 04:42:37 INFO - PROCESS | 2089 | RSS: Main: 282382336 04:42:37 INFO - PROCESS | 2089 | 04:42:38 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:39 INFO - PROCESS | 2089 | RSS: Main: 314773504 04:42:39 INFO - PROCESS | 2089 | 04:42:41 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:41 INFO - PROCESS | 2089 | RSS: Main: 314675200 04:42:41 INFO - PROCESS | 2089 | 04:42:43 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:44 INFO - PROCESS | 2089 | RSS: Main: 322686976 04:42:44 INFO - PROCESS | 2089 | 04:42:46 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:47 INFO - PROCESS | 2089 | RSS: Main: 324055040 04:42:47 INFO - PROCESS | 2089 | 04:42:50 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:50 INFO - PROCESS | 2089 | RSS: Main: 323751936 04:42:50 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:57119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57119/tests/kraken/driver.html?testName=ai-astar) 04:42:52 INFO - PROCESS | 2089 | RSS: Main: 386400256 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | __start_tp_report 04:42:52 INFO - PROCESS | 2089 | _x_x_mozilla_page_load 04:42:52 INFO - PROCESS | 2089 | _x_x_mozilla_page_load_details 04:42:52 INFO - PROCESS | 2089 | |i|pagename|runs| 04:42:52 INFO - PROCESS | 2089 | |0;ai-astar;110;108;110;109;110;111;116;116;111;110 04:42:52 INFO - PROCESS | 2089 | |1;audio-beat-detection;179;112;173;197;150;143;122;157;151;120 04:42:52 INFO - PROCESS | 2089 | |2;audio-dft;188;184;187;197;259;204;180;178;182;182 04:42:52 INFO - PROCESS | 2089 | |3;audio-fft;74;75;77;132;56;57;58;59;124;55 04:42:52 INFO - PROCESS | 2089 | |4;audio-oscillator;93;90;130;77;80;87;118;78;80;122 04:42:52 INFO - PROCESS | 2089 | |5;imaging-gaussian-blur;86;82;85;83;86;84;87;83;87;83 04:42:52 INFO - PROCESS | 2089 | |6;imaging-darkroom;92;93;93;101;137;93;93;94;105;150 04:42:52 INFO - PROCESS | 2089 | |7;imaging-desaturate;87;84;86;82;86;84;87;87;86;87 04:42:52 INFO - PROCESS | 2089 | |8;json-parse-financial;54;54;54;53;53;53;54;64;55;52 04:42:52 INFO - PROCESS | 2089 | |9;json-stringify-tinderbox;60;61;79;75;71;69;69;68;68;74 04:42:52 INFO - PROCESS | 2089 | |10;stanford-crypto-aes;85;84;91;84;84;82;82;83;85;84 04:42:52 INFO - PROCESS | 2089 | |11;stanford-crypto-ccm;128;133;138;134;133;119;120;127;138;139 04:42:52 INFO - PROCESS | 2089 | |12;stanford-crypto-pbkdf2;138;125;140;139;139;129;140;140;140;140 04:42:52 INFO - PROCESS | 2089 | |13;stanford-crypto-sha256-iterative;68;68;70;82;51;53;66;66;66;66 04:42:52 INFO - PROCESS | 2089 | __end_tp_report 04:42:52 INFO - PROCESS | 2089 | __start_cc_report 04:42:52 INFO - PROCESS | 2089 | _x_x_mozilla_cycle_collect,1249 04:42:52 INFO - PROCESS | 2089 | __end_cc_report 04:42:52 INFO - PROCESS | 2089 | __startTimestamp1459770172626__endTimestamp 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | ------- Summary: start ------- 04:42:52 INFO - PROCESS | 2089 | Number of tests: 14 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:2.73 (2.5%) stddev-sans-first:2.86 04:42:52 INFO - PROCESS | 2089 | Values: 110.0 108.0 110.0 109.0 110.0 111.0 116.0 116.0 111.0 110.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:154.00 stddev:27.50 (17.9%) stddev-sans-first:27.15 04:42:52 INFO - PROCESS | 2089 | Values: 179.0 112.0 173.0 197.0 150.0 143.0 122.0 157.0 151.0 120.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#2] audio-dft Cycles:10 Average:194.10 Median:187.50 stddev:24.17 (12.9%) stddev-sans-first:25.54 04:42:52 INFO - PROCESS | 2089 | Values: 188.0 184.0 187.0 197.0 259.0 204.0 180.0 178.0 182.0 182.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#3] audio-fft Cycles:10 Average:76.70 Median:58.50 stddev:28.39 (48.5%) stddev-sans-first:30.10 04:42:52 INFO - PROCESS | 2089 | Values: 74.0 75.0 77.0 132.0 56.0 57.0 58.0 59.0 124.0 55.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:80.00 stddev:20.10 (25.1%) stddev-sans-first:21.30 04:42:52 INFO - PROCESS | 2089 | Values: 93.0 90.0 130.0 77.0 80.0 87.0 118.0 78.0 80.0 122.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#5] imaging-gaussian-blur Cycles:10 Average:84.60 Median:85.50 stddev:1.84 (2.1%) stddev-sans-first:1.88 04:42:52 INFO - PROCESS | 2089 | Values: 86.0 82.0 85.0 83.0 86.0 84.0 87.0 83.0 87.0 83.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:93.00 stddev:20.90 (22.5%) stddev-sans-first:21.62 04:42:52 INFO - PROCESS | 2089 | Values: 92.0 93.0 93.0 101.0 137.0 93.0 93.0 94.0 105.0 150.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.50 stddev:1.71 (2.0%) stddev-sans-first:1.74 04:42:52 INFO - PROCESS | 2089 | Values: 87.0 84.0 86.0 82.0 86.0 84.0 87.0 87.0 86.0 87.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.41 (6.3%) stddev-sans-first:3.61 04:42:52 INFO - PROCESS | 2089 | Values: 54.0 54.0 54.0 53.0 53.0 53.0 54.0 64.0 55.0 52.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:5.87 (8.4%) stddev-sans-first:5.15 04:42:52 INFO - PROCESS | 2089 | Values: 60.0 61.0 79.0 75.0 71.0 69.0 69.0 68.0 68.0 74.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.55 (3.0%) stddev-sans-first:2.69 04:42:52 INFO - PROCESS | 2089 | Values: 85.0 84.0 91.0 84.0 84.0 82.0 82.0 83.0 85.0 84.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:133.50 stddev:7.22 (5.4%) stddev-sans-first:7.58 04:42:52 INFO - PROCESS | 2089 | Values: 128.0 133.0 138.0 134.0 133.0 119.0 120.0 127.0 138.0 139.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:140.00 stddev:5.40 (3.9%) stddev-sans-first:5.71 04:42:52 INFO - PROCESS | 2089 | Values: 138.0 125.0 140.0 139.0 139.0 129.0 140.0 140.0 140.0 140.0 04:42:52 INFO - PROCESS | 2089 | 04:42:52 INFO - PROCESS | 2089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:67.00 stddev:8.64 (12.9%) stddev-sans-first:9.12 04:42:52 INFO - PROCESS | 2089 | Values: 68.0 68.0 70.0 82.0 51.0 53.0 66.0 66.0 66.0 66.0 04:42:52 INFO - PROCESS | 2089 | -------- Summary: end -------- 04:42:52 INFO - PROCESS | 2089 | 04:42:53 INFO - TEST-INFO | 2089: exit 0 04:42:53 INFO - TEST-OK | kraken | took 57245ms 04:42:53 INFO - SUITE-END | took 1170s 04:42:53 INFO - Completed test suite (00:19:30) 04:42:53 INFO - javascript benchmark 04:42:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3428.9999999999995, 3454.809985450799, 3487.9651203487956, 3492.9476057859138, 3521.806300653463, 5617.4382561743805, 5655.830325090244, 5701.629394089381, 5711.257536520252, 5712.628679135859, 5704.0, 5722.885542289162, 5746.425357464252, 5833.416658334165, 5856.912146317809, 5143.948560514385, 5150.510701483362, 5182.455842136578, 5206.921896171561, 5309.575233981292, 5251.343582052244, 5262.210668399752, 5279.41926388097, 5291.68249905005, 5326.387465441485, 5149.9485005149845, 5169.948300517022, 5223.320968274138, 5253.86865328366, 5285.86785330366, 5170.689758614495, 5183.533481986601, 5183.714895680736, 5186.481351864821, 5220.660657057279, 5114.667546609458, 5140.820071297487, 5149.716765577892, 5167.276581278624, 5169.974150129263, 5508.614396992212, 5559.193916882029, 5613.915791263134, 5626.324841019063, 5670.262865827416, 5168.457311982263, 6234.812955611339, 6250.843728906768, 6266.0, 6291.7797877074545, 5493.23094766733, 6134.620279381772, 6325.620462772248, 6329.588576742497, 6335.081413195061, 5794.82615521535, 5803.042497987869, 5811.912821307684, 5863.618864773819, 5867.11993201019, 6296.5592408531875, 6305.747770089237, 6319.0, 6329.050642403584, 6332.936670633327, 6029.758809647565, 6043.184170137063, 6147.139400483936, 6155.1075094112, 6181.103739957681, 6189.81430557084, 6238.0, 6249.562530622813, 6280.2777680566405, 6282.905756413657, 6185.226846644169, 6223.1287619733275, 6237.594556353823, 6249.062640603855, 6268.059791031291, 6125.601835880653, 6179.196704428396, 6261.686915654199, 6277.560570760094, 6299.244090709052, 4529.818807247739, 4598.0803839232285, 4842.83050093245, 4875.536824001714, 4925.630577706686, 4368.759718215465, 4372.453443319585, 4377.649788016951, 4377.8248870044845, 4397.40635014269, 5573.60984731073, 5636.830895073154, 5644.774209031592, 5656.773729050874, 5658.540481979385, 6188.412100850412, 6196.597221180609, 6244.718987645567, 6248.656323902229, 6313.77901773445, 5672.461116193955, 5683.005474042026, 5694.487496125369, 5698.17376480408, 5698.914516282259, 5232.3982741985155, 5378.838634840961, 5383.111786555253, 5389.380221274525, 5400.0, 6190.257169139642, 6256.43692067707, 6265.185525881698, 6290.24517057956, 6313.684315784284, 6259.655718935503, 6273.121762953099, 6276.403741644536, 6284.8428789278805, 6297.086922396135, 6214.1921550198185, 6280.0893870389455, 6333.113364128933, 6353.4599559038, 6361.554691171574, 6127.769884593299, 6152.323244443018, 6193.318734939063, 6203.16257305276, 6219.875602487835, 6279.120923070683, 6300.2754683212015, 6302.936970630235, 6305.306416294112, 6321.0, 5981.7308221131025, 6087.360827113266, 6118.938810612015, 6124.38756124384, 6144.754209831557, 6079.787207447718, 6079.817605471843, 6081.695915204311, 6086.543509236736, 6135.969320153371, 5104.259882317117, 5909.497692696169, 5913.881722365614, 5916.881662366814, 5923.881522369442, 5890.322612899571, 5992.250968628921, 6070.0, 6116.204893363834, 6120.387961203844, 4904.2643603459765, 5982.880342393215, 5993.490553303018, 6005.459508644243, 6013.278406591062], "unit": "score", "name": "dojo.html", "value": 5681.950144233478}, {"lowerIsBetter": false, "replicates": [488.1092007087067, 574.2247965246916, 574.9798757043504, 587.1867463562965, 628.6259675493081, 37997.81001094994, 38414.03964900872, 38471.0, 38509.03727406813, 38671.83984480463, 40711.0, 41203.9699007525, 41310.58689413105, 41319.793401032955, 41363.17273654525, 9512.667056653036, 9711.465869377182, 9712.368696034771, 9721.125098741111, 9726.249275130474, 9430.858537121949, 9612.279079069098, 9618.42289462631, 9732.805343893118, 9733.415995040285, 9702.932677405479, 9752.26857985654, 9771.413715177112, 9775.071368220044, 9795.363301385423, 9675.080867317594, 9742.366746161548, 9746.610135594532, 9747.90252097477, 9761.316707830454, 9637.855432168522, 9779.902200977971, 9785.412875227437, 9786.461744604045, 9827.0, 39838.402423963664, 40157.598424015676, 40171.59828401708, 40233.396499052535, 40247.59752402497, 3283.1792051987004, 3371.2751758371824, 3428.6571342865514, 3660.4143337066207, 3663.358912190383, 28391.716082839113, 28480.71519284822, 28681.922654142185, 28886.566701499494, 29261.414771704447, 2755.600437936508, 2786.1362977477047, 2846.4307138572367, 2915.941681166365, 2956.8965086222092, 332328.0, 377701.99999999726, 379093.0, 379136.0, 379826.0, 44086.33870491945, 44693.55306446894, 44708.10583788371, 53658.463415365346, 63612.0, 43815.56184438115, 44008.559914401085, 44076.89807754832, 44184.0, 44187.337189942176, 15050.698986020217, 15087.321070551852, 15246.466373676869, 15260.847391525942, 15311.693766124616, 12375.071869609816, 12458.937705311597, 12471.5011399543, 12472.939800117092, 12477.688057798447, 11565.901239382245, 13424.798628020588, 14023.298835058205, 14102.929485352508, 14152.150870947777, 5332.360116785933, 6107.854454955701, 6144.354842741537, 6171.321154672983, 6182.814515564541, 1000.9949950250202, 1054.267284237463, 1062.8352605346183, 1096.31480324797, 1116.6655846263636, 24949.5010099797, 27927.882884684386, 28673.13980580586, 29524.409511809645, 29679.703202967696, 1075.6342843433113, 1124.2692250037378, 1144.3248483394837, 1166.4284500594817, 1167.8248262760653, 13663.454410674574, 14703.970722049355, 14875.0, 14970.32633531472, 15071.849281507264, 531741.0, 537512.0, 541837.0, 544391.0, 544528.0, 56549.869002619715, 57052.99999999917, 57168.42831571631, 57187.0, 57274.140887886715, 1312.3044786263297, 1433.8924580656492, 1439.2731670506537, 1474.837767845536, 1482.7256957462903, 27866.58200126959, 28838.711612883602, 28859.567106493, 29582.408351833274, 29718.554221687125, 45018.549814501435, 45371.0, 45460.77269613631, 45464.40874569374, 45550.31674524819, 368908.0, 370780.0, 371434.0, 371906.0, 372361.0, 27611.58582621222, 32533.837330813196, 32945.835270823496, 32971.50542741813, 33031.843885463895, 41400.37899431571, 42046.57953420427, 42133.57866421297, 42589.0, 43246.78376608097, 30295.848520757256, 35223.82388088043, 35454.8227258862, 35549.46675799813, 36226.4566031515, 35074.473882892285, 35322.0, 35474.0, 35878.820605896806, 35941.28117437689, 35344.939651810484, 35480.0, 35571.466428003085, 35950.28099438049, 36140.27719445544, 29586.40827183401, 29665.703342966295, 31259.218519537193, 31310.530342045342, 31620.525692114177, 23532.29403117909, 23851.0, 24197.395065123514, 24313.905874235348, 24352.391190220387], "unit": "score", "name": "ext.html", "value": 18617.227713052}, {"lowerIsBetter": false, "replicates": [362.67721727662376, 362.72251727428505, 368.1881451399664, 373.4659437005085, 376.24750499001993, 19133.808661913376, 19594.314199003038, 20904.581908361823, 20937.58124837504, 20945.266915657954, 11981.281123132618, 12348.876511234885, 12364.567240146596, 12377.009839212864, 12382.752344953118, 5132.922086361868, 5171.715555644438, 5752.223449834281, 5917.230760001194, 5933.6439813611105, 5254.712595414129, 5873.383294754032, 5937.020391635397, 6003.339632640406, 6007.4893634041155, 5183.922241166386, 5358.0, 5390.703511306877, 5615.241942337773, 5870.88258234835, 5339.679619222839, 5355.946440535584, 5359.38367087786, 5363.651362661434, 5410.756515956772, 5160.509751573594, 5168.457311982225, 5286.3392075990505, 5528.9723551381985, 5539.861503462405, 13230.801537976939, 13397.66505837352, 13436.932815335958, 13453.932730336384, 21260.574788504142, 1930.855185861066, 2052.84603654725, 2069.0378973777265, 2214.2360885494477, 2765.9170224893287, 9547.809043819085, 9562.952185239099, 9959.402435853872, 10111.949440252825, 11824.527018919232, 1671.1059583122972, 1696.6606678664193, 1706.385701147586, 1751.9474415767547, 1752.5793809485758, 94846.52576737072, 96399.0, 96945.54581681281, 97259.5685107871, 97484.0, 10898.673039808818, 10996.780064398827, 11089.585476187944, 11099.5560177592, 11239.438028098562, 13762.24307663068, 13813.447462101403, 13836.308184590931, 13844.653883652989, 13878.306084695725, 8302.682605045342, 8454.704085357105, 8458.74623761288, 8579.270761985177, 8583.914160858436, 8575.0, 8604.268637165786, 8626.201274699772, 8735.25750311218, 8809.779755506164, 4303.720258183208, 4376.059147283349, 4380.69335146543, 4422.469303683579, 4436.689431739747, 1831.8717689761854, 1860.339579449303, 1861.8231268029515, 1877.1365172021024, 1886.6698327792856, 860.6144107986262, 930.7114794413618, 971.3540495570367, 1042.3537406807677, 1074.0762943868267, 15759.448419305269, 19822.0, 19878.50303742418, 20249.493762656053, 20314.695279570817, 958.9808203836023, 959.491469521155, 977.3207620703685, 1000.394761169482, 1005.9127310829911, 10317.174626029899, 10525.21060920434, 10670.57317707283, 10711.517981690842, 10728.302660327054, 560141.0, 592482.0, 627560.0, 646290.0, 648335.0, 110451.44774276238, 111617.44191279155, 111876.0, 113636.0, 116072.0, 987.5457289646699, 995.4027583449872, 1011.6560369474267, 1016.4561959351711, 1016.7051555049101, 13187.802182967454, 17429.73855392145, 17501.64996700084, 18090.638187236444, 18224.0, 35344.29311413809, 36698.44952325771, 46885.0, 49155.01689966252, 49817.75091124521, 66917.0, 66985.0, 67412.662936685, 67982.66008669925, 68258.0, 5834.504067154339, 7168.354848063699, 7831.843363132592, 7867.252611001945, 8174.141715119827, 10306.433146177033, 11330.433478325886, 12128.696782580153, 12304.569340073054, 12349.93825030869, 10540.209484288862, 10646.254762166884, 10865.239433239914, 10878.292910960763, 10907.454627268764, 10281.177505799667, 10545.767895478724, 10656.413897235727, 10873.836892446461, 10983.890161098607, 10662.946685266525, 10751.838722419014, 10757.67726968161, 10911.491161027116, 11171.72070698239, 7808.453408261367, 7820.452568320163, 7900.209979002284, 7919.802004949923, 8196.795080123045, 9438.0, 10589.0, 10854.620088296871, 11016.06363459083, 11146.108311335236], "unit": "score", "name": "jquery.html", "value": 8894.251415519293}, {"lowerIsBetter": false, "replicates": [1424.6794471243966, 1561.3442354211234, 1594.6730920161365, 1856.2667746240236, 1996.7204591357213, 7982.401319901009, 8666.263367613752, 8782.692605758799, 8796.824063518727, 8804.64781408743, 8438.789030274245, 8698.043215246318, 8699.565021748904, 8701.91298087019, 8712.738617841474, 2102.463871712715, 2166.5666866626657, 2441.9755802441928, 2512.057978258153, 2521.13021007752, 2519.433127546306, 2535.733747956466, 2535.9746402535925, 2537.974620253792, 2539.415934335104, 2399.5081008393236, 2482.615194644833, 2483.0, 2483.5653760591913, 2489.962650560243, 2450.3629056445366, 2493.7132229793533, 2505.8621775802326, 2508.7240403555593, 2513.673222481084, 2035.592881423721, 2404.3748625357357, 2435.549423356667, 2438.5976313908186, 2454.0, 8784.736457906209, 8862.423942443786, 8873.73378798637, 8885.422447540954, 8885.511296878669, 5332.680039197622, 5515.0, 5522.0, 5524.392316845144, 5529.142982837667, 3556.1820781220204, 3632.291703117893, 3714.052916506301, 3741.1956429367815, 3745.9625403745886, 1053.952572134256, 1070.5129166229424, 1076.0, 1085.7394225385929, 1087.782443511301, 11975.401229938469, 11992.460339284753, 12002.099842511847, 12011.759764804743, 12017.918387345093, 4114.979425102855, 4841.540053694894, 4881.0, 4982.227754698028, 4984.37695288089, 10028.949855250678, 10050.748731281776, 10062.547185376676, 10086.546105425274, 10112.898871011195, 5539.612227144061, 5545.195946587723, 5551.861203469945, 5587.1339942309005, 5596.300462442195, 4527.8641640750175, 4696.953030469652, 4848.660593758403, 4984.950150498521, 5023.070731914608, 3725.6088110748524, 3795.962040379616, 3831.4635950966886, 3831.540215174197, 3851.537815462106, 1302.9674258143623, 1309.4958441000283, 1309.862464441239, 1322.8081928120562, 1325.5360623781792, 1343.1202562321696, 1357.9253141077336, 1380.6065271397604, 1381.1436909116412, 1387.1330418488444, 8170.673173073011, 8251.968503937007, 8269.21442462965, 8276.172382761795, 8276.420650554403, 511.5447251945697, 522.6237109281311, 528.2683483375553, 530.0194639916124, 532.597888594109, 6220.160278362454, 6247.312795592481, 6315.989441689308, 6324.0, 6333.46165575922, 10394.740131496774, 10773.78452430947, 10787.892121078688, 10874.836877446845, 10910.34537927711, 10274.0, 10645.680629581126, 10675.626353077605, 10731.034206921415, 10851.240413171161, 8351.164883511721, 8405.495670259805, 8423.0, 8466.57667116654, 8492.57537123129, 7750.534967901944, 7999.32005779492, 8009.239122283374, 8012.439129260896, 8017.198280171936, 9492.240620750461, 9743.9025609743, 9776.511174441392, 9796.412215266822, 9813.362131461432, 9739.513024348613, 9870.802583948138, 9943.552540135566, 10149.137323327599, 10157.136643385395, 6666.666666666589, 6815.829604259735, 7343.237622970555, 7523.811904702427, 7582.924170758221, 8220.260176584135, 8228.0, 8249.876251856347, 8270.503769773833, 8292.792680183044, 7218.169910460364, 7286.271372862671, 7343.3390994810725, 7456.552606843607, 7531.88702169457, 7146.678399471933, 7193.424526038009, 7229.277072292939, 7248.710051597877, 7252.89120663201, 7655.732049378245, 7776.300132988058, 7781.416393770377, 7798.337141342822, 7806.180351063056, 6975.232724400211, 6983.441324694114, 7082.822929426806, 7085.078939738008, 7099.07711997437, 7072.681729322296, 7158.749443769651, 7161.713531458683, 7176.174739904769, 7176.605286709281], "unit": "score", "name": "mootools.html", "value": 4866.685416643553}, {"lowerIsBetter": false, "replicates": [324.5845317992969, 325.9478483442648, 332.5643407136651, 333.80806036529003, 338.08042125418865, 6445.9677701611545, 6511.283758786536, 6513.576617519858, 6568.835779105525, 6591.307912669173, 6489.351064893508, 6496.935030649692, 6501.577397469161, 6522.57603255788, 6526.477881769459, 4588.655850811186, 4672.299155126724, 4689.507601701806, 4777.18787806072, 4825.179719447694, 3862.7489213201193, 3896.5324161100707, 4773.92839107412, 4792.185328494164, 4820.734859582722, 3877.2827027000094, 4756.785944632483, 4757.619390448773, 4786.282057691356, 4791.209450440673, 4545.659075569345, 4611.708721557986, 4737.289406589005, 4770.880727981794, 4781.474037855833, 4090.9386359204636, 4098.959010409888, 4099.85650502234, 4105.630493255591, 4107.54816970133, 5207.3490813648295, 6119.204503414572, 6253.78111766086, 6263.968680156616, 6279.8744025119695, 4689.710329659337, 5095.235714642796, 5182.274481572583, 5565.5825813063775, 5631.60578759487, 6879.071325371061, 6880.139982502187, 6880.415164711006, 6904.861902761967, 6934.167899851999, 3981.820818063194, 4507.481639611454, 4650.907146747409, 4697.3893393858925, 4712.986707857793, 7161.462890283249, 7307.232740562217, 7317.780466585958, 7346.52247603904, 7416.7774966751085, 4773.403324584427, 4792.113459010095, 4792.376990991149, 4794.4486384065585, 4795.784189711471, 4847.127517046895, 4854.368932038883, 4859.902801943941, 4868.2210846264425, 4879.999600081975, 4711.670183087151, 5694.402087780806, 5698.629589076697, 5714.085746280575, 5727.914081288784, 5574.470425309589, 6907.585544867324, 6930.995005724142, 6932.792016239521, 6933.410660093848, 1380.3581334679423, 1647.604574902015, 1661.8753593480537, 1670.548951783036, 1674.6566953774447, 830.2403300979536, 1019.8572199892021, 1079.5304042741275, 1084.728817795551, 1112.5382966069153, 6404.0, 6547.508936829757, 6585.9012114818315, 6684.665766711645, 6710.899336509956, 7271.490995630255, 7278.163011253668, 7281.0, 7297.671604777798, 7334.046573945353, 5302.814401495929, 6503.154589903377, 6516.250631177475, 6517.4134327910715, 6538.509611779135, 3081.260497480633, 3843.9615603844163, 3855.4409610606867, 3860.6718428933855, 3861.3242682530445, 6897.3447522486285, 7161.319674630901, 7379.262073792578, 7394.334509894135, 7401.407887368998, 6133.417325354084, 6499.3175716549085, 7196.95644131598, 7274.054372931485, 7429.0, 7576.24237576249, 7598.240175982468, 7599.316061554487, 7599.924000760032, 7615.4669173157345, 6948.895766563607, 7078.362947334765, 7295.161056478573, 7301.269873012656, 7307.3423391894985, 7145.82135446618, 7155.534890232118, 7156.1770396403, 7158.856822863618, 7168.247334029852, 7587.2412758723685, 7607.4674772765375, 7618.00965874455, 7621.3902887769955, 7630.542167469747, 4789.114013907299, 4790.7844147012775, 4791.736454494897, 4793.688410253322, 4795.736234507136, 6990.755323563854, 7203.819904502429, 7279.563226206445, 7291.08861392326, 7342.449316301192, 5747.942520574741, 6960.47796415281, 7015.088038554955, 7030.3321184487395, 7031.1211098612675, 6963.860722785617, 6964.547304425196, 6972.651367431709, 6985.79042628722, 6993.545419547713, 6826.658667066726, 6831.931680683129, 6847.657617119224, 6851.2121106071445, 6856.0, 6765.594064356154, 6916.135483064617, 6948.444124469929, 6965.373116419547, 7022.12223472066, 6522.804315870531, 6807.251202367835, 6862.382385585322, 6878.65606719672, 6896.069030680794], "unit": "score", "name": "prototype.html", "value": 5063.097354460485}, {"lowerIsBetter": false, "replicates": [684.4353408438039, 716.1370548489072, 751.2074761127012, 766.6166916541729, 792.3581898662082, 14811.55565333039, 14934.850651493482, 14959.626009349744, 14961.476348327797, 14980.026298290617, 13450.260235687034, 13597.728045439086, 13879.514217002406, 14218.71562568748, 14271.0, 718.3032458515232, 760.0119844202542, 893.1871996483185, 921.7603423110006, 924.3945215883573, 827.6482494939627, 924.4037595750737, 945.9054094590555, 947.1333729637373, 949.9787728192186, 984.4339504784778, 990.8810942686888, 991.1525645573039, 995.1342332170985, 995.6465454763563, 767.7696690992735, 969.6654654144379, 979.6962941488162, 982.513655740413, 989.648674720471, 709.1171491493124, 726.1721637333444, 740.6037769793135, 744.3970383988986, 745.1282000059942, 14820.110793352325, 14870.851291487055, 14895.404183832634, 14901.552953411307, 14908.552743417715, 10580.153587712965, 12391.504339826397, 12494.875051249463, 12651.873481265253, 12823.935880320632, 9919.90080099197, 10040.849387259197, 10156.23828212887, 10437.843432348522, 10989.61536346224, 4094.9967258021975, 4125.278076336629, 4201.6008479194425, 4204.915901681979, 4210.200061988213, 69923.0, 71064.0, 71423.57152856966, 71654.28345716528, 71800.0, 9095.31785116119, 9215.53922303882, 9250.21373183287, 9266.258699304039, 9313.906860931304, 20793.58412831735, 21009.579808403745, 21048.684269735968, 21051.473713157295, 21089.472763181042, 7552.811179720551, 7618.428617853572, 7634.541927484369, 7727.806804829925, 7748.186440423787, 4143.834246630161, 4154.335306350969, 4182.623563879265, 4186.1836941796055, 4431.224535706238, 3462.3940810358085, 3531.434970404723, 3559.1280136366754, 3562.946555801665, 3580.785152890835, 659.970301336441, 666.9199696036507, 668.0747165176266, 670.11210146556, 672.7275453441364, 555.1727925391139, 557.7908284393352, 563.4168635462277, 585.853536615846, 591.6036255708685, 6868.484863635247, 7088.610126442992, 7401.259874012556, 7534.434917381109, 7840.740243799423, 512.874345785285, 544.9100898351807, 545.5090418623271, 549.9092649712752, 572.9713514324351, 3732.496113024707, 3733.0, 3734.8319325630414, 3741.8877433677035, 3754.5494540655295, 85728.0, 86521.0, 87098.12901871027, 90930.0, 94020.52989735008, 67148.0, 67579.0, 74538.0, 74645.25354746492, 75867.48265034778, 65098.69802604016, 65412.0, 65434.69130617361, 65739.67130164319, 66718.99921501182, 8160.551169685724, 8330.416870818985, 8332.16678332162, 8445.87331190045, 8502.404831661972, 48723.5127648719, 49141.75429122832, 49571.0, 50392.49607503878, 50521.0, 55173.0, 65147.67426162839, 65415.67292163509, 65717.0, 66883.66558167373, 9791.608335666493, 10886.29239099456, 10904.264504892217, 10978.451077445936, 11204.551817927191, 11878.680301753664, 11911.40442977865, 12051.096167787626, 12199.3290369027, 12322.137450378388, 11139.275947063416, 11173.441327933408, 11206.271592346471, 11262.155338349821, 11648.708782280512, 11233.269837460539, 11568.190226684388, 11623.59317423886, 11795.882041179822, 12163.391830408267, 8830.867536986822, 11009.889901100887, 11046.226764126433, 11184.0, 11450.37022963745, 7618.504797188165, 9402.2948278878, 9502.572384242587, 9534.761630959281, 9754.317197796086, 8962.641494340414, 9042.81914361696, 9569.473678947446, 9612.951935240279, 9619.27855410833], "unit": "score", "name": "yui.html", "value": 6813.478078316763}], "name": "dromaeo_css", "value": 7352.3955271782}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 110.0, 109.0, 110.0, 111.0, 116.0, 116.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [179.0, 112.0, 173.0, 197.0, 150.0, 143.0, 122.0, 157.0, 151.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [188.0, 184.0, 187.0, 197.0, 259.0, 204.0, 180.0, 178.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 194.1}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 77.0, 132.0, 56.0, 57.0, 58.0, 59.0, 124.0, 55.0], "unit": "score", "name": "audio-fft", "value": 76.7}, {"lowerIsBetter": true, "replicates": [93.0, 90.0, 130.0, 77.0, 80.0, 87.0, 118.0, 78.0, 80.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 95.5}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 85.0, 83.0, 86.0, 84.0, 87.0, 83.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 101.0, 137.0, 93.0, 93.0, 94.0, 105.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 105.1}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 82.0, 86.0, 84.0, 87.0, 87.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 54.0, 53.0, 53.0, 53.0, 54.0, 64.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 79.0, 75.0, 71.0, 69.0, 69.0, 68.0, 68.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 91.0, 84.0, 84.0, 82.0, 82.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [128.0, 133.0, 138.0, 134.0, 133.0, 119.0, 120.0, 127.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.9}, {"lowerIsBetter": true, "replicates": [138.0, 125.0, 140.0, 139.0, 139.0, 129.0, 140.0, 140.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 82.0, 51.0, 53.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1445.0000000000002}]} 04:42:53 INFO - Return code: 0 04:42:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:42:53 ERROR - # TBPL SUCCESS # 04:42:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:42:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:42:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:42:53 INFO - 2016-04-04 04:42:53.934 screenresolution[2093:27809] starting screenresolution argv=screenresolution get 04:42:53 INFO - 2016-04-04 04:42:53.936 screenresolution[2093:27809] Display 0: 1600x1200x32@60 04:42:53 INFO - 2016-04-04 04:42:53.942 screenresolution[2094:27812] starting screenresolution argv=screenresolution list 04:42:53 INFO - Available Modes on Display 0 04:42:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:42:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:42:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:42:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:42:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:42:54 INFO - Intel Iris: 04:42:54 INFO - Chipset Model: Intel Iris 04:42:54 INFO - Type: GPU 04:42:54 INFO - Bus: Built-In 04:42:54 INFO - VRAM (Dynamic, Max): 1536 MB 04:42:54 INFO - Vendor: Intel (0x8086) 04:42:54 INFO - Device ID: 0x0a2e 04:42:54 INFO - Revision ID: 0x0009 04:42:54 INFO - Displays: 04:42:54 INFO - Display: 04:42:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:42:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:42:54 INFO - Display Serial Number: 1600x1200 60 04:42:54 INFO - Main Display: Yes 04:42:54 INFO - Mirror: Off 04:42:54 INFO - Online: Yes 04:42:54 INFO - Rotation: Supported 04:42:54 INFO - Return code: 0 04:42:54 INFO - Running post-action listener: _resource_record_post_action 04:42:54 INFO - Running post-run listener: _resource_record_post_run 04:42:55 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 946176; Write bytes: 701094400; Read time: 3; Write time: 2114 04:42:55 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398785024; Write bytes: 392820736; Read time: 30279; Write time: 752 04:42:55 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 946176; Write bytes: 297112064; Read time: 3; Write time: 1330 04:42:55 INFO - Running post-run listener: _upload_blobber_files 04:42:55 INFO - Blob upload gear active. 04:42:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:42:55 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:42:55 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:42:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:56 INFO - (blobuploader) - INFO - Done attempting. 04:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:42:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:57 INFO - (blobuploader) - INFO - Done attempting. 04:42:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:57 INFO - Return code: 0 04:42:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8da7a602d16beb3e700952c68db5210f50ccf5a43b2e11aa2e4ee54ef5c44ebebaf18e55204b370a4d9de3841fdfb9488b9016febd14e3b57b53255e07331fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d1e1a53253ec0409065fa249707cdd3d0d4134b1c09e73ad213487f26d82395062139de9ac6abd168fa441bd53d61fbd3e329ced4b388828d8bd05b3785081"} 04:42:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:57 INFO - Contents: 04:42:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8da7a602d16beb3e700952c68db5210f50ccf5a43b2e11aa2e4ee54ef5c44ebebaf18e55204b370a4d9de3841fdfb9488b9016febd14e3b57b53255e07331fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d1e1a53253ec0409065fa249707cdd3d0d4134b1c09e73ad213487f26d82395062139de9ac6abd168fa441bd53d61fbd3e329ced4b388828d8bd05b3785081"} 04:42:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:57 INFO - Copying logs to upload dir... 04:42:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1326.630599 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-04-04 04:42:57.853025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 04:42:57.857404) ========= 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.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/Firefox/sha512/c8da7a602d16beb3e700952c68db5210f50ccf5a43b2e11aa2e4ee54ef5c44ebebaf18e55204b370a4d9de3841fdfb9488b9016febd14e3b57b53255e07331fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d1e1a53253ec0409065fa249707cdd3d0d4134b1c09e73ad213487f26d82395062139de9ac6abd168fa441bd53d61fbd3e329ced4b388828d8bd05b3785081"} build_url:https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010074 build_url: 'https://queue.taskcluster.net/v1/task/JL8c5z2mSA-kObSE_bDRPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8da7a602d16beb3e700952c68db5210f50ccf5a43b2e11aa2e4ee54ef5c44ebebaf18e55204b370a4d9de3841fdfb9488b9016febd14e3b57b53255e07331fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d1e1a53253ec0409065fa249707cdd3d0d4134b1c09e73ad213487f26d82395062139de9ac6abd168fa441bd53d61fbd3e329ced4b388828d8bd05b3785081"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 04:42:57.890042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:42:57.890792) ========= 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.wDwYrc4lqA/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.CbZveL5vY2/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.004709 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:42:57.943118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 04:42:57.943849) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 04:42:57.944626) ========= ========= Total master_lag: 0.51 =========