builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0135 starttime: 1460326517.84 results: success (0) buildid: 20160410132213 builduid: 1d12707a6a7a4786b25ef5a1068c23bf revision: 29d5a4175c8b74f45482276a53985cf2568b4be2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:17.838008) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:17.838403) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-04-10 15:15:17.838697) ========= 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.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005562 basedir: '/builds/slave/test' ========= master_lag: 1.23 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-04-10 15:15:19.075705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.076020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.156827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.157109) ========= 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.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.205417) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.208749) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.209122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.209388) ========= 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.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-10 15:15:19-- 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% 8.16M=0.001s 2016-04-10 15:15:19 (8.16 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187468 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.412236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.412543) ========= 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.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.018897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:19.464148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-10 15:15:19.464483) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29d5a4175c8b74f45482276a53985cf2568b4be2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 29d5a4175c8b74f45482276a53985cf2568b4be2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-10 15:15:19,541 truncating revision to first 12 chars 2016-04-10 15:15:19,541 Setting DEBUG logging. 2016-04-10 15:15:19,541 attempt 1/10 2016-04-10 15:15:19,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29d5a4175c8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-10 15:15:20,985 unpacking tar archive at: fx-team-29d5a4175c8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.694642 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-10 15:15:21.177365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:21.180708) ========= echo 29d5a4175c8b74f45482276a53985cf2568b4be2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'29d5a4175c8b74f45482276a53985cf2568b4be2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 29d5a4175c8b74f45482276a53985cf2568b4be2 program finished with exit code 0 elapsedTime=0.005064 script_repo_revision: '29d5a4175c8b74f45482276a53985cf2568b4be2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:21.233069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:21.233364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 15:15:21.250036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-10 15:15:21.250303) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:15:21 INFO - MultiFileLogger online at 20160410 15:15:21 in /builds/slave/test 15:15:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:15:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:15:21 INFO - {'append_to_log': False, 15:15:21 INFO - 'base_work_dir': '/builds/slave/test', 15:15:21 INFO - 'blob_upload_branch': 'Fx-Team', 15:15:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:15:21 INFO - 'branch': 'Fx-Team', 15:15:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:15:21 INFO - 'config_files': ('talos/mac_config.py',), 15:15:21 INFO - 'default_actions': ('clobber', 15:15:21 INFO - 'read-buildbot-config', 15:15:21 INFO - 'download-and-extract', 15:15:21 INFO - 'populate-webroot', 15:15:21 INFO - 'create-virtualenv', 15:15:21 INFO - 'install', 15:15:21 INFO - 'run-tests'), 15:15:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:15:21 INFO - 'download_minidump_stackwalk': True, 15:15:21 INFO - 'download_symbols': 'ondemand', 15:15:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:15:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:15:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:15:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:15:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:15:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:15:21 INFO - 'installer_path': 'installer.exe', 15:15:21 INFO - 'log_level': 'info', 15:15:21 INFO - 'log_name': 'talos', 15:15:21 INFO - 'log_to_console': True, 15:15:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:15:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:15:21 INFO - 'opt_config_files': (), 15:15:21 INFO - 'pip_index': False, 15:15:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:21 INFO - 'cmd': ('bash', 15:15:21 INFO - '-c', 15:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:21 INFO - 'enabled': True, 15:15:21 INFO - 'halt_on_failure': False, 15:15:21 INFO - 'name': 'check_screen_resolution'},), 15:15:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:15:21 INFO - 'cmd': ('bash', 15:15:21 INFO - '-c', 15:15:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:15:21 INFO - 'enabled': True, 15:15:21 INFO - 'halt_on_failure': False, 15:15:21 INFO - 'name': 'check_screen_resolution'},), 15:15:21 INFO - 'run_cmd_checks_enabled': True, 15:15:21 INFO - 'sps_profile': False, 15:15:21 INFO - 'sps_profile_interval': 0, 15:15:21 INFO - 'suite': 'dromaeojs', 15:15:21 INFO - 'system_bits': '32', 15:15:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:15:21 INFO - 'title': 't-yosemite-r7-0135', 15:15:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:15:21 INFO - 'use_talos_json': True, 15:15:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:15:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:15:21 INFO - 'work_dir': 'build'} 15:15:21 INFO - ##### 15:15:21 INFO - ##### Running clobber step. 15:15:21 INFO - ##### 15:15:21 INFO - Running pre-action listener: _resource_record_pre_action 15:15:21 INFO - Running main action method: clobber 15:15:21 INFO - rmtree: /builds/slave/test/build 15:15:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:15:23 INFO - Running post-action listener: _resource_record_post_action 15:15:23 INFO - ##### 15:15:23 INFO - ##### Running read-buildbot-config step. 15:15:23 INFO - ##### 15:15:23 INFO - Running pre-action listener: _resource_record_pre_action 15:15:23 INFO - Running main action method: read_buildbot_config 15:15:23 INFO - Using buildbot properties: 15:15:23 INFO - { 15:15:23 INFO - "project": "", 15:15:23 INFO - "product": "firefox", 15:15:23 INFO - "script_repo_revision": "production", 15:15:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:15:23 INFO - "repository": "", 15:15:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:15:23 INFO - "buildid": "20160410132213", 15:15:23 INFO - "pgo_build": "False", 15:15:23 INFO - "basedir": "/builds/slave/test", 15:15:23 INFO - "buildnumber": 697, 15:15:23 INFO - "slavename": "t-yosemite-r7-0135", 15:15:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:15:23 INFO - "platform": "yosemite_r7", 15:15:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:15:23 INFO - "branch": "fx-team", 15:15:23 INFO - "repo_path": "integration/fx-team", 15:15:23 INFO - "revision": "29d5a4175c8b74f45482276a53985cf2568b4be2", 15:15:23 INFO - "stage_platform": "macosx64", 15:15:23 INFO - "builduid": "1d12707a6a7a4786b25ef5a1068c23bf", 15:15:23 INFO - "slavebuilddir": "test" 15:15:23 INFO - } 15:15:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:15:23 INFO - Running post-action listener: _resource_record_post_action 15:15:23 INFO - ##### 15:15:23 INFO - ##### Running download-and-extract step. 15:15:23 INFO - ##### 15:15:23 INFO - Running pre-action listener: _resource_record_pre_action 15:15:23 INFO - Running main action method: download_and_extract 15:15:23 INFO - mkdir: /builds/slave/test/build/tests 15:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:23 INFO - https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:30 INFO - Downloaded 1199 bytes. 15:15:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:15:30 INFO - Using the following test package requirements: 15:15:30 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:15:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:15:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:15:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'jsshell-mac.zip'], 15:15:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:15:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:15:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:15:30 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:15:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:15:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:15:30 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:15:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:30 INFO - https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:32 INFO - Downloaded 18018875 bytes. 15:15:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:15:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:15:35 INFO - Return code: 0 15:15:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:35 INFO - https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:37 INFO - Downloaded 18018875 bytes. 15:15:37 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'] 15:15:37 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 15:15:41 INFO - Return code: 0 15:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:41 INFO - https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:42 INFO - Downloaded 10841046 bytes. 15:15:42 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'] 15:15:42 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 15:15:42 INFO - Return code: 0 15:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:42 INFO - https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRaaKUZDR_GGM17P9oEeYQ/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 15:15:49 INFO - Downloaded 108841103 bytes. 15:15:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:15:49 INFO - mkdir: /builds/slave/test/properties 15:15:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:15:49 INFO - Writing to file /builds/slave/test/properties/build_url 15:15:49 INFO - Contents: 15:15:49 INFO - build_url:https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:15:50 INFO - Running post-action listener: _resource_record_post_action 15:15:50 INFO - Running post-action listener: set_extra_try_arguments 15:15:50 INFO - ##### 15:15:50 INFO - ##### Running populate-webroot step. 15:15:50 INFO - ##### 15:15:50 INFO - Running pre-action listener: _resource_record_pre_action 15:15:50 INFO - Running main action method: populate_webroot 15:15:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:15:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:15:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:15:50 INFO - '--tppagecycles', 15:15:50 INFO - '7'], 15:15:50 INFO - 'tests': ['tsvgm']}}, 15:15:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:15:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:15:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:15:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:15:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:15:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['damp', 'tps']}, 15:15:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'tests': ['damp', 'tps']}, 15:15:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['dromaeo_dom']}, 15:15:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:15:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['a11yr', 15:15:50 INFO - 'ts_paint', 15:15:50 INFO - 'tpaint', 15:15:50 INFO - 'sessionrestore', 15:15:50 INFO - 'sessionrestore_no_auto_restore', 15:15:50 INFO - 'tabpaint']}, 15:15:50 INFO - 'other-e10s': {'tests': ['a11yr', 15:15:50 INFO - 'ts_paint', 15:15:50 INFO - 'tpaint', 15:15:50 INFO - 'sessionrestore', 15:15:50 INFO - 'sessionrestore_no_auto_restore', 15:15:50 INFO - 'tabpaint']}, 15:15:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:15:50 INFO - 'ts_paint', 15:15:50 INFO - 'tpaint', 15:15:50 INFO - 'sessionrestore', 15:15:50 INFO - 'sessionrestore_no_auto_restore', 15:15:50 INFO - 'tabpaint']}, 15:15:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:15:50 INFO - 'ts_paint', 15:15:50 INFO - 'tpaint', 15:15:50 INFO - 'sessionrestore', 15:15:50 INFO - 'sessionrestore_no_auto_restore', 15:15:50 INFO - 'tabpaint']}, 15:15:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['a11yr', 15:15:50 INFO - 'ts_paint', 15:15:50 INFO - 'tpaint', 15:15:50 INFO - 'sessionrestore', 15:15:50 INFO - 'sessionrestore_no_auto_restore', 15:15:50 INFO - 'tabpaint']}, 15:15:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['a11yr', 15:15:50 INFO - 'ts_paint', 15:15:50 INFO - 'tpaint', 15:15:50 INFO - 'sessionrestore', 15:15:50 INFO - 'sessionrestore_no_auto_restore', 15:15:50 INFO - 'tabpaint']}, 15:15:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['tsvgx', 15:15:50 INFO - 'tsvgr_opacity', 15:15:50 INFO - 'tart', 15:15:50 INFO - 'tscrollx', 15:15:50 INFO - 'cart']}, 15:15:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:15:50 INFO - 'tsvgr_opacity', 15:15:50 INFO - 'tart', 15:15:50 INFO - 'tscrollx', 15:15:50 INFO - 'cart']}, 15:15:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'talos_options': ['--disable-e10s'], 15:15:50 INFO - 'tests': ['tp5o']}, 15:15:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'tests': ['tp5o']}, 15:15:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'talos_options': ['--disable-e10s', 15:15:50 INFO - '--xperf_path', 15:15:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:50 INFO - 'tests': ['tp5n']}, 15:15:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:15:50 INFO - 'talos_options': ['--xperf_path', 15:15:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:15:50 INFO - 'tests': ['tp5n']}}, 15:15:50 INFO - 'talos.zip': {'path': '', 15:15:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:15:50 INFO - Running post-action listener: _resource_record_post_action 15:15:50 INFO - ##### 15:15:50 INFO - ##### Running create-virtualenv step. 15:15:50 INFO - ##### 15:15:50 INFO - Running pre-action listener: _resource_record_pre_action 15:15:50 INFO - Running main action method: create_virtualenv 15:15:50 INFO - Creating virtualenv /builds/slave/test/build/venv 15:15:50 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 15:15:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:15:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:15:51 INFO - Using real prefix '/tools/python27' 15:15:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:15:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:15:54 INFO - Installing pip.................done. 15:15:54 INFO - Return code: 0 15:15:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:54 INFO - 'HOME': '/Users/cltbld', 15:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:54 INFO - 'LOGNAME': 'cltbld', 15:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:54 INFO - 'MOZ_NO_REMOTE': '1', 15:15:54 INFO - 'NO_EM_RESTART': '1', 15:15:54 INFO - 'PAGER': '/bin/cat', 15:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:54 INFO - 'PWD': '/builds/slave/test', 15:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:54 INFO - 'SHELL': '/bin/bash', 15:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:15:54 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:54 INFO - 'USER': 'cltbld', 15:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:54 INFO - 'XPC_FLAGS': '0x0', 15:15:54 INFO - 'XPC_SERVICE_NAME': '0', 15:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:54 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 15:15:54 INFO - Cleaning up... 15:15:54 INFO - Return code: 0 15:15:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:54 INFO - 'HOME': '/Users/cltbld', 15:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:54 INFO - 'LOGNAME': 'cltbld', 15:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:54 INFO - 'MOZ_NO_REMOTE': '1', 15:15:54 INFO - 'NO_EM_RESTART': '1', 15:15:54 INFO - 'PAGER': '/bin/cat', 15:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:54 INFO - 'PWD': '/builds/slave/test', 15:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:54 INFO - 'SHELL': '/bin/bash', 15:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:15:54 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:54 INFO - 'USER': 'cltbld', 15:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:54 INFO - 'XPC_FLAGS': '0x0', 15:15:54 INFO - 'XPC_SERVICE_NAME': '0', 15:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:55 INFO - Downloading/unpacking psutil>=0.7.1 15:15:55 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 15:15:55 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 15:15:55 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 15:15:55 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 15:15:55 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 15:15:55 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 15:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:15:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:58 INFO - Installing collected packages: psutil 15:15:58 INFO - Running setup.py install for psutil 15:15:58 INFO - building 'psutil._psutil_osx' extension 15:15:58 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 15:15:59 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 15:15:59 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 15:15:59 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 15:15:59 INFO - building 'psutil._psutil_posix' extension 15:15:59 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 15:15:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:15:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:15:59 INFO - ^ 15:15:59 INFO - 1 warning generated. 15:15:59 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 15:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:15:59 INFO - Successfully installed psutil 15:15:59 INFO - Cleaning up... 15:15:59 INFO - Return code: 0 15:15:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:15: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')]} 15:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15: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')]} 15:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:15:59 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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:15:59 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 15:15:59 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 15:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:15:59 INFO - 'HOME': '/Users/cltbld', 15:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:15:59 INFO - 'LOGNAME': 'cltbld', 15:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:59 INFO - 'MOZ_NO_REMOTE': '1', 15:15:59 INFO - 'NO_EM_RESTART': '1', 15:15:59 INFO - 'PAGER': '/bin/cat', 15:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:15:59 INFO - 'PWD': '/builds/slave/test', 15:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:15:59 INFO - 'SHELL': '/bin/bash', 15:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:15:59 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:15:59 INFO - 'USER': 'cltbld', 15:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:59 INFO - 'XPC_FLAGS': '0x0', 15:15:59 INFO - 'XPC_SERVICE_NAME': '0', 15:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:15:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:16:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:16:02 INFO - Installing collected packages: mozsystemmonitor 15:16:02 INFO - Running setup.py install for mozsystemmonitor 15:16:02 INFO - Successfully installed mozsystemmonitor 15:16:02 INFO - Cleaning up... 15:16:02 INFO - Return code: 0 15:16:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:02 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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:16:02 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 15:16:02 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 15:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:02 INFO - 'HOME': '/Users/cltbld', 15:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:02 INFO - 'LOGNAME': 'cltbld', 15:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:02 INFO - 'MOZ_NO_REMOTE': '1', 15:16:02 INFO - 'NO_EM_RESTART': '1', 15:16:02 INFO - 'PAGER': '/bin/cat', 15:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:02 INFO - 'PWD': '/builds/slave/test', 15:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:02 INFO - 'SHELL': '/bin/bash', 15:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:16:02 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:02 INFO - 'USER': 'cltbld', 15:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:02 INFO - 'XPC_FLAGS': '0x0', 15:16:02 INFO - 'XPC_SERVICE_NAME': '0', 15:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:02 INFO - Downloading/unpacking blobuploader==1.2.4 15:16:02 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 15:16:02 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 15:16:02 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 15:16:02 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 15:16:02 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 15:16:02 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 15:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:16:05 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 15:16:05 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 15:16:05 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 15:16:05 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 15:16:05 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 15:16:05 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 15:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:16:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 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 15:16:06 INFO - Downloading docopt-0.6.1.tar.gz 15:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:16:06 INFO - Running setup.py install for blobuploader 15:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:16:06 INFO - Running setup.py install for requests 15:16:07 INFO - Running setup.py install for docopt 15:16:07 INFO - Successfully installed blobuploader requests docopt 15:16:07 INFO - Cleaning up... 15:16:07 INFO - Return code: 0 15:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:07 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')]} 15:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:07 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')]} 15:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:07 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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:16:07 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 15:16:07 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 15:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:07 INFO - 'HOME': '/Users/cltbld', 15:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:07 INFO - 'LOGNAME': 'cltbld', 15:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:07 INFO - 'MOZ_NO_REMOTE': '1', 15:16:07 INFO - 'NO_EM_RESTART': '1', 15:16:07 INFO - 'PAGER': '/bin/cat', 15:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:07 INFO - 'PWD': '/builds/slave/test', 15:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:07 INFO - 'SHELL': '/bin/bash', 15:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:16:07 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:07 INFO - 'USER': 'cltbld', 15:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:07 INFO - 'XPC_FLAGS': '0x0', 15:16:07 INFO - 'XPC_SERVICE_NAME': '0', 15:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:07 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8r8a_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:07 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FwQEfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:07 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sowIjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-l_7x5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8BusPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-vFDOf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aHskdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-nZfvJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Z2waxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-NwC8g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-An0brJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-3Y0sDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:08 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-3SCrjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:09 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-X9XN3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:09 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-uzCBaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:09 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-KuP2Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:09 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hPSspE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:16:09 INFO - Running setup.py install for manifestparser 15:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:16:09 INFO - Running setup.py install for mozcrash 15:16:09 INFO - Running setup.py install for mozdebug 15:16:09 INFO - Running setup.py install for mozdevice 15:16:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Running setup.py install for mozfile 15:16:10 INFO - Running setup.py install for mozhttpd 15:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Running setup.py install for mozinfo 15:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Running setup.py install for mozInstall 15:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:16:10 INFO - Running setup.py install for mozleak 15:16:10 INFO - Running setup.py install for mozlog 15:16:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Running setup.py install for moznetwork 15:16:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Running setup.py install for mozprocess 15:16:11 INFO - Running setup.py install for mozprofile 15:16:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Running setup.py install for mozrunner 15:16:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:16:11 INFO - Running setup.py install for mozscreenshot 15:16:11 INFO - Running setup.py install for moztest 15:16:11 INFO - Running setup.py install for mozversion 15:16:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:16:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:16:12 INFO - Cleaning up... 15:16:12 INFO - Return code: 0 15:16:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:12 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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:16:12 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 15:16:12 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 15:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:12 INFO - 'HOME': '/Users/cltbld', 15:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:12 INFO - 'LOGNAME': 'cltbld', 15:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:12 INFO - 'MOZ_NO_REMOTE': '1', 15:16:12 INFO - 'NO_EM_RESTART': '1', 15:16:12 INFO - 'PAGER': '/bin/cat', 15:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:12 INFO - 'PWD': '/builds/slave/test', 15:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:12 INFO - 'SHELL': '/bin/bash', 15:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:16:12 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:12 INFO - 'USER': 'cltbld', 15:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:12 INFO - 'XPC_FLAGS': '0x0', 15:16:12 INFO - 'XPC_SERVICE_NAME': '0', 15:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:16:12 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8pu_SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:16:12 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)) 15:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:16:12 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-zRYyaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:16:12 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)) 15:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:16:12 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-kszQdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:16:12 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)) 15:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:16:12 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-N4hkt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:16:12 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)) 15:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:16:12 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ernZSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:16:12 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)) 15:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:16:12 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-UJUruo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-KElTEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-kYTCZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-98CPwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ZDxITq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sJB5xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CNuj8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-cXuief-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-9P_il4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:16:13 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)) 15:16:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:13 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hCRB57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:16:14 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4iZWY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:16:14 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)) 15:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:16:14 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-7VGzeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:16:14 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)) 15:16:14 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)) 15:16:14 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)) 15:16:14 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)) 15:16:14 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)) 15:16:14 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)) 15:16:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:16 INFO - Downloading blessings-1.6.tar.gz 15:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:16:17 INFO - Installing collected packages: blessings 15:16:17 INFO - Running setup.py install for blessings 15:16:17 INFO - Successfully installed blessings 15:16:17 INFO - Cleaning up... 15:16:17 INFO - Return code: 0 15:16:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:16:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:17 INFO - Reading from file tmpfile_stdout 15:16:17 INFO - Current package versions: 15:16:17 INFO - blessings == 1.6 15:16:17 INFO - blobuploader == 1.2.4 15:16:17 INFO - docopt == 0.6.1 15:16:17 INFO - manifestparser == 1.1 15:16:17 INFO - mozInstall == 1.12 15:16:17 INFO - mozcrash == 0.17 15:16:17 INFO - mozdebug == 0.1 15:16:17 INFO - mozdevice == 0.48 15:16:17 INFO - mozfile == 1.2 15:16:17 INFO - mozhttpd == 0.7 15:16:17 INFO - mozinfo == 0.9 15:16:17 INFO - mozleak == 0.1 15:16:17 INFO - mozlog == 3.1 15:16:17 INFO - moznetwork == 0.27 15:16:17 INFO - mozprocess == 0.22 15:16:17 INFO - mozprofile == 0.28 15:16:17 INFO - mozrunner == 6.11 15:16:17 INFO - mozscreenshot == 0.1 15:16:17 INFO - mozsystemmonitor == 0.0 15:16:17 INFO - moztest == 0.7 15:16:17 INFO - mozversion == 1.4 15:16:17 INFO - psutil == 3.1.1 15:16:17 INFO - requests == 1.2.3 15:16:17 INFO - wsgiref == 0.1.2 15:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:16:17 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')]} 15:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 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')]} 15:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:16:17 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 15:16:17 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 15:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:17 INFO - 'HOME': '/Users/cltbld', 15:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:17 INFO - 'LOGNAME': 'cltbld', 15:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:17 INFO - 'MOZ_NO_REMOTE': '1', 15:16:17 INFO - 'NO_EM_RESTART': '1', 15:16:17 INFO - 'PAGER': '/bin/cat', 15:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:17 INFO - 'PWD': '/builds/slave/test', 15:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:17 INFO - 'SHELL': '/bin/bash', 15:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:16:17 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:17 INFO - 'USER': 'cltbld', 15:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:17 INFO - 'XPC_FLAGS': '0x0', 15:16:17 INFO - 'XPC_SERVICE_NAME': '0', 15:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 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)) 15:16:17 INFO - Cleaning up... 15:16:17 INFO - Return code: 0 15:16:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:16:17 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')]} 15:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 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')]} 15:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16:17 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 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:16:17 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 15:16:17 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 15:16:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:16:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:17 INFO - 'HOME': '/Users/cltbld', 15:16:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:17 INFO - 'LOGNAME': 'cltbld', 15:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:17 INFO - 'MOZ_NO_REMOTE': '1', 15:16:17 INFO - 'NO_EM_RESTART': '1', 15:16:17 INFO - 'PAGER': '/bin/cat', 15:16:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:17 INFO - 'PWD': '/builds/slave/test', 15:16:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:17 INFO - 'SHELL': '/bin/bash', 15:16:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:16:17 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:16:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:17 INFO - 'USER': 'cltbld', 15:16:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:17 INFO - 'XPC_FLAGS': '0x0', 15:16:17 INFO - 'XPC_SERVICE_NAME': '0', 15:16:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:18 INFO - Downloading/unpacking jsonschema 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:16:20 INFO - Downloading/unpacking functools32 (from jsonschema) 15:16:20 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 15:16:20 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 15:16:20 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 15:16:20 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 15:16:20 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 15:16:20 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 15:16:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:16:21 INFO - warning: no files found matching '*.txt' 15:16:21 INFO - no previously-included directories found matching 'build' 15:16:21 INFO - no previously-included directories found matching 'dist' 15:16:21 INFO - no previously-included directories found matching '.git*' 15:16:21 INFO - Installing collected packages: jsonschema, functools32 15:16:21 INFO - Running setup.py install for functools32 15:16:21 INFO - warning: no files found matching '*.txt' 15:16:21 INFO - no previously-included directories found matching 'build' 15:16:21 INFO - no previously-included directories found matching 'dist' 15:16:21 INFO - no previously-included directories found matching '.git*' 15:16:21 INFO - Successfully installed jsonschema functools32 15:16:21 INFO - Cleaning up... 15:16:21 INFO - Return code: 0 15:16:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:16: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')]} 15:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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')]} 15:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:16: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe44420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa173469340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, '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.aEzhEZkkzz/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.dNQstA5xiV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 15:16: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', 'flake8'] in /builds/slave/test/build 15:16: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 flake8 15:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:16:21 INFO - 'HOME': '/Users/cltbld', 15:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:16:21 INFO - 'LOGNAME': 'cltbld', 15:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:21 INFO - 'MOZ_NO_REMOTE': '1', 15:16:21 INFO - 'NO_EM_RESTART': '1', 15:16:21 INFO - 'PAGER': '/bin/cat', 15:16:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:21 INFO - 'PWD': '/builds/slave/test', 15:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:16:21 INFO - 'SHELL': '/bin/bash', 15:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:16:21 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:16:21 INFO - 'USER': 'cltbld', 15:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:21 INFO - 'XPC_FLAGS': '0x0', 15:16:21 INFO - 'XPC_SERVICE_NAME': '0', 15:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:16:21 INFO - Downloading/unpacking flake8 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:16:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:16:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16: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 15:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:16:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:16:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:16:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:16:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:16:25 INFO - no previously-included directories found matching 'docs/_build' 15:16:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:16:25 INFO - Running setup.py install for pep8 15:16:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:16:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:16:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:16:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:16:26 INFO - no previously-included directories found matching 'docs/_build' 15:16:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:16:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:16:26 INFO - Cleaning up... 15:16:26 INFO - Return code: 0 15:16:26 INFO - Running post-action listener: _resource_record_post_action 15:16:26 INFO - Running post-action listener: _start_resource_monitoring 15:16:26 INFO - Starting resource monitoring. 15:16:26 INFO - ##### 15:16:26 INFO - ##### Running install step. 15:16:26 INFO - ##### 15:16:26 INFO - Running pre-action listener: _resource_record_pre_action 15:16:26 INFO - Running main action method: install 15:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:16:26 INFO - Reading from file tmpfile_stdout 15:16:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:16:26 INFO - Reading from file tmpfile_stdout 15:16:26 INFO - Output received: 15:16:26 INFO - Usage: mozinstall [options] installer 15:16:26 INFO - Options: 15:16:26 INFO - -h, --help show this help message and exit 15:16:26 INFO - -d DEST, --destination=DEST 15:16:26 INFO - Directory to install application into. [default: 15:16:26 INFO - "/builds/slave/test"] 15:16:26 INFO - --app=APP Application being installed. [default: firefox] 15:16:26 INFO - mkdir: /builds/slave/test/build/application 15:16:26 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'] 15:16:26 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 15:16:59 INFO - Reading from file tmpfile_stdout 15:16:59 INFO - Output received: 15:16:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:16:59 INFO - Running post-action listener: _resource_record_post_action 15:16:59 INFO - ##### 15:16:59 INFO - ##### Running run-tests step. 15:16:59 INFO - ##### 15:16:59 INFO - Running pre-action listener: _resource_record_pre_action 15:16:59 INFO - Running main action method: run_tests 15:16:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:59 INFO - 2016-04-10 15:16:59.818 screenresolution[1947:19362] starting screenresolution argv=screenresolution get 15:16:59 INFO - 2016-04-10 15:16:59.821 screenresolution[1947:19362] Display 0: 1600x1200x32@60 15:16:59 INFO - 2016-04-10 15:16:59.827 screenresolution[1948:19364] starting screenresolution argv=screenresolution list 15:16:59 INFO - Available Modes on Display 0 15:16:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:17:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:17:00 INFO - Intel Iris: 15:17:00 INFO - Chipset Model: Intel Iris 15:17:00 INFO - Type: GPU 15:17:00 INFO - Bus: Built-In 15:17:00 INFO - VRAM (Dynamic, Max): 1536 MB 15:17:00 INFO - Vendor: Intel (0x8086) 15:17:00 INFO - Device ID: 0x0a2e 15:17:00 INFO - Revision ID: 0x0009 15:17:00 INFO - Displays: 15:17:00 INFO - Display: 15:17:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:17:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:17:00 INFO - Display Serial Number: 1600x1200 60 15:17:00 INFO - Main Display: Yes 15:17:00 INFO - Mirror: Off 15:17:00 INFO - Online: Yes 15:17:00 INFO - Rotation: Supported 15:17:00 INFO - Return code: 0 15:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:17:00 INFO - Python 2.7.3 15:17:00 INFO - Return code: 0 15:17:00 INFO - grabbing minidump binary from tooltool 15:17:00 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')]} 15:17:00 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 0x10fcd3e00>, '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 0x10fafcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:17:00 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 15:17:00 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 15:17:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:17:00 INFO - Return code: 0 15:17:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:17:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:17:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:17:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:17:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:17:01 INFO - Return code: 0 15:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 15:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 15:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aEzhEZkkzz/Render', 15:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:01 INFO - 'HOME': '/Users/cltbld', 15:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:01 INFO - 'LOGNAME': 'cltbld', 15:17:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:17:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:01 INFO - 'MOZ_NO_REMOTE': '1', 15:17:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:17:01 INFO - 'NO_EM_RESTART': '1', 15:17:01 INFO - 'PAGER': '/bin/cat', 15:17:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:01 INFO - 'PWD': '/builds/slave/test', 15:17:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:01 INFO - 'SHELL': '/bin/bash', 15:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dNQstA5xiV/Listeners', 15:17:01 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 15:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:01 INFO - 'USER': 'cltbld', 15:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:01 INFO - 'XPC_FLAGS': '0x0', 15:17:01 INFO - 'XPC_SERVICE_NAME': '0', 15:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 15:17:01 INFO - mozversion application_buildid: 20160410132213 15:17:01 INFO - mozversion application_changeset: 29d5a4175c8b74f45482276a53985cf2568b4be2 15:17:01 INFO - mozversion application_display_name: Nightly 15:17:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:17:01 INFO - mozversion application_name: Firefox 15:17:01 INFO - mozversion application_remotingname: firefox 15:17:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:17:01 INFO - mozversion application_vendor: Mozilla 15:17:01 INFO - mozversion application_version: 48.0a1 15:17:01 INFO - mozversion platform_buildid: 20160410132213 15:17:01 INFO - mozversion platform_changeset: 29d5a4175c8b74f45482276a53985cf2568b4be2 15:17:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:17:01 INFO - mozversion platform_version: 48.0a1 15:17:01 INFO - using testdate: 1460326621 15:17:01 INFO - actual date: 1460326621 15:17:01 INFO - starting webserver on 'localhost:57338' 15:17:01 INFO - SUITE-START | Running 2 tests 15:17:01 INFO - TEST-START | dromaeo_css 15:17:01 INFO - operating with platform_type : mac_ 15:17:01 INFO - Initialising browser for dromaeo_css test... 15:17:01 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp4Xs_Fy/profile http://localhost:57338/getInfo.html) 15:17:03 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 15:17:03 INFO - PROCESS | 1966 | colorDepth:24 15:17:03 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 15:17:03 INFO - PROCESS | 1966 | __metrics 15:17:03 INFO - PROCESS | 1966 | 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" 15:17:03 ERROR - PROCESS | 1966 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:17:04 INFO - TEST-INFO | 1966: exit 0 15:17:04 INFO - Browser initialized. 15:17:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:17:04 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp4Xs_Fy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:16 INFO - PROCESS | 1968 | RSS: Main: 237592576 15:17:16 INFO - PROCESS | 1968 | 15:18:08 INFO - PROCESS | 1968 | 1460326688153 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] 15:20:18 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57338/tests/dromaeo/cssquery-ext.html) 15:20:20 INFO - PROCESS | 1968 | RSS: Main: 383102976 15:20:20 INFO - PROCESS | 1968 | 15:23:23 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57338/tests/dromaeo/cssquery-ext.html (next: http://localhost:57338/tests/dromaeo/cssquery-jquery.html) 15:23:24 INFO - PROCESS | 1968 | RSS: Main: 379355136 15:23:24 INFO - PROCESS | 1968 | 15:26:25 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57338/tests/dromaeo/cssquery-mootools.html) 15:26:26 INFO - PROCESS | 1968 | RSS: Main: 378630144 15:26:26 INFO - PROCESS | 1968 | 15:29:28 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57338/tests/dromaeo/cssquery-prototype.html) 15:29:29 INFO - PROCESS | 1968 | RSS: Main: 336404480 15:29:29 INFO - PROCESS | 1968 | 15:32:32 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57338/tests/dromaeo/cssquery-yui.html) 15:32:33 INFO - PROCESS | 1968 | RSS: Main: 342593536 15:32:33 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57338/tests/dromaeo/cssquery-yui.html (next: http://localhost:57338/tests/dromaeo/cssquery-dojo.html) 15:35:36 INFO - PROCESS | 1968 | RSS: Main: 385462272 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | __start_tp_report 15:35:36 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 15:35:36 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 15:35:36 INFO - PROCESS | 1968 | |i|pagename|runs| 15:35:36 INFO - PROCESS | 1968 | |0;dojo.html;3056.3428862794494;3351.765376423651;3354.547136136622;3386.4243078676623;3424.2124311408375;5591.776328946838;5652.971735141324;5655.066913959197;5667.178259152425;5667.886642267163;5614.550835933126;5661.60368774186;5665.23519324891;5668.971655141729;5676.432356764321;5143.53708166265;5153.458886816887;5187.195984622371;5204.271402003723;5247.763850626731;5219.138842091051;5231.816886408977;5233.084210263208;5233.65981211222;5242.580593552507;5143.305653736754;5187.533122019017;5213.009528189651;5223.503767142115;5273.789048438058;5196.740162991835;5243.187305967581;5248.475152484759;5250.9737451312885;5298.178782288752;5079.974600127012;5117.84646460603;5121.923171152398;5183.429822719498;5224.582033437354;5504.119340905436;5535;5545.223668686387;5556.749946252428;5560.471755183251;6103.725332360054;6115.449609535119;6115.724792384353;6116.755329786848;6121.4490695837585;6053.856250745797;6165.815025549241;6217.098520714516;6225.782097626607;6243.032329988859;5739.167820666064;5759.22250496186;5763.88472230553;5776.306843178803;5809.128630705386;6311.589746666452;6321.905171422432;6325.399087086811;6327.746890124344;6334.081558174039;5925.555583331267;6026.7890623828835;6062.878742425127;6090.23872015998;6101.60339577926;6210.50315974721;6249.875002499924;6250.874982500324;6258.9359808832605;6260.655663938436;6099.9085013724825;6144.754209831646;6167.290761562478;6167.629942203482;6201.0388389799655;6070.150178974947;6130.398136742002;6136.243373036893;6188.752449901954;6188.783392581238;4843.128236917389;4862.124817532878;4882.218844984856;4883.267509873547;4886.511348865085;3748.437734339871;4380.5838445347645;4401.009772801158;4423.60187583119;4483.708558943724;5697.145428185805;5710.771569137271;5718.685472299064;5727.885442291131;5745.540356771448;4615.838445654386;6140.504248697391;6238.376162383816;6240;6305.464035556937;5666.801661941895;5669.149627555899;5683.573731970118;5684.602077854511;5692.260006199168;5293.841184764463;5320.255164277004;5370.892582148414;5405.675659460445;5414.0254754144635;6244.2819075805955;6265.592736472115;6273.592216505913;6285.120083188357;6311.810645680545;5224.50367215114;6228.077594742127;6272.843178920563;6279.780207692709;6286.968565157145;5293.947060529345;6190.0405437157315;6199.225096862892;6232.439080482778;6307.779227727007;4974.552290293891;6167.969160154171;6171.876562468636;6182;6193.102000209854;6227.50179985591;6228.968855155696;6243.500519958302;6253.218347706536;6265.655388953652;5998.25021872266;6080.543959202989;6111.327753947151;6128.111423843607;6139.877202456015;6060.090986352083;6100.490342048369;6102.7619317136805;6110.103144028831;6131.468419844996;5939.287285525765;5942.821715348547;5949.52403807703;5970.31341395745;6000.5799594028;5977.731002104829;6058.12157237207;6111.358307377662;6113.083037544226;6122.998116460583;5788.044972579645;6001.4298641628975;6002.399760023963;6006.669633170218;6063.484603808725 15:35:36 INFO - PROCESS | 1968 | |1;ext.html;492.18788998153065;497.7461494637734;519.2159838643647;523.9659422137562;530.4456842599483;23993.52012959742;29568.112956611283;29577.40845183095;29686.703132968665;29698.70301296992;30979.535306970414;31504.369912601793;38461.807690961505;39867.202655946865;39896.40155397671;9385.671501497465;9614.326997110205;9618.182454491376;9632.855507167398;9637.518124093802;8332.166783321649;9657.32398732089;9775.071368220044;9790.461524616143;9831.410115393064;8606.78483037926;8847.292216622687;8876.511791851446;8882.333824963122;8896.154865287788;11315.83026254607;11702.414879256088;11719.12106592009;11721.35532545714;11728.35494047827;11297.983181513704;11435.542578296858;11460.197786154973;11474.54101835934;11490;27371;27453.588196177072;31678.891238806533;39678.60321396807;40312.79843600763;3173.587433633636;3200.8879689211;3329.916752081193;3434.158631135363;3556.6764635793315;27687.169384918485;27878.581821272695;28294.717052829415;28514.572281415796;29091.690873910724;2729.986350068237;2734.8769305381306;2799.230211691781;2844.7297506736827;2861;468293;469946;472316;473619;474269;34951.77668781581;35652;64867;65385;65484.345156547824;34884.47673284903;34915.65084349175;35001.1249718754;35027.299454010776;35075.473867892004;14572.854271457361;14762.261886905611;14768.261586920611;14768.852311476963;14787.630309242355;12445.377731113407;12552.937235313764;12577.05672074598;12584.307863067435;12599.18105323151;8110.675572977133;8128.674853005932;8139.226773456512;8195.672173113127;8212.58937053145;3158.510430883217;3266.9673303266663;3281.442154833684;3337.4493208620306;3409.16475463513;956.1872408452759;998.0219385002738;1019.5513973851481;1037.3412882819314;1055.9683209503728;25905.61141582878;28650.856745716137;28762.280942976595;29591.408171836443;29594.852025740165;914.5290175559592;1045.6876619842049;1123.1127409346689;1127.261643623428;1144.404909447083;15323.387064517294;15444.15057171844;15497.992630478982;15631.06213627186;15777.368905243662;573244;584027;585865;586489.135108652;586761;50924.490755091974;51272.48727512677;59316;61585.69207154025;61802.0729689055;1319.8416190057062;1445.2773613193403;1461.9342129604192;1474.5355213107837;1477.6232060824636;22189.556208876056;25576.10483633064;28279.858600706866;28448.146555603365;29152.854235728686;46717.065658687316;46745.06509869851;47362.52637473581;47416;47462.76268618635;332038;334864;592299.0385048047;629058;649970;25728.09951651758;26049;26116.34709132287;26198.60702089432;26227;43451.130977380904;43526.911827204574;43646.781766090964;44222.77888610536;44593.77703111464;36918.815405922796;37861.86414407572;37881.43177852279;38843.223135536566;39251.80374098226;37315.253694925406;37398.439023415216;37584.812075939444;38436;38603.42094868523;37378.8131059343;38005.61994380021;38076.42885356777;38527.6147238524;38565.843024709306;30150.698493015665;30798.384032319675;31308;33164.83417582897;33649.83175084109;19085.809141908405;19688.704669430255;24767.628485573092;24866.378340541632;24919.50160996806 15:35:36 INFO - PROCESS | 1968 | |2;jquery.html;394.28830960116994;397.4118304908735;400.44138426894466;404.20573572929186;410.49099117094795;19389.03054847259;19758;20443.795562044375;20455.386338409833;20531.486712832186;15769.84230157698;19596.31412900549;21541.24605638803;21650.24224152155;21733;5588.636738611987;6090.817275481742;6091.543134264925;6110.541709371815;6112.266528016622;5546.750396232179;5913.704314784243;6002.969985150068;6004.5796794224425;6009.699515024253;5944.256967879015;5955.404459554032;5967.970160149193;5970.34326224115;5972.343042265347;5583.832485025436;5856.238688970428;6439.452646525051;6442.613443193423;6451;5539.9169012464845;5763.8559036024435;6037.124616930564;6041.426064523863;6045.969770151121;13059.281739504324;13423.3959471824;13640.249786261751;13671.31643417835;13691;2055.969160462594;2079.9376018719463;2125.829933605308;2126.5215326551556;2168.046059733712;9329.72010839676;9638.277129215337;9660.37207581512;10114.241431892564;10294.124999375063;1574.4646820081114;1691.0699115486557;1741.738739189119;1751.9912400438043;1761.6124452620404;110153;113689.43155284254;114313;116926.41536792347;118401.99999999914;9182.67860624875;9782.41305521671;11585.6524304271;11733.88266117345;11746.941265293619;15244.618884527976;15244.771328430083;15275.007124536869;15287.770683439758;15306.234688265766;7168.784936451915;8405.915940840514;8568.143185681507;8659.13408659129;8687.174718401742;8364.038135614483;8368.079511253758;8371.665133394596;8501.829963400698;8508.787280318042;3750.1749615084636;4525.185466615975;4622.930656040095;4661.930071048937;4688.671792974459;1669.4540825241604;1900.477368723612;1963.626910886927;1967.4687834284948;1984.6526857799827;742.3801126059693;935.1723724503863;948.5209968965628;953.2135987809946;1022.8874823769379;19165.974050535187;20004.299849505198;20056.09747561363;20072.59854802925;20290.289839855534;879.5162660536679;901.2200903216095;966.6423423333412;976.2190247801872;1037.5071840875523;10291.53688084038;10510.947445262878;10524.315919465364;10534.525946332433;10565.260431769702;541814;608841;636670;656476.7176164088;658209;87746.56126719326;99828;125661;134601;135593;958.9232861371073;997.3543652972509;1015.6491865818443;1021.8569400283966;1059.8092343378112;14531;16054.277557510173;17053.403130890358;17634.1182940855;17800.821991779918;46967;47532.52467475419;48262;49209;49432.75283623559;65012;66479;66540.33459665341;67114.6644266795;67156.6642166786;6872.862542749217;6875.724971001104;8002;8164.7958801030445;8165.387595930448;9249.768755781159;10606.575736970435;12334.938325308316;12591.748165036832;12618.936905315415;9061.093890610886;9524.95237523808;10575.31260468098;11048.281861678965;11082.722931926766;10794.784104318027;10798.784024319313;11005.724856878642;11095.445227738743;11122.666320010412;10861.40262285582;11082.445877706245;11100.61147859821;11396.259243149168;11450.198486105892;6530.575512591667;8194.565950958679;8290.626921788655;8349.03986041613;8561.785955351166;8188.426810123234;10947.233693641369;10975.615853445091;11041.613543525938;11105.666829995112 15:35:36 INFO - PROCESS | 1968 | |3;mootools.html;1440.063958427023;1633.1344387474635;1646.2591833674846;1914.4639500939734;2026.0983862181336;7969.840603187933;8745.518996455192;8961.238294744955;8982.326325525579;8987.415817971836;8598.656053757843;8828.77928051799;8832;8835.646574137043;8859;2146.9355919322365;2223.210760180137;2230.119102954332;2455.472073504192;2490.2155820916355;2396.293093537402;2481.0447977528693;2484.44100077482;2484.838485498446;2485.5774518331837;2418.9274321770285;2453.4234454903085;2461.2247142150254;2461.913833015845;2468.839525430841;2080.854340196187;2209.9779002209934;2422.9273121806373;2434.2697190842678;2452.877356132195;2202;2230.386643672987;2387.6418537219556;2475.987620061906;2476.73994230605;8723.781905452352;8761.737147885573;8782.38523303369;8784.824303513959;8789.20897119256;5260.342457192851;5441.374241962186;5446.809361672362;5469.890602187974;5478.04134276504;3574.1422058705725;3617.1680513481783;3684.1158122050783;3697.334479793636;3701.9814900925594;1038.8441733739924;1063.4044934836515;1067.2209287220373;1077.3374374759467;1099.983500247497;11809.291442513391;11826.93557579822;11829.053675706009;11846.703832404173;11853.703657408547;4742.312364707098;4827.541383568555;4880.463149053601;4987.750612469435;4996.800127994912;10121.291509594257;10149.49252537385;10167.796644067077;10183.54174062169;10192.1336686381;5508.980838544882;5513.035218836688;5539.196816461671;5557.138643510181;5562.3881373048935;4261.701680882308;4311.590398912098;4625.098105869391;5028.723420211851;5081.923771143436;3696.1868388954385;4017.598240175959;4030.6170913763144;4145.233131870614;4153.190127925026;1249.4002878618132;1353.5465619017739;1357.8642135786342;1373.3133433283358;1373.7183877305129;1355.396848402471;1374.9381277842522;1376.2980879751399;1390.478570536049;1416.5679467762432;8149.388795840217;8285.751427457066;8374.832503349899;8381.916180838236;8383.95808020956;507.64972169203133;516.4964159944025;522.568880673446;525.7818005527663;527.0302643136647;6312.5581209314905;6321.1150438938585;6461.935380646133;6473.126127972663;6474.093626892239;10508.684739457829;10825.566977320976;10962.561497540168;10963.013328800445;10988.945055274673;8823.55882205887;10799.352038877536;10860.511276992554;10866.076383507332;10990.560377584967;8184.468009579358;8306.70926517569;8363.16368363171;8379.874301885477;8402.831943361221;7994.120646728739;8403.495790252604;8406.537640429835;8414.957925210334;8416.36877234222;9525.714228573153;9813.362131461432;9920.801583968425;10001.5499302533;10100.595976160872;10031.228920478794;10154.187664986635;10243.129334006693;10445.582176712845;10459.738506537398;7369.263073692588;7420.703171873065;7654.73208437702;7664.041994750656;7667.539947603162;8376.288015518505;8401.411901166859;8431.747047588582;8458.619362128842;8463.915360846313;7239.4932354734665;7459.104907411145;7582.431317651309;7601.315881570686;7670.8082297943;7342.486025978344;7445.478816482794;7446.553206807609;7598.658060387185;7610.581418022062;6767.255601883888;7876.291133797986;7910.802229944297;7965.1238363778775;7967.083785364757;7001.614911179934;7080.327368899946;7145.999560061699;7175.712971481083;7196.10048743907;6289.9307117791;7182.461315401261;7223.783286501413;7298.379637730853;7313.414926805949 15:35:36 INFO - PROCESS | 1968 | |4;prototype.html;322.29256781364904;322.6112534396053;329.63739886125256;330.5818140052832;334.43313583476004;5841.269841269841;5863.853403664911;5867.88264234715;5893.764249430028;5897.793577224798;4779.928301075487;4970.8318545141865;5678.517326027292;5824.271966004249;5830.475257226849;3694.704423646115;4207.179599978005;4335.739855608658;4379.299312110063;4452;3601.657842504971;4362.563743625644;4374.60628543431;4391.231534481469;4394.846180383687;4319.632831209336;4338.240807858628;4357.847475338363;4362.214801335758;4382.970002049516;4014.9360419488567;4169.437125987998;4201.075763332077;4438.467383913919;4465.151621191995;3544.113971507123;3785.432185172246;3834.789086600236;3846.076941534012;3846.1346197105427;4846.491118432549;5577.525910297589;5599.7480113394995;5609;5626.127950167731;4426.911461770746;5084;5084.644074914758;5103.642745007851;5150.4334523202415;6016.969915150396;6103.481204097613;6104.511639068864;6106.786262480836;6115.205023346936;3793.487879136309;4051.9870032491876;4242.384854196124;4245.596668316505;4275.187714334266;6051.334353221142;6398.520110991694;6536.281009088996;6548.574342667759;6571.34286571339;3751.6060813614176;4228.344606585984;4358.65130789536;4363.956360436355;4424.13729322779;3772.7359084864347;4289.1850548395705;4439.64482841372;4448.777561121931;4480.596746292784;4551.658625603093;5039.924401133986;5124.769385377667;5136.614753893473;5144.945286216317;6173.96913015441;6225.439710425992;6262.436380725665;6269.96865015672;6296.43332100104;1360.3674291454522;1423.6298562373856;1515.5756388211319;1516.4540765324475;1541.129261966985;957.9521023948774;983.695054533097;1002.7944271424341;1032.5818043692316;1033.245730616639;4993.926305844261;5786.363500014995;5798.536117110621;5858.062709966385;5879.735411906475;5704.885902282014;6446.419822215929;6470.5147113965695;6495.967520162463;6498.155239818793;5544;5803.622764520293;5832.9708351457975;5854.18041474194;5870.647761134345;2911.7233862783;2914.804929978741;3327.334533093391;3387.47494138404;3410.4031794435873;5437.782488700487;5660.782931669711;6369.5222858285815;6625.4037136657935;6683.532152749358;5254.789808407697;6600.570962887397;6602.3067577904585;6655.334466553306;6768.2216545097945;6041.728122234422;6538.574992625464;6684.2647308795995;6696.196456425066;6744.494162937701;4759.929015971379;5374;5550.58370622213;5720.170575266647;6400.9039864403;5935.821925342247;6347.650879201504;6376.234851817811;6383.776567820104;6396.584222025554;5262.342207224097;5865.885481758452;6275.341089185752;6390.52071094679;6774.796756097325;3744.6255374462335;4178.707490475637;4211.55778643238;4214;4237.3220284755525;6210.5652604317265;6393.328700486568;6413.8396540085005;6454.257760357619;6454.774082907075;5948.524118070631;6233.812985610439;6258.12386265914;6283.497320214463;6317.6841157941;5712.80005199816;6080.69596520181;6177.7837775677635;6196.47329976957;6201.3178550358525;5273.578113750814;5344;5655.1517272409465;6077.726502307319;6078.57449978515;5396.78412863481;5736.1453063588615;6021.458068773832;6235.376462353728;6243.625382476885;5776.884462310814;6104.412852658252;6109.969450152721;6111.816645500642;6113.663748493876 15:35:36 INFO - PROCESS | 1968 | |5;yui.html;681.3118750062441;696.742205384008;708.0759608710631;748.0425055928412;808.9271965523103;14389.64025899353;14735.115893046424;14747.41010359587;14798.26008699566;14820;13745.725085498285;13781.724365512684;13782.379792909318;13794.862051379509;13821.723565528684;897.2507955856851;919.2002957427048;926.3839546701436;926.8053708721177;930.8836395450569;576.8327185116311;718.7699936020449;731.7146312937932;901.923336516397;911.1890417528405;969.1955676788284;981.906718861707;984.1339621133393;984.4290311619279;988.332875309167;960.9807803843919;978.8580655804868;979.1334668818076;979.603260679426;981.3326937682373;577.137179916024;707.4234498883394;725.2638571849524;734.4198083514018;736.3225832234357;14848.851511484854;14903.925480372529;14911.32899019536;14915.552533424014;14928.10431374121;10201.744956376077;12227.755444891052;12250.81623775644;12642.115051946368;13180.077394582384;9746.325770064577;9777.706668799947;9858.309918305722;9913.355631883904;10242.180625549938;3037.9848100759577;3485.268093700326;3544.3974524330924;3551.058969373092;3585.1933315004176;77428;78825;78909;79265;79446.6027669858;9327.673531426368;9379.193796908423;9388.155066044088;9663.90336096644;9756.658516951873;20674.793252067586;20689.379318620464;20722;20743.1702731889;21293.935303234775;7394.408447324201;7493.100827900686;7521.9247807522315;7562.659680314399;7576.886346704804;3962.247262528697;4021.3364794809113;4054.716169868081;4091.9590804091577;4369.300911854088;3521.8239088045493;3642.0894776305922;3644.781313121221;3645.2709458108484;3645.3985092459448;662.8906230471919;664.139938779282;665.1751827733575;670.963097029668;677.069030083635;533.8451848963757;551.0329371952279;593.7061154728437;613.622622087413;615.1203778596561;7609.695612175562;7687.308142267111;7982.560959147187;8042.919570804217;8083.811493749966;526.494565217388;569.0979797021685;577.4168090228815;587.759018802289;592.5674257791836;3723.906902327409;3746.4942232798767;3808.5810560838286;3841.5006049213425;3863.7923659262215;86435.56782216174;86965.56517217374;88207;88402;88892.5555372219;56805.44375503112;68131;74976.87534686984;75010;75993;65342.99999999905;65889;66332.00501992473;67688;67837.66081169562;7353.0441042664115;7397.408207343292;7572.129205141479;7587.962060189884;7808.687652493837;38631.42052869265;39565;39645.41418343234;39968;41835.7908210457;41595.58404415917;55688.72155639196;57377.42622573721;57666.7116664414;59015;10398.324108932895;10733.463326833471;10841.891581084088;10872.782544349227;11262.873712628672;11956.402179890796;12002.819957700467;12061.51753929833;12142.696432589257;12456.501739930301;11065.668029959113;11163.72090697739;11180.329180249211;11256.662300131009;11582.247153934968;11232.606858759904;11507.194496385173;11568.710782230512;11648.88351116478;11676.007539359249;9131.315151363542;11383.918527739852;11389.373584452604;11851.466683999413;11864.644060678194;9606.183474404474;9638.132568068908;9754.853677194706;9921.801563968536;10004;9263.397879137834;9483.810323793623;9505.239580833655;9517.143457088896;9968.601255949681 15:35:36 INFO - PROCESS | 1968 | __end_tp_report 15:35:36 INFO - PROCESS | 1968 | __start_cc_report 15:35:36 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1402 15:35:36 INFO - PROCESS | 1968 | __end_cc_report 15:35:36 INFO - PROCESS | 1968 | __startTimestamp1460327736291__endTimestamp 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | ------- Summary: start ------- 15:35:36 INFO - PROCESS | 1968 | Number of tests: 6 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | [#0] dojo.html Cycles:165 Average:5689.28 Median:5942.82 stddev:654.26 (11.0%) stddev-sans-first:622.81 15:35:36 INFO - PROCESS | 1968 | Values: 3056.3 3351.8 3354.5 3386.4 3424.2 5591.8 5653.0 5655.1 5667.2 5667.9 5614.6 5661.6 5665.2 5669.0 5676.4 5143.5 5153.5 5187.2 5204.3 5247.8 5219.1 5231.8 5233.1 5233.7 5242.6 5143.3 5187.5 5213.0 5223.5 5273.8 5196.7 5243.2 5248.5 5251.0 5298.2 5080.0 5117.8 5121.9 5183.4 5224.6 5504.1 5535.0 5545.2 5556.7 5560.5 6103.7 6115.4 6115.7 6116.8 6121.4 6053.9 6165.8 6217.1 6225.8 6243.0 5739.2 5759.2 5763.9 5776.3 5809.1 6311.6 6321.9 6325.4 6327.7 6334.1 5925.6 6026.8 6062.9 6090.2 6101.6 6210.5 6249.9 6250.9 6258.9 6260.7 6099.9 6144.8 6167.3 6167.6 6201.0 6070.2 6130.4 6136.2 6188.8 6188.8 4843.1 4862.1 4882.2 4883.3 4886.5 3748.4 4380.6 4401.0 4423.6 4483.7 5697.1 5710.8 5718.7 5727.9 5745.5 4615.8 6140.5 6238.4 6240.0 6305.5 5666.8 5669.1 5683.6 5684.6 5692.3 5293.8 5320.3 5370.9 5405.7 5414.0 6244.3 6265.6 6273.6 6285.1 6311.8 5224.5 6228.1 6272.8 6279.8 6287.0 5293.9 6190.0 6199.2 6232.4 6307.8 4974.6 6168.0 6171.9 6182.0 6193.1 6227.5 6229.0 6243.5 6253.2 6265.7 5998.3 6080.5 6111.3 6128.1 6139.9 6060.1 6100.5 6102.8 6110.1 6131.5 5939.3 5942.8 5949.5 5970.3 6000.6 5977.7 6058.1 6111.4 6113.1 6123.0 5788.0 6001.4 6002.4 6006.7 6063.5 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | [#1] ext.html Cycles:180 Average:63621.97 Median:18529.50 stddev:141855.50 (765.6%) stddev-sans-first:142174.25 15:35:36 INFO - PROCESS | 1968 | Values: 492.2 497.7 519.2 524.0 530.4 23993.5 29568.1 29577.4 29686.7 29698.7 30979.5 31504.4 38461.8 39867.2 39896.4 9385.7 9614.3 9618.2 9632.9 9637.5 8332.2 9657.3 9775.1 9790.5 9831.4 8606.8 8847.3 8876.5 8882.3 8896.2 11315.8 11702.4 11719.1 11721.4 11728.4 11298.0 11435.5 11460.2 11474.5 11490.0 27371.0 27453.6 31678.9 39678.6 40312.8 3173.6 3200.9 3329.9 3434.2 3556.7 27687.2 27878.6 28294.7 28514.6 29091.7 2730.0 2734.9 2799.2 2844.7 2861.0 468293.0 469946.0 472316.0 473619.0 474269.0 34951.8 35652.0 64867.0 65385.0 65484.3 34884.5 34915.7 35001.1 35027.3 35075.5 14572.9 14762.3 14768.3 14768.9 14787.6 12445.4 12552.9 12577.1 12584.3 12599.2 8110.7 8128.7 8139.2 8195.7 8212.6 3158.5 3267.0 3281.4 3337.4 3409.2 956.2 998.0 1019.6 1037.3 1056.0 25905.6 28650.9 28762.3 29591.4 29594.9 914.5 1045.7 1123.1 1127.3 1144.4 15323.4 15444.2 15498.0 15631.1 15777.4 573244.0 584027.0 585865.0 586489.1 586761.0 50924.5 51272.5 59316.0 61585.7 61802.1 1319.8 1445.3 1461.9 1474.5 1477.6 22189.6 25576.1 28279.9 28448.1 29152.9 46717.1 46745.1 47362.5 47416.0 47462.8 332038.0 334864.0 592299.0 629058.0 649970.0 25728.1 26049.0 26116.3 26198.6 26227.0 43451.1 43526.9 43646.8 44222.8 44593.8 36918.8 37861.9 37881.4 38843.2 39251.8 37315.3 37398.4 37584.8 38436.0 38603.4 37378.8 38005.6 38076.4 38527.6 38565.8 30150.7 30798.4 31308.0 33164.8 33649.8 19085.8 19688.7 24767.6 24866.4 24919.5 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | [#2] jquery.html Cycles:180 Average:34252.73 Median:395.85 stddev:103260.40 (26085.7%) stddev-sans-first:103518.78 15:35:36 INFO - PROCESS | 1968 | Values: 394.3 397.4 400.4 404.2 410.5 19389.0 19758.0 20443.8 20455.4 20531.5 15769.8 19596.3 21541.2 21650.2 21733.0 5588.6 6090.8 6091.5 6110.5 6112.3 5546.8 5913.7 6003.0 6004.6 6009.7 5944.3 5955.4 5968.0 5970.3 5972.3 5583.8 5856.2 6439.5 6442.6 6451.0 5539.9 5763.9 6037.1 6041.4 6046.0 13059.3 13423.4 13640.2 13671.3 13691.0 2056.0 2079.9 2125.8 2126.5 2168.0 9329.7 9638.3 9660.4 10114.2 10294.1 1574.5 1691.1 1741.7 1752.0 1761.6 110153.0 113689.4 114313.0 116926.4 118402.0 9182.7 9782.4 11585.7 11733.9 11746.9 15244.6 15244.8 15275.0 15287.8 15306.2 7168.8 8405.9 8568.1 8659.1 8687.2 8364.0 8368.1 8371.7 8501.8 8508.8 3750.2 4525.2 4622.9 4661.9 4688.7 1669.5 1900.5 1963.6 1967.5 1984.7 742.4 935.2 948.5 953.2 1022.9 19166.0 20004.3 20056.1 20072.6 20290.3 879.5 901.2 966.6 976.2 1037.5 10291.5 10510.9 10524.3 10534.5 10565.3 541814.0 608841.0 636670.0 656476.7 658209.0 87746.6 99828.0 125661.0 134601.0 135593.0 958.9 997.4 1015.6 1021.9 1059.8 14531.0 16054.3 17053.4 17634.1 17800.8 46967.0 47532.5 48262.0 49209.0 49432.8 65012.0 66479.0 66540.3 67114.7 67156.7 6872.9 6875.7 8002.0 8164.8 8165.4 9249.8 10606.6 12334.9 12591.7 12618.9 9061.1 9525.0 10575.3 11048.3 11082.7 10794.8 10798.8 11005.7 11095.4 11122.7 10861.4 11082.4 11100.6 11396.3 11450.2 6530.6 8194.6 8290.6 8349.0 8561.8 8188.4 10947.2 10975.6 11041.6 11105.7 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | [#3] mootools.html Cycles:180 Average:6113.78 Median:2794.79 stddev:3261.13 (116.7%) stddev-sans-first:3251.35 15:35:36 INFO - PROCESS | 1968 | Values: 1440.1 1633.1 1646.3 1914.5 2026.1 7969.8 8745.5 8961.2 8982.3 8987.4 8598.7 8828.8 8832.0 8835.6 8859.0 2146.9 2223.2 2230.1 2455.5 2490.2 2396.3 2481.0 2484.4 2484.8 2485.6 2418.9 2453.4 2461.2 2461.9 2468.8 2080.9 2210.0 2422.9 2434.3 2452.9 2202.0 2230.4 2387.6 2476.0 2476.7 8723.8 8761.7 8782.4 8784.8 8789.2 5260.3 5441.4 5446.8 5469.9 5478.0 3574.1 3617.2 3684.1 3697.3 3702.0 1038.8 1063.4 1067.2 1077.3 1100.0 11809.3 11826.9 11829.1 11846.7 11853.7 4742.3 4827.5 4880.5 4987.8 4996.8 10121.3 10149.5 10167.8 10183.5 10192.1 5509.0 5513.0 5539.2 5557.1 5562.4 4261.7 4311.6 4625.1 5028.7 5081.9 3696.2 4017.6 4030.6 4145.2 4153.2 1249.4 1353.5 1357.9 1373.3 1373.7 1355.4 1374.9 1376.3 1390.5 1416.6 8149.4 8285.8 8374.8 8381.9 8384.0 507.6 516.5 522.6 525.8 527.0 6312.6 6321.1 6461.9 6473.1 6474.1 10508.7 10825.6 10962.6 10963.0 10988.9 8823.6 10799.4 10860.5 10866.1 10990.6 8184.5 8306.7 8363.2 8379.9 8402.8 7994.1 8403.5 8406.5 8415.0 8416.4 9525.7 9813.4 9920.8 10001.5 10100.6 10031.2 10154.2 10243.1 10445.6 10459.7 7369.3 7420.7 7654.7 7664.0 7667.5 8376.3 8401.4 8431.7 8458.6 8463.9 7239.5 7459.1 7582.4 7601.3 7670.8 7342.5 7445.5 7446.6 7598.7 7610.6 6767.3 7876.3 7910.8 7965.1 7967.1 7001.6 7080.3 7146.0 7175.7 7196.1 6289.9 7182.5 7223.8 7298.4 7313.4 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | [#4] prototype.html Cycles:180 Average:5004.34 Median:5640.64 stddev:1559.30 (27.6%) stddev-sans-first:1523.56 15:35:36 INFO - PROCESS | 1968 | Values: 322.3 322.6 329.6 330.6 334.4 5841.3 5863.9 5867.9 5893.8 5897.8 4779.9 4970.8 5678.5 5824.3 5830.5 3694.7 4207.2 4335.7 4379.3 4452.0 3601.7 4362.6 4374.6 4391.2 4394.8 4319.6 4338.2 4357.8 4362.2 4383.0 4014.9 4169.4 4201.1 4438.5 4465.2 3544.1 3785.4 3834.8 3846.1 3846.1 4846.5 5577.5 5599.7 5609.0 5626.1 4426.9 5084.0 5084.6 5103.6 5150.4 6017.0 6103.5 6104.5 6106.8 6115.2 3793.5 4052.0 4242.4 4245.6 4275.2 6051.3 6398.5 6536.3 6548.6 6571.3 3751.6 4228.3 4358.7 4364.0 4424.1 3772.7 4289.2 4439.6 4448.8 4480.6 4551.7 5039.9 5124.8 5136.6 5144.9 6174.0 6225.4 6262.4 6270.0 6296.4 1360.4 1423.6 1515.6 1516.5 1541.1 958.0 983.7 1002.8 1032.6 1033.2 4993.9 5786.4 5798.5 5858.1 5879.7 5704.9 6446.4 6470.5 6496.0 6498.2 5544.0 5803.6 5833.0 5854.2 5870.6 2911.7 2914.8 3327.3 3387.5 3410.4 5437.8 5660.8 6369.5 6625.4 6683.5 5254.8 6600.6 6602.3 6655.3 6768.2 6041.7 6538.6 6684.3 6696.2 6744.5 4759.9 5374.0 5550.6 5720.2 6400.9 5935.8 6347.7 6376.2 6383.8 6396.6 5262.3 5865.9 6275.3 6390.5 6774.8 3744.6 4178.7 4211.6 4214.0 4237.3 6210.6 6393.3 6413.8 6454.3 6454.8 5948.5 6233.8 6258.1 6283.5 6317.7 5712.8 6080.7 6177.8 6196.5 6201.3 5273.6 5344.0 5655.2 6077.7 6078.6 5396.8 5736.1 6021.5 6235.4 6243.6 5776.9 6104.4 6110.0 6111.8 6113.7 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - PROCESS | 1968 | [#5] yui.html Cycles:180 Average:17062.14 Median:593.14 stddev:23577.77 (3975.1%) stddev-sans-first:23611.83 15:35:36 INFO - PROCESS | 1968 | Values: 681.3 696.7 708.1 748.0 808.9 14389.6 14735.1 14747.4 14798.3 14820.0 13745.7 13781.7 13782.4 13794.9 13821.7 897.3 919.2 926.4 926.8 930.9 576.8 718.8 731.7 901.9 911.2 969.2 981.9 984.1 984.4 988.3 961.0 978.9 979.1 979.6 981.3 577.1 707.4 725.3 734.4 736.3 14848.9 14903.9 14911.3 14915.6 14928.1 10201.7 12227.8 12250.8 12642.1 13180.1 9746.3 9777.7 9858.3 9913.4 10242.2 3038.0 3485.3 3544.4 3551.1 3585.2 77428.0 78825.0 78909.0 79265.0 79446.6 9327.7 9379.2 9388.2 9663.9 9756.7 20674.8 20689.4 20722.0 20743.2 21293.9 7394.4 7493.1 7521.9 7562.7 7576.9 3962.2 4021.3 4054.7 4092.0 4369.3 3521.8 3642.1 3644.8 3645.3 3645.4 662.9 664.1 665.2 671.0 677.1 533.8 551.0 593.7 613.6 615.1 7609.7 7687.3 7982.6 8042.9 8083.8 526.5 569.1 577.4 587.8 592.6 3723.9 3746.5 3808.6 3841.5 3863.8 86435.6 86965.6 88207.0 88402.0 88892.6 56805.4 68131.0 74976.9 75010.0 75993.0 65343.0 65889.0 66332.0 67688.0 67837.7 7353.0 7397.4 7572.1 7588.0 7808.7 38631.4 39565.0 39645.4 39968.0 41835.8 41595.6 55688.7 57377.4 57666.7 59015.0 10398.3 10733.5 10841.9 10872.8 11262.9 11956.4 12002.8 12061.5 12142.7 12456.5 11065.7 11163.7 11180.3 11256.7 11582.2 11232.6 11507.2 11568.7 11648.9 11676.0 9131.3 11383.9 11389.4 11851.5 11864.6 9606.2 9638.1 9754.9 9921.8 10004.0 9263.4 9483.8 9505.2 9517.1 9968.6 15:35:36 INFO - PROCESS | 1968 | -------- Summary: end -------- 15:35:36 INFO - PROCESS | 1968 | 15:35:36 INFO - TEST-INFO | 1968: exit 0 15:35:36 INFO - TEST-OK | dromaeo_css | took 1115254ms 15:35:36 INFO - TEST-START | kraken 15:35:36 INFO - operating with platform_type : mac_ 15:35:36 INFO - Initialising browser for kraken test... 15:35:36 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpm_UWAu/profile http://localhost:57338/getInfo.html) 15:35:39 INFO - PROCESS | 1972 | __metrics Screen width/height:1600/1200 15:35:39 INFO - PROCESS | 1972 | colorDepth:24 15:35:39 INFO - PROCESS | 1972 | Browser inner width/height: 1024/689 15:35:39 INFO - PROCESS | 1972 | __metrics 15:35:39 INFO - PROCESS | 1972 | 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" 15:35:39 ERROR - PROCESS | 1972 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:35:39 INFO - TEST-INFO | 1972: exit 0 15:35:39 INFO - Browser initialized. 15:35:39 INFO - Running cycle 1/1 for kraken test... 15:35:39 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpm_UWAu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:51 INFO - PROCESS | 1974 | RSS: Main: 237785088 15:35:51 INFO - PROCESS | 1974 | 15:35:54 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57338/tests/kraken/driver.html?testName=audio-beat-detection) 15:35:55 INFO - PROCESS | 1974 | RSS: Main: 286674944 15:35:55 INFO - PROCESS | 1974 | 15:35:58 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57338/tests/kraken/driver.html?testName=audio-dft) 15:35:58 INFO - PROCESS | 1974 | RSS: Main: 299401216 15:35:58 INFO - PROCESS | 1974 | 15:36:02 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57338/tests/kraken/driver.html?testName=audio-fft) 15:36:02 INFO - PROCESS | 1974 | RSS: Main: 384241664 15:36:02 INFO - PROCESS | 1974 | 15:36:04 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57338/tests/kraken/driver.html?testName=audio-oscillator) 15:36:05 INFO - PROCESS | 1974 | RSS: Main: 286646272 15:36:05 INFO - PROCESS | 1974 | 15:36:07 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:36:08 INFO - PROCESS | 1974 | RSS: Main: 290611200 15:36:08 INFO - PROCESS | 1974 | 15:36:11 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57338/tests/kraken/driver.html?testName=imaging-darkroom) 15:36:11 INFO - PROCESS | 1974 | RSS: Main: 328822784 15:36:11 INFO - PROCESS | 1974 | 15:36:14 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57338/tests/kraken/driver.html?testName=imaging-desaturate) 15:36:15 INFO - PROCESS | 1974 | RSS: Main: 330199040 15:36:15 INFO - PROCESS | 1974 | 15:36:17 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57338/tests/kraken/driver.html?testName=json-parse-financial) 15:36:18 INFO - PROCESS | 1974 | RSS: Main: 326406144 15:36:18 INFO - PROCESS | 1974 | 15:36:20 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:36:20 INFO - PROCESS | 1974 | RSS: Main: 320139264 15:36:20 INFO - PROCESS | 1974 | 15:36:22 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:36:23 INFO - PROCESS | 1974 | RSS: Main: 326987776 15:36:23 INFO - PROCESS | 1974 | 15:36:25 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:36:25 INFO - PROCESS | 1974 | RSS: Main: 330227712 15:36:25 INFO - PROCESS | 1974 | 15:36:28 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:36:29 INFO - PROCESS | 1974 | RSS: Main: 334643200 15:36:29 INFO - PROCESS | 1974 | 15:36:32 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:36:32 INFO - PROCESS | 1974 | RSS: Main: 332554240 15:36:32 INFO - PROCESS | 1974 | 15:36:34 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:57338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57338/tests/kraken/driver.html?testName=ai-astar) 15:36:35 INFO - PROCESS | 1974 | RSS: Main: 396607488 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | __start_tp_report 15:36:35 INFO - PROCESS | 1974 | _x_x_mozilla_page_load 15:36:35 INFO - PROCESS | 1974 | _x_x_mozilla_page_load_details 15:36:35 INFO - PROCESS | 1974 | |i|pagename|runs| 15:36:35 INFO - PROCESS | 1974 | |0;ai-astar;115;149;163;112;112;112;117;114;143;165 15:36:35 INFO - PROCESS | 1974 | |1;audio-beat-detection;181;148;147;194;148;144;142;118;169;120 15:36:35 INFO - PROCESS | 1974 | |2;audio-dft;188;189;188;204;188;185;182;183;177;185 15:36:35 INFO - PROCESS | 1974 | |3;audio-fft;78;71;84;92;56;59;58;79;86;56 15:36:35 INFO - PROCESS | 1974 | |4;audio-oscillator;91;132;179;105;80;80;125;79;78;129 15:36:35 INFO - PROCESS | 1974 | |5;imaging-gaussian-blur;88;85;87;84;132;87;87;84;86;83 15:36:35 INFO - PROCESS | 1974 | |6;imaging-darkroom;93;92;93;94;92;93;93;93;92;92 15:36:35 INFO - PROCESS | 1974 | |7;imaging-desaturate;88;87;86;85;86;86;85;86;87;85 15:36:35 INFO - PROCESS | 1974 | |8;json-parse-financial;55;56;54;53;53;54;54;68;54;54 15:36:35 INFO - PROCESS | 1974 | |9;json-stringify-tinderbox;66;74;63;73;70;66;68;69;67;69 15:36:35 INFO - PROCESS | 1974 | |10;stanford-crypto-aes;84;84;85;84;86;85;84;86;83;84 15:36:35 INFO - PROCESS | 1974 | |11;stanford-crypto-ccm;149;141;130;156;159;141;140;144;198;166 15:36:35 INFO - PROCESS | 1974 | |12;stanford-crypto-pbkdf2;161;150;197;203;179;168;169;169;167;165 15:36:35 INFO - PROCESS | 1974 | |13;stanford-crypto-sha256-iterative;68;71;85;96;95;99;69;68;70;70 15:36:35 INFO - PROCESS | 1974 | __end_tp_report 15:36:35 INFO - PROCESS | 1974 | __start_cc_report 15:36:35 INFO - PROCESS | 1974 | _x_x_mozilla_cycle_collect,1915 15:36:35 INFO - PROCESS | 1974 | __end_cc_report 15:36:35 INFO - PROCESS | 1974 | __startTimestamp1460327795090__endTimestamp 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | ------- Summary: start ------- 15:36:35 INFO - PROCESS | 1974 | Number of tests: 14 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#0] ai-astar Cycles:10 Average:130.20 Median:130.00 stddev:22.28 (17.1%) stddev-sans-first:22.94 15:36:35 INFO - PROCESS | 1974 | Values: 115.0 149.0 163.0 112.0 112.0 112.0 117.0 114.0 143.0 165.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:148.00 stddev:24.24 (16.4%) stddev-sans-first:23.17 15:36:35 INFO - PROCESS | 1974 | Values: 181.0 148.0 147.0 194.0 148.0 144.0 142.0 118.0 169.0 120.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#2] audio-dft Cycles:10 Average:186.90 Median:188.00 stddev:7.03 (3.7%) stddev-sans-first:7.45 15:36:35 INFO - PROCESS | 1974 | Values: 188.0 189.0 188.0 204.0 188.0 185.0 182.0 183.0 177.0 185.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#3] audio-fft Cycles:10 Average:71.90 Median:78.50 stddev:13.76 (17.5%) stddev-sans-first:14.41 15:36:35 INFO - PROCESS | 1974 | Values: 78.0 71.0 84.0 92.0 56.0 59.0 58.0 79.0 86.0 56.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:78.50 stddev:33.26 (42.4%) stddev-sans-first:34.71 15:36:35 INFO - PROCESS | 1974 | Values: 91.0 132.0 179.0 105.0 80.0 80.0 125.0 79.0 78.0 129.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:86.50 stddev:14.74 (17.0%) stddev-sans-first:15.61 15:36:35 INFO - PROCESS | 1974 | Values: 88.0 85.0 87.0 84.0 132.0 87.0 87.0 84.0 86.0 83.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:36:35 INFO - PROCESS | 1974 | Values: 93.0 92.0 93.0 94.0 92.0 93.0 93.0 93.0 92.0 92.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:0.99 (1.2%) stddev-sans-first:0.78 15:36:35 INFO - PROCESS | 1974 | Values: 88.0 87.0 86.0 85.0 86.0 86.0 85.0 86.0 87.0 85.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:4.48 (8.3%) stddev-sans-first:4.75 15:36:35 INFO - PROCESS | 1974 | Values: 55.0 56.0 54.0 53.0 53.0 54.0 54.0 68.0 54.0 54.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.31 (4.8%) stddev-sans-first:3.38 15:36:35 INFO - PROCESS | 1974 | Values: 66.0 74.0 63.0 73.0 70.0 66.0 68.0 69.0 67.0 69.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 15:36:35 INFO - PROCESS | 1974 | Values: 84.0 84.0 85.0 84.0 86.0 85.0 84.0 86.0 83.0 84.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:152.50 stddev:19.20 (12.6%) stddev-sans-first:20.33 15:36:35 INFO - PROCESS | 1974 | Values: 149.0 141.0 130.0 156.0 159.0 141.0 140.0 144.0 198.0 166.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:169.00 stddev:16.13 (9.5%) stddev-sans-first:16.53 15:36:35 INFO - PROCESS | 1974 | Values: 161.0 150.0 197.0 203.0 179.0 168.0 169.0 169.0 167.0 165.0 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - PROCESS | 1974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:78.00 stddev:13.12 (16.8%) stddev-sans-first:13.29 15:36:35 INFO - PROCESS | 1974 | Values: 68.0 71.0 85.0 96.0 95.0 99.0 69.0 68.0 70.0 70.0 15:36:35 INFO - PROCESS | 1974 | -------- Summary: end -------- 15:36:35 INFO - PROCESS | 1974 | 15:36:35 INFO - TEST-INFO | 1974: exit 0 15:36:35 INFO - TEST-OK | kraken | took 59099ms 15:36:35 INFO - SUITE-END | took 1174s 15:36:36 INFO - Completed test suite (00:19:34) 15:36:36 INFO - javascript benchmark 15:36:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.3428862794494, 3351.765376423651, 3354.547136136622, 3386.4243078676623, 3424.2124311408375, 5591.776328946838, 5652.971735141324, 5655.066913959197, 5667.178259152425, 5667.886642267163, 5614.550835933126, 5661.60368774186, 5665.23519324891, 5668.971655141729, 5676.432356764321, 5143.53708166265, 5153.458886816887, 5187.195984622371, 5204.271402003723, 5247.763850626731, 5219.138842091051, 5231.816886408977, 5233.084210263208, 5233.65981211222, 5242.580593552507, 5143.305653736754, 5187.533122019017, 5213.009528189651, 5223.503767142115, 5273.789048438058, 5196.740162991835, 5243.187305967581, 5248.475152484759, 5250.9737451312885, 5298.178782288752, 5079.974600127012, 5117.84646460603, 5121.923171152398, 5183.429822719498, 5224.582033437354, 5504.119340905436, 5535.0, 5545.223668686387, 5556.749946252428, 5560.471755183251, 6103.725332360054, 6115.449609535119, 6115.724792384353, 6116.755329786848, 6121.4490695837585, 6053.856250745797, 6165.815025549241, 6217.098520714516, 6225.782097626607, 6243.032329988859, 5739.167820666064, 5759.22250496186, 5763.88472230553, 5776.306843178803, 5809.128630705386, 6311.589746666452, 6321.905171422432, 6325.399087086811, 6327.746890124344, 6334.081558174039, 5925.555583331267, 6026.7890623828835, 6062.878742425127, 6090.23872015998, 6101.60339577926, 6210.50315974721, 6249.875002499924, 6250.874982500324, 6258.9359808832605, 6260.655663938436, 6099.9085013724825, 6144.754209831646, 6167.290761562478, 6167.629942203482, 6201.0388389799655, 6070.150178974947, 6130.398136742002, 6136.243373036893, 6188.752449901954, 6188.783392581238, 4843.128236917389, 4862.124817532878, 4882.218844984856, 4883.267509873547, 4886.511348865085, 3748.437734339871, 4380.5838445347645, 4401.009772801158, 4423.60187583119, 4483.708558943724, 5697.145428185805, 5710.771569137271, 5718.685472299064, 5727.885442291131, 5745.540356771448, 4615.838445654386, 6140.504248697391, 6238.376162383816, 6240.0, 6305.464035556937, 5666.801661941895, 5669.149627555899, 5683.573731970118, 5684.602077854511, 5692.260006199168, 5293.841184764463, 5320.255164277004, 5370.892582148414, 5405.675659460445, 5414.0254754144635, 6244.2819075805955, 6265.592736472115, 6273.592216505913, 6285.120083188357, 6311.810645680545, 5224.50367215114, 6228.077594742127, 6272.843178920563, 6279.780207692709, 6286.968565157145, 5293.947060529345, 6190.0405437157315, 6199.225096862892, 6232.439080482778, 6307.779227727007, 4974.552290293891, 6167.969160154171, 6171.876562468636, 6182.0, 6193.102000209854, 6227.50179985591, 6228.968855155696, 6243.500519958302, 6253.218347706536, 6265.655388953652, 5998.25021872266, 6080.543959202989, 6111.327753947151, 6128.111423843607, 6139.877202456015, 6060.090986352083, 6100.490342048369, 6102.7619317136805, 6110.103144028831, 6131.468419844996, 5939.287285525765, 5942.821715348547, 5949.52403807703, 5970.31341395745, 6000.5799594028, 5977.731002104829, 6058.12157237207, 6111.358307377662, 6113.083037544226, 6122.998116460583, 5788.044972579645, 6001.4298641628975, 6002.399760023963, 6006.669633170218, 6063.484603808725], "value": 5647.826902880243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.18788998153065, 497.7461494637734, 519.2159838643647, 523.9659422137562, 530.4456842599483, 23993.52012959742, 29568.112956611283, 29577.40845183095, 29686.703132968665, 29698.70301296992, 30979.535306970414, 31504.369912601793, 38461.807690961505, 39867.202655946865, 39896.40155397671, 9385.671501497465, 9614.326997110205, 9618.182454491376, 9632.855507167398, 9637.518124093802, 8332.166783321649, 9657.32398732089, 9775.071368220044, 9790.461524616143, 9831.410115393064, 8606.78483037926, 8847.292216622687, 8876.511791851446, 8882.333824963122, 8896.154865287788, 11315.83026254607, 11702.414879256088, 11719.12106592009, 11721.35532545714, 11728.35494047827, 11297.983181513704, 11435.542578296858, 11460.197786154973, 11474.54101835934, 11490.0, 27371.0, 27453.588196177072, 31678.891238806533, 39678.60321396807, 40312.79843600763, 3173.587433633636, 3200.8879689211, 3329.916752081193, 3434.158631135363, 3556.6764635793315, 27687.169384918485, 27878.581821272695, 28294.717052829415, 28514.572281415796, 29091.690873910724, 2729.986350068237, 2734.8769305381306, 2799.230211691781, 2844.7297506736827, 2861.0, 468293.0, 469946.0, 472316.0, 473619.0, 474269.0, 34951.77668781581, 35652.0, 64867.0, 65385.0, 65484.345156547824, 34884.47673284903, 34915.65084349175, 35001.1249718754, 35027.299454010776, 35075.473867892004, 14572.854271457361, 14762.261886905611, 14768.261586920611, 14768.852311476963, 14787.630309242355, 12445.377731113407, 12552.937235313764, 12577.05672074598, 12584.307863067435, 12599.18105323151, 8110.675572977133, 8128.674853005932, 8139.226773456512, 8195.672173113127, 8212.58937053145, 3158.510430883217, 3266.9673303266663, 3281.442154833684, 3337.4493208620306, 3409.16475463513, 956.1872408452759, 998.0219385002738, 1019.5513973851481, 1037.3412882819314, 1055.9683209503728, 25905.61141582878, 28650.856745716137, 28762.280942976595, 29591.408171836443, 29594.852025740165, 914.5290175559592, 1045.6876619842049, 1123.1127409346689, 1127.261643623428, 1144.404909447083, 15323.387064517294, 15444.15057171844, 15497.992630478982, 15631.06213627186, 15777.368905243662, 573244.0, 584027.0, 585865.0, 586489.135108652, 586761.0, 50924.490755091974, 51272.48727512677, 59316.0, 61585.69207154025, 61802.0729689055, 1319.8416190057062, 1445.2773613193403, 1461.9342129604192, 1474.5355213107837, 1477.6232060824636, 22189.556208876056, 25576.10483633064, 28279.858600706866, 28448.146555603365, 29152.854235728686, 46717.065658687316, 46745.06509869851, 47362.52637473581, 47416.0, 47462.76268618635, 332038.0, 334864.0, 592299.0385048047, 629058.0, 649970.0, 25728.09951651758, 26049.0, 26116.34709132287, 26198.60702089432, 26227.0, 43451.130977380904, 43526.911827204574, 43646.781766090964, 44222.77888610536, 44593.77703111464, 36918.815405922796, 37861.86414407572, 37881.43177852279, 38843.223135536566, 39251.80374098226, 37315.253694925406, 37398.439023415216, 37584.812075939444, 38436.0, 38603.42094868523, 37378.8131059343, 38005.61994380021, 38076.42885356777, 38527.6147238524, 38565.843024709306, 30150.698493015665, 30798.384032319675, 31308.0, 33164.83417582897, 33649.83175084109, 19085.809141908405, 19688.704669430255, 24767.628485573092, 24866.378340541632, 24919.50160996806], "value": 17965.361626214817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.28830960116994, 397.4118304908735, 400.44138426894466, 404.20573572929186, 410.49099117094795, 19389.03054847259, 19758.0, 20443.795562044375, 20455.386338409833, 20531.486712832186, 15769.84230157698, 19596.31412900549, 21541.24605638803, 21650.24224152155, 21733.0, 5588.636738611987, 6090.817275481742, 6091.543134264925, 6110.541709371815, 6112.266528016622, 5546.750396232179, 5913.704314784243, 6002.969985150068, 6004.5796794224425, 6009.699515024253, 5944.256967879015, 5955.404459554032, 5967.970160149193, 5970.34326224115, 5972.343042265347, 5583.832485025436, 5856.238688970428, 6439.452646525051, 6442.613443193423, 6451.0, 5539.9169012464845, 5763.8559036024435, 6037.124616930564, 6041.426064523863, 6045.969770151121, 13059.281739504324, 13423.3959471824, 13640.249786261751, 13671.31643417835, 13691.0, 2055.969160462594, 2079.9376018719463, 2125.829933605308, 2126.5215326551556, 2168.046059733712, 9329.72010839676, 9638.277129215337, 9660.37207581512, 10114.241431892564, 10294.124999375063, 1574.4646820081114, 1691.0699115486557, 1741.738739189119, 1751.9912400438043, 1761.6124452620404, 110153.0, 113689.43155284254, 114313.0, 116926.41536792347, 118401.99999999914, 9182.67860624875, 9782.41305521671, 11585.6524304271, 11733.88266117345, 11746.941265293619, 15244.618884527976, 15244.771328430083, 15275.007124536869, 15287.770683439758, 15306.234688265766, 7168.784936451915, 8405.915940840514, 8568.143185681507, 8659.13408659129, 8687.174718401742, 8364.038135614483, 8368.079511253758, 8371.665133394596, 8501.829963400698, 8508.787280318042, 3750.1749615084636, 4525.185466615975, 4622.930656040095, 4661.930071048937, 4688.671792974459, 1669.4540825241604, 1900.477368723612, 1963.626910886927, 1967.4687834284948, 1984.6526857799827, 742.3801126059693, 935.1723724503863, 948.5209968965628, 953.2135987809946, 1022.8874823769379, 19165.974050535187, 20004.299849505198, 20056.09747561363, 20072.59854802925, 20290.289839855534, 879.5162660536679, 901.2200903216095, 966.6423423333412, 976.2190247801872, 1037.5071840875523, 10291.53688084038, 10510.947445262878, 10524.315919465364, 10534.525946332433, 10565.260431769702, 541814.0, 608841.0, 636670.0, 656476.7176164088, 658209.0, 87746.56126719326, 99828.0, 125661.0, 134601.0, 135593.0, 958.9232861371073, 997.3543652972509, 1015.6491865818443, 1021.8569400283966, 1059.8092343378112, 14531.0, 16054.277557510173, 17053.403130890358, 17634.1182940855, 17800.821991779918, 46967.0, 47532.52467475419, 48262.0, 49209.0, 49432.75283623559, 65012.0, 66479.0, 66540.33459665341, 67114.6644266795, 67156.6642166786, 6872.862542749217, 6875.724971001104, 8002.0, 8164.7958801030445, 8165.387595930448, 9249.768755781159, 10606.575736970435, 12334.938325308316, 12591.748165036832, 12618.936905315415, 9061.093890610886, 9524.95237523808, 10575.31260468098, 11048.281861678965, 11082.722931926766, 10794.784104318027, 10798.784024319313, 11005.724856878642, 11095.445227738743, 11122.666320010412, 10861.40262285582, 11082.445877706245, 11100.61147859821, 11396.259243149168, 11450.198486105892, 6530.575512591667, 8194.565950958679, 8290.626921788655, 8349.03986041613, 8561.785955351166, 8188.426810123234, 10947.233693641369, 10975.615853445091, 11041.613543525938, 11105.666829995112], "value": 9165.163427391039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.063958427023, 1633.1344387474635, 1646.2591833674846, 1914.4639500939734, 2026.0983862181336, 7969.840603187933, 8745.518996455192, 8961.238294744955, 8982.326325525579, 8987.415817971836, 8598.656053757843, 8828.77928051799, 8832.0, 8835.646574137043, 8859.0, 2146.9355919322365, 2223.210760180137, 2230.119102954332, 2455.472073504192, 2490.2155820916355, 2396.293093537402, 2481.0447977528693, 2484.44100077482, 2484.838485498446, 2485.5774518331837, 2418.9274321770285, 2453.4234454903085, 2461.2247142150254, 2461.913833015845, 2468.839525430841, 2080.854340196187, 2209.9779002209934, 2422.9273121806373, 2434.2697190842678, 2452.877356132195, 2202.0, 2230.386643672987, 2387.6418537219556, 2475.987620061906, 2476.73994230605, 8723.781905452352, 8761.737147885573, 8782.38523303369, 8784.824303513959, 8789.20897119256, 5260.342457192851, 5441.374241962186, 5446.809361672362, 5469.890602187974, 5478.04134276504, 3574.1422058705725, 3617.1680513481783, 3684.1158122050783, 3697.334479793636, 3701.9814900925594, 1038.8441733739924, 1063.4044934836515, 1067.2209287220373, 1077.3374374759467, 1099.983500247497, 11809.291442513391, 11826.93557579822, 11829.053675706009, 11846.703832404173, 11853.703657408547, 4742.312364707098, 4827.541383568555, 4880.463149053601, 4987.750612469435, 4996.800127994912, 10121.291509594257, 10149.49252537385, 10167.796644067077, 10183.54174062169, 10192.1336686381, 5508.980838544882, 5513.035218836688, 5539.196816461671, 5557.138643510181, 5562.3881373048935, 4261.701680882308, 4311.590398912098, 4625.098105869391, 5028.723420211851, 5081.923771143436, 3696.1868388954385, 4017.598240175959, 4030.6170913763144, 4145.233131870614, 4153.190127925026, 1249.4002878618132, 1353.5465619017739, 1357.8642135786342, 1373.3133433283358, 1373.7183877305129, 1355.396848402471, 1374.9381277842522, 1376.2980879751399, 1390.478570536049, 1416.5679467762432, 8149.388795840217, 8285.751427457066, 8374.832503349899, 8381.916180838236, 8383.95808020956, 507.64972169203133, 516.4964159944025, 522.568880673446, 525.7818005527663, 527.0302643136647, 6312.5581209314905, 6321.1150438938585, 6461.935380646133, 6473.126127972663, 6474.093626892239, 10508.684739457829, 10825.566977320976, 10962.561497540168, 10963.013328800445, 10988.945055274673, 8823.55882205887, 10799.352038877536, 10860.511276992554, 10866.076383507332, 10990.560377584967, 8184.468009579358, 8306.70926517569, 8363.16368363171, 8379.874301885477, 8402.831943361221, 7994.120646728739, 8403.495790252604, 8406.537640429835, 8414.957925210334, 8416.36877234222, 9525.714228573153, 9813.362131461432, 9920.801583968425, 10001.5499302533, 10100.595976160872, 10031.228920478794, 10154.187664986635, 10243.129334006693, 10445.582176712845, 10459.738506537398, 7369.263073692588, 7420.703171873065, 7654.73208437702, 7664.041994750656, 7667.539947603162, 8376.288015518505, 8401.411901166859, 8431.747047588582, 8458.619362128842, 8463.915360846313, 7239.4932354734665, 7459.104907411145, 7582.431317651309, 7601.315881570686, 7670.8082297943, 7342.486025978344, 7445.478816482794, 7446.553206807609, 7598.658060387185, 7610.581418022062, 6767.255601883888, 7876.291133797986, 7910.802229944297, 7965.1238363778775, 7967.083785364757, 7001.614911179934, 7080.327368899946, 7145.999560061699, 7175.712971481083, 7196.10048743907, 6289.9307117791, 7182.461315401261, 7223.783286501413, 7298.379637730853, 7313.414926805949], "value": 4890.00901268099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.29256781364904, 322.6112534396053, 329.63739886125256, 330.5818140052832, 334.43313583476004, 5841.269841269841, 5863.853403664911, 5867.88264234715, 5893.764249430028, 5897.793577224798, 4779.928301075487, 4970.8318545141865, 5678.517326027292, 5824.271966004249, 5830.475257226849, 3694.704423646115, 4207.179599978005, 4335.739855608658, 4379.299312110063, 4452.0, 3601.657842504971, 4362.563743625644, 4374.60628543431, 4391.231534481469, 4394.846180383687, 4319.632831209336, 4338.240807858628, 4357.847475338363, 4362.214801335758, 4382.970002049516, 4014.9360419488567, 4169.437125987998, 4201.075763332077, 4438.467383913919, 4465.151621191995, 3544.113971507123, 3785.432185172246, 3834.789086600236, 3846.076941534012, 3846.1346197105427, 4846.491118432549, 5577.525910297589, 5599.7480113394995, 5609.0, 5626.127950167731, 4426.911461770746, 5084.0, 5084.644074914758, 5103.642745007851, 5150.4334523202415, 6016.969915150396, 6103.481204097613, 6104.511639068864, 6106.786262480836, 6115.205023346936, 3793.487879136309, 4051.9870032491876, 4242.384854196124, 4245.596668316505, 4275.187714334266, 6051.334353221142, 6398.520110991694, 6536.281009088996, 6548.574342667759, 6571.34286571339, 3751.6060813614176, 4228.344606585984, 4358.65130789536, 4363.956360436355, 4424.13729322779, 3772.7359084864347, 4289.1850548395705, 4439.64482841372, 4448.777561121931, 4480.596746292784, 4551.658625603093, 5039.924401133986, 5124.769385377667, 5136.614753893473, 5144.945286216317, 6173.96913015441, 6225.439710425992, 6262.436380725665, 6269.96865015672, 6296.43332100104, 1360.3674291454522, 1423.6298562373856, 1515.5756388211319, 1516.4540765324475, 1541.129261966985, 957.9521023948774, 983.695054533097, 1002.7944271424341, 1032.5818043692316, 1033.245730616639, 4993.926305844261, 5786.363500014995, 5798.536117110621, 5858.062709966385, 5879.735411906475, 5704.885902282014, 6446.419822215929, 6470.5147113965695, 6495.967520162463, 6498.155239818793, 5544.0, 5803.622764520293, 5832.9708351457975, 5854.18041474194, 5870.647761134345, 2911.7233862783, 2914.804929978741, 3327.334533093391, 3387.47494138404, 3410.4031794435873, 5437.782488700487, 5660.782931669711, 6369.5222858285815, 6625.4037136657935, 6683.532152749358, 5254.789808407697, 6600.570962887397, 6602.3067577904585, 6655.334466553306, 6768.2216545097945, 6041.728122234422, 6538.574992625464, 6684.2647308795995, 6696.196456425066, 6744.494162937701, 4759.929015971379, 5374.0, 5550.58370622213, 5720.170575266647, 6400.9039864403, 5935.821925342247, 6347.650879201504, 6376.234851817811, 6383.776567820104, 6396.584222025554, 5262.342207224097, 5865.885481758452, 6275.341089185752, 6390.52071094679, 6774.796756097325, 3744.6255374462335, 4178.707490475637, 4211.55778643238, 4214.0, 4237.3220284755525, 6210.5652604317265, 6393.328700486568, 6413.8396540085005, 6454.257760357619, 6454.774082907075, 5948.524118070631, 6233.812985610439, 6258.12386265914, 6283.497320214463, 6317.6841157941, 5712.80005199816, 6080.69596520181, 6177.7837775677635, 6196.47329976957, 6201.3178550358525, 5273.578113750814, 5344.0, 5655.1517272409465, 6077.726502307319, 6078.57449978515, 5396.78412863481, 5736.1453063588615, 6021.458068773832, 6235.376462353728, 6243.625382476885, 5776.884462310814, 6104.412852658252, 6109.969450152721, 6111.816645500642, 6113.663748493876], "value": 4507.081381510161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.3118750062441, 696.742205384008, 708.0759608710631, 748.0425055928412, 808.9271965523103, 14389.64025899353, 14735.115893046424, 14747.41010359587, 14798.26008699566, 14820.0, 13745.725085498285, 13781.724365512684, 13782.379792909318, 13794.862051379509, 13821.723565528684, 897.2507955856851, 919.2002957427048, 926.3839546701436, 926.8053708721177, 930.8836395450569, 576.8327185116311, 718.7699936020449, 731.7146312937932, 901.923336516397, 911.1890417528405, 969.1955676788284, 981.906718861707, 984.1339621133393, 984.4290311619279, 988.332875309167, 960.9807803843919, 978.8580655804868, 979.1334668818076, 979.603260679426, 981.3326937682373, 577.137179916024, 707.4234498883394, 725.2638571849524, 734.4198083514018, 736.3225832234357, 14848.851511484854, 14903.925480372529, 14911.32899019536, 14915.552533424014, 14928.10431374121, 10201.744956376077, 12227.755444891052, 12250.81623775644, 12642.115051946368, 13180.077394582384, 9746.325770064577, 9777.706668799947, 9858.309918305722, 9913.355631883904, 10242.180625549938, 3037.9848100759577, 3485.268093700326, 3544.3974524330924, 3551.058969373092, 3585.1933315004176, 77428.0, 78825.0, 78909.0, 79265.0, 79446.6027669858, 9327.673531426368, 9379.193796908423, 9388.155066044088, 9663.90336096644, 9756.658516951873, 20674.793252067586, 20689.379318620464, 20722.0, 20743.1702731889, 21293.935303234775, 7394.408447324201, 7493.100827900686, 7521.9247807522315, 7562.659680314399, 7576.886346704804, 3962.247262528697, 4021.3364794809113, 4054.716169868081, 4091.9590804091577, 4369.300911854088, 3521.8239088045493, 3642.0894776305922, 3644.781313121221, 3645.2709458108484, 3645.3985092459448, 662.8906230471919, 664.139938779282, 665.1751827733575, 670.963097029668, 677.069030083635, 533.8451848963757, 551.0329371952279, 593.7061154728437, 613.622622087413, 615.1203778596561, 7609.695612175562, 7687.308142267111, 7982.560959147187, 8042.919570804217, 8083.811493749966, 526.494565217388, 569.0979797021685, 577.4168090228815, 587.759018802289, 592.5674257791836, 3723.906902327409, 3746.4942232798767, 3808.5810560838286, 3841.5006049213425, 3863.7923659262215, 86435.56782216174, 86965.56517217374, 88207.0, 88402.0, 88892.5555372219, 56805.44375503112, 68131.0, 74976.87534686984, 75010.0, 75993.0, 65342.99999999905, 65889.0, 66332.00501992473, 67688.0, 67837.66081169562, 7353.0441042664115, 7397.408207343292, 7572.129205141479, 7587.962060189884, 7808.687652493837, 38631.42052869265, 39565.0, 39645.41418343234, 39968.0, 41835.7908210457, 41595.58404415917, 55688.72155639196, 57377.42622573721, 57666.7116664414, 59015.0, 10398.324108932895, 10733.463326833471, 10841.891581084088, 10872.782544349227, 11262.873712628672, 11956.402179890796, 12002.819957700467, 12061.51753929833, 12142.696432589257, 12456.501739930301, 11065.668029959113, 11163.72090697739, 11180.329180249211, 11256.662300131009, 11582.247153934968, 11232.606858759904, 11507.194496385173, 11568.710782230512, 11648.88351116478, 11676.007539359249, 9131.315151363542, 11383.918527739852, 11389.373584452604, 11851.466683999413, 11864.644060678194, 9606.183474404474, 9638.132568068908, 9754.853677194706, 9921.801563968536, 10004.0, 9263.397879137834, 9483.810323793623, 9505.239580833655, 9517.143457088896, 9968.601255949681], "value": 6713.919007811904, "unit": "score"}], "name": "dromaeo_css", "value": 7185.313594018629, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 149.0, 163.0, 112.0, 112.0, 112.0, 117.0, 114.0, 143.0, 165.0], "value": 130.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 148.0, 147.0, 194.0, 148.0, 144.0, 142.0, 118.0, 169.0, 120.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 189.0, 188.0, 204.0, 188.0, 185.0, 182.0, 183.0, 177.0, 185.0], "value": 186.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 84.0, 92.0, 56.0, 59.0, 58.0, 79.0, 86.0, 56.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 132.0, 179.0, 105.0, 80.0, 80.0, 125.0, 79.0, 78.0, 129.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 84.0, 132.0, 87.0, 87.0, 84.0, 86.0, 83.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 92.0, 92.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 85.0, 86.0, 86.0, 85.0, 86.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 53.0, 53.0, 54.0, 54.0, 68.0, 54.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 63.0, 73.0, 70.0, 66.0, 68.0, 69.0, 67.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 86.0, 85.0, 84.0, 86.0, 83.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 141.0, 130.0, 156.0, 159.0, 141.0, 140.0, 144.0, 198.0, 166.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 150.0, 197.0, 203.0, 179.0, 168.0, 169.0, 169.0, 167.0, 165.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 85.0, 96.0, 95.0, 99.0, 69.0, 68.0, 70.0, 70.0], "value": 79.1, "unit": "score"}], "name": "kraken", "value": 1529.8, "alertThreshold": 2.0}]} 15:36:36 INFO - Return code: 0 15:36:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:36:36 ERROR - # TBPL SUCCESS # 15:36:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:36:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:36:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:36:36 INFO - 2016-04-10 15:36:36.408 screenresolution[1978:21386] starting screenresolution argv=screenresolution get 15:36:36 INFO - 2016-04-10 15:36:36.411 screenresolution[1978:21386] Display 0: 1600x1200x32@60 15:36:36 INFO - 2016-04-10 15:36:36.417 screenresolution[1979:21389] starting screenresolution argv=screenresolution list 15:36:36 INFO - Available Modes on Display 0 15:36:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:36:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:36:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:36:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:36:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:36:36 INFO - Intel Iris: 15:36:36 INFO - Chipset Model: Intel Iris 15:36:36 INFO - Type: GPU 15:36:36 INFO - Bus: Built-In 15:36:36 INFO - VRAM (Dynamic, Max): 1536 MB 15:36:36 INFO - Vendor: Intel (0x8086) 15:36:36 INFO - Device ID: 0x0a2e 15:36:36 INFO - Revision ID: 0x0009 15:36:36 INFO - Displays: 15:36:36 INFO - Display: 15:36:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:36:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:36:36 INFO - Display Serial Number: 1600x1200 60 15:36:36 INFO - Main Display: Yes 15:36:36 INFO - Mirror: Off 15:36:36 INFO - Online: Yes 15:36:36 INFO - Rotation: Supported 15:36:36 INFO - Return code: 0 15:36:36 INFO - Running post-action listener: _resource_record_post_action 15:36:36 INFO - Running post-run listener: _resource_record_post_run 15:36:37 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 102400; Write bytes: 692955648; Read time: 3; Write time: 1823 15:36:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381383168; Write bytes: 375989760; Read time: 28179; Write time: 647 15:36:37 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 98304; Write bytes: 297391104; Read time: 2; Write time: 1138 15:36:37 INFO - Running post-run listener: _upload_blobber_files 15:36:37 INFO - Blob upload gear active. 15:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:36:37 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 15:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:36:38 INFO - (blobuploader) - INFO - Open directory for files ... 15:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:39 INFO - (blobuploader) - INFO - Done attempting. 15:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:36:40 INFO - (blobuploader) - INFO - Done attempting. 15:36:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:36:40 INFO - Return code: 0 15:36:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:36:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:36:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9a7addb2c64860da2ed30145d275bc71e10bb774e342eeeccbd2e90761e3fbcdad9e4af069623abb013dba379162c16b93b961e87b053b363a6d874044c1564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1ccf9d2ebb862e22d0b6b98c3250c89e7a5732d7f206bcc3063e231176b0fde804dda159a043372519156b0c7de9ad24f3db7cb5febfc0305f060f2fa264524"} 15:36:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:36:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:36:40 INFO - Contents: 15:36:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9a7addb2c64860da2ed30145d275bc71e10bb774e342eeeccbd2e90761e3fbcdad9e4af069623abb013dba379162c16b93b961e87b053b363a6d874044c1564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1ccf9d2ebb862e22d0b6b98c3250c89e7a5732d7f206bcc3063e231176b0fde804dda159a043372519156b0c7de9ad24f3db7cb5febfc0305f060f2fa264524"} 15:36:40 INFO - Running post-run listener: copy_logs_to_upload_dir 15:36:40 INFO - Copying logs to upload dir... 15:36:40 INFO - mkdir: /builds/slave/test/build/upload/logs 15:36:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.158090 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-10 15:36:40.454371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 15:36:40.462105) ========= 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.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9a7addb2c64860da2ed30145d275bc71e10bb774e342eeeccbd2e90761e3fbcdad9e4af069623abb013dba379162c16b93b961e87b053b363a6d874044c1564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1ccf9d2ebb862e22d0b6b98c3250c89e7a5732d7f206bcc3063e231176b0fde804dda159a043372519156b0c7de9ad24f3db7cb5febfc0305f060f2fa264524"} build_url:https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/XRaaKUZDR_GGM17P9oEeYQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9a7addb2c64860da2ed30145d275bc71e10bb774e342eeeccbd2e90761e3fbcdad9e4af069623abb013dba379162c16b93b961e87b053b363a6d874044c1564", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1ccf9d2ebb862e22d0b6b98c3250c89e7a5732d7f206bcc3063e231176b0fde804dda159a043372519156b0c7de9ad24f3db7cb5febfc0305f060f2fa264524"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 15:36:40.493324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:36:40.493615) ========= 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.aEzhEZkkzz/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.dNQstA5xiV/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005035 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 15:36:40.545550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 15:36:40.548891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 15:36:40.549311) ========= ========= Total master_lag: 1.50 =========