builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0161 starttime: 1458356234.1 results: success (0) buildid: 20160318185337 builduid: b5461c6a45f84c89bbbbaf72ac8beffa revision: ad73190dcc495cfd527d0733df5bbc88fc90cd16 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:14.098727) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:14.099105) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2016-03-18 19:57:14.099384) ========= 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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005396 basedir: '/builds/slave/test' ========= master_lag: 3.57 ========= ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2016-03-18 19:57:17.670425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.670760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.714343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.714698) ========= 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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005395 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.764274) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.764664) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.765063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.765405) ========= 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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-18 19:57:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.6M=0.001s 2016-03-18 19:57:17 (17.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.941327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.944683) ========= 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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.026485 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:17.994848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 19:57:17.995193) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad73190dcc495cfd527d0733df5bbc88fc90cd16 --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 ad73190dcc495cfd527d0733df5bbc88fc90cd16 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-18 19:57:18,075 truncating revision to first 12 chars 2016-03-18 19:57:18,076 Setting DEBUG logging. 2016-03-18 19:57:18,076 attempt 1/10 2016-03-18 19:57:18,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad73190dcc49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 19:57:19,671 unpacking tar archive at: fx-team-ad73190dcc49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.839380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 19:57:19.856116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:19.856991) ========= echo ad73190dcc495cfd527d0733df5bbc88fc90cd16 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ad73190dcc495cfd527d0733df5bbc88fc90cd16'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 ad73190dcc495cfd527d0733df5bbc88fc90cd16 program finished with exit code 0 elapsedTime=0.005416 script_repo_revision: 'ad73190dcc495cfd527d0733df5bbc88fc90cd16' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:19.910037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:19.910375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 19:57:19.927170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-03-18 19:57:19.927841) ========= /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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:57:20 INFO - MultiFileLogger online at 20160318 19:57:20 in /builds/slave/test 19:57:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:57:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:57:20 INFO - {'append_to_log': False, 19:57:20 INFO - 'base_work_dir': '/builds/slave/test', 19:57:20 INFO - 'blob_upload_branch': 'Fx-Team', 19:57:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:57:20 INFO - 'branch': 'Fx-Team', 19:57:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:57:20 INFO - 'config_files': ('talos/mac_config.py',), 19:57:20 INFO - 'default_actions': ('clobber', 19:57:20 INFO - 'read-buildbot-config', 19:57:20 INFO - 'download-and-extract', 19:57:20 INFO - 'populate-webroot', 19:57:20 INFO - 'create-virtualenv', 19:57:20 INFO - 'install', 19:57:20 INFO - 'run-tests'), 19:57:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:57:20 INFO - 'download_minidump_stackwalk': True, 19:57:20 INFO - 'download_symbols': 'ondemand', 19:57:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:57:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:57:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:57:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:57:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:57:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:57:20 INFO - 'installer_path': 'installer.exe', 19:57:20 INFO - 'log_level': 'info', 19:57:20 INFO - 'log_name': 'talos', 19:57:20 INFO - 'log_to_console': True, 19:57:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:57:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:57:20 INFO - 'opt_config_files': (), 19:57:20 INFO - 'pip_index': False, 19:57:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:57:20 INFO - 'cmd': ('bash', 19:57:20 INFO - '-c', 19:57:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:57:20 INFO - 'enabled': True, 19:57:20 INFO - 'halt_on_failure': False, 19:57:20 INFO - 'name': 'check_screen_resolution'},), 19:57:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:57:20 INFO - 'cmd': ('bash', 19:57:20 INFO - '-c', 19:57:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:57:20 INFO - 'enabled': True, 19:57:20 INFO - 'halt_on_failure': False, 19:57:20 INFO - 'name': 'check_screen_resolution'},), 19:57:20 INFO - 'run_cmd_checks_enabled': True, 19:57:20 INFO - 'sps_profile': False, 19:57:20 INFO - 'sps_profile_interval': 0, 19:57:20 INFO - 'suite': 'dromaeojs', 19:57:20 INFO - 'system_bits': '32', 19:57:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:57:20 INFO - 'title': 't-yosemite-r7-0161', 19:57:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:57:20 INFO - 'use_talos_json': True, 19:57:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:57:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:57:20 INFO - 'work_dir': 'build'} 19:57:20 INFO - ##### 19:57:20 INFO - ##### Running clobber step. 19:57:20 INFO - ##### 19:57:20 INFO - Running pre-action listener: _resource_record_pre_action 19:57:20 INFO - Running main action method: clobber 19:57:20 INFO - rmtree: /builds/slave/test/build 19:57:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:57:21 INFO - Running post-action listener: _resource_record_post_action 19:57:21 INFO - ##### 19:57:21 INFO - ##### Running read-buildbot-config step. 19:57:21 INFO - ##### 19:57:21 INFO - Running pre-action listener: _resource_record_pre_action 19:57:21 INFO - Running main action method: read_buildbot_config 19:57:21 INFO - Using buildbot properties: 19:57:21 INFO - { 19:57:21 INFO - "project": "", 19:57:21 INFO - "product": "firefox", 19:57:21 INFO - "script_repo_revision": "production", 19:57:21 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:57:21 INFO - "repository": "", 19:57:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:57:21 INFO - "buildid": "20160318185337", 19:57:21 INFO - "pgo_build": "False", 19:57:21 INFO - "basedir": "/builds/slave/test", 19:57:21 INFO - "buildnumber": 553, 19:57:21 INFO - "slavename": "t-yosemite-r7-0161", 19:57:21 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:57:21 INFO - "platform": "yosemite_r7", 19:57:21 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:57:21 INFO - "branch": "fx-team", 19:57:21 INFO - "repo_path": "integration/fx-team", 19:57:21 INFO - "revision": "ad73190dcc495cfd527d0733df5bbc88fc90cd16", 19:57:21 INFO - "stage_platform": "macosx64", 19:57:21 INFO - "builduid": "b5461c6a45f84c89bbbbaf72ac8beffa", 19:57:21 INFO - "slavebuilddir": "test" 19:57:21 INFO - } 19:57:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 19:57:21 INFO - Running post-action listener: _resource_record_post_action 19:57:21 INFO - ##### 19:57:21 INFO - ##### Running download-and-extract step. 19:57:21 INFO - ##### 19:57:21 INFO - Running pre-action listener: _resource_record_pre_action 19:57:21 INFO - Running main action method: download_and_extract 19:57:21 INFO - mkdir: /builds/slave/test/build/tests 19:57: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')]} 19:57:21 INFO - https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:57:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:57:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:57:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:57:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 19:57:22 INFO - Downloaded 1199 bytes. 19:57:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:57:22 INFO - Using the following test package requirements: 19:57:22 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:57:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 19:57:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 19:57:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'jsshell-mac.zip'], 19:57:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 19:57:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:57:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 19:57:22 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 19:57:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 19:57:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:57:22 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 19:57:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:22 INFO - https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:57:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:57:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:57:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:57:24 INFO - Downloaded 17871392 bytes. 19:57:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:57:27 INFO - Return code: 0 19:57:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:27 INFO - https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:57:28 INFO - Downloaded 17871392 bytes. 19:57:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:57:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:57:32 INFO - Return code: 0 19:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:32 INFO - https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:57:33 INFO - Downloaded 10846565 bytes. 19:57:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:57:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:57:33 INFO - Return code: 0 19:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:33 INFO - https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:57:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:57:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:57:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 19:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 19:57:36 INFO - Downloaded 111188492 bytes. 19:57:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:57:36 INFO - mkdir: /builds/slave/test/properties 19:57:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:57:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:57:36 INFO - Contents: 19:57:36 INFO - build_url:https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:57:37 INFO - Running post-action listener: _resource_record_post_action 19:57:37 INFO - Running post-action listener: set_extra_try_arguments 19:57:37 INFO - ##### 19:57:37 INFO - ##### Running populate-webroot step. 19:57:37 INFO - ##### 19:57:37 INFO - Running pre-action listener: _resource_record_pre_action 19:57:37 INFO - Running main action method: populate_webroot 19:57:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:57:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:57:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:57:37 INFO - '--tppagecycles', 19:57:37 INFO - '7'], 19:57:37 INFO - 'tests': ['tsvgm']}}, 19:57:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:57:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:57:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:57:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:57:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'tests': ['damp', 'tps']}, 19:57:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['damp', 'tps']}, 19:57:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:57:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:57:37 INFO - 'other': {'tests': ['a11yr', 19:57:37 INFO - 'ts_paint', 19:57:37 INFO - 'tpaint', 19:57:37 INFO - 'sessionrestore', 19:57:37 INFO - 'sessionrestore_no_auto_restore', 19:57:37 INFO - 'tabpaint']}, 19:57:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['a11yr', 19:57:37 INFO - 'ts_paint', 19:57:37 INFO - 'tpaint', 19:57:37 INFO - 'sessionrestore', 19:57:37 INFO - 'sessionrestore_no_auto_restore', 19:57:37 INFO - 'tabpaint']}, 19:57:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['a11yr', 19:57:37 INFO - 'ts_paint', 19:57:37 INFO - 'tpaint', 19:57:37 INFO - 'sessionrestore', 19:57:37 INFO - 'sessionrestore_no_auto_restore', 19:57:37 INFO - 'tabpaint']}, 19:57:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['a11yr', 19:57:37 INFO - 'ts_paint', 19:57:37 INFO - 'tpaint', 19:57:37 INFO - 'sessionrestore', 19:57:37 INFO - 'sessionrestore_no_auto_restore', 19:57:37 INFO - 'tabpaint']}, 19:57:37 INFO - 'other_l64': {'tests': ['a11yr', 19:57:37 INFO - 'ts_paint', 19:57:37 INFO - 'tpaint', 19:57:37 INFO - 'sessionrestore', 19:57:37 INFO - 'sessionrestore_no_auto_restore', 19:57:37 INFO - 'tabpaint']}, 19:57:37 INFO - 'other_nol64': {'tests': ['a11yr', 19:57:37 INFO - 'ts_paint', 19:57:37 INFO - 'tpaint', 19:57:37 INFO - 'sessionrestore', 19:57:37 INFO - 'sessionrestore_no_auto_restore', 19:57:37 INFO - 'tabpaint']}, 19:57:37 INFO - 'svgr': {'tests': ['tsvgx', 19:57:37 INFO - 'tsvgr_opacity', 19:57:37 INFO - 'tart', 19:57:37 INFO - 'tscrollx', 19:57:37 INFO - 'cart']}, 19:57:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['tsvgx', 19:57:37 INFO - 'tsvgr_opacity', 19:57:37 INFO - 'tart', 19:57:37 INFO - 'tscrollx', 19:57:37 INFO - 'cart']}, 19:57:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'tests': ['tp5o']}, 19:57:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'talos_options': ['--e10s'], 19:57:37 INFO - 'tests': ['tp5o']}, 19:57:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'talos_options': ['--xperf_path', 19:57:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:37 INFO - 'tests': ['tp5n']}, 19:57:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:37 INFO - 'talos_options': ['--e10s', 19:57:37 INFO - '--xperf_path', 19:57:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:37 INFO - 'tests': ['tp5n']}}, 19:57:37 INFO - 'talos.zip': {'path': '', 19:57:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:57:37 INFO - Running post-action listener: _resource_record_post_action 19:57:37 INFO - ##### 19:57:37 INFO - ##### Running create-virtualenv step. 19:57:37 INFO - ##### 19:57:37 INFO - Running pre-action listener: _resource_record_pre_action 19:57:37 INFO - Running main action method: create_virtualenv 19:57:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:57:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:57:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:57:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:57:37 INFO - Using real prefix '/tools/python27' 19:57:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:57:38 INFO - Installing distribute.............................................................................................................................................................................................done. 19:57:41 INFO - Installing pip.................done. 19:57:41 INFO - Return code: 0 19:57:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:41 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:41 INFO - 'HOME': '/Users/cltbld', 19:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:41 INFO - 'LOGNAME': 'cltbld', 19:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:41 INFO - 'MOZ_NO_REMOTE': '1', 19:57:41 INFO - 'NO_EM_RESTART': '1', 19:57:41 INFO - 'PAGER': '/bin/cat', 19:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:41 INFO - 'PWD': '/builds/slave/test', 19:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:41 INFO - 'SHELL': '/bin/bash', 19:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:57:41 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:41 INFO - 'USER': 'cltbld', 19:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:41 INFO - 'XPC_FLAGS': '0x0', 19:57:41 INFO - 'XPC_SERVICE_NAME': '0', 19:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:57:41 INFO - Cleaning up... 19:57:41 INFO - Return code: 0 19:57:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:41 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:41 INFO - 'HOME': '/Users/cltbld', 19:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:41 INFO - 'LOGNAME': 'cltbld', 19:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:41 INFO - 'MOZ_NO_REMOTE': '1', 19:57:41 INFO - 'NO_EM_RESTART': '1', 19:57:41 INFO - 'PAGER': '/bin/cat', 19:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:41 INFO - 'PWD': '/builds/slave/test', 19:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:41 INFO - 'SHELL': '/bin/bash', 19:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:57:41 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:41 INFO - 'USER': 'cltbld', 19:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:41 INFO - 'XPC_FLAGS': '0x0', 19:57:41 INFO - 'XPC_SERVICE_NAME': '0', 19:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:41 INFO - Downloading/unpacking psutil>=0.7.1 19:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:44 INFO - Installing collected packages: psutil 19:57:44 INFO - Running setup.py install for psutil 19:57:44 INFO - building 'psutil._psutil_osx' extension 19:57:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:57:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:57:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:57:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:57:45 INFO - building 'psutil._psutil_posix' extension 19:57:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:57:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:57:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:57:45 INFO - ^ 19:57:45 INFO - 1 warning generated. 19:57:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:57:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:45 INFO - Successfully installed psutil 19:57:45 INFO - Cleaning up... 19:57:45 INFO - Return code: 0 19:57:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:45 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:45 INFO - 'HOME': '/Users/cltbld', 19:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:45 INFO - 'LOGNAME': 'cltbld', 19:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:45 INFO - 'MOZ_NO_REMOTE': '1', 19:57:45 INFO - 'NO_EM_RESTART': '1', 19:57:45 INFO - 'PAGER': '/bin/cat', 19:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:45 INFO - 'PWD': '/builds/slave/test', 19:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:45 INFO - 'SHELL': '/bin/bash', 19:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:57:45 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:45 INFO - 'USER': 'cltbld', 19:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:45 INFO - 'XPC_FLAGS': '0x0', 19:57:45 INFO - 'XPC_SERVICE_NAME': '0', 19:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:57:48 INFO - Installing collected packages: mozsystemmonitor 19:57:48 INFO - Running setup.py install for mozsystemmonitor 19:57:48 INFO - Successfully installed mozsystemmonitor 19:57:48 INFO - Cleaning up... 19:57:48 INFO - Return code: 0 19:57:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:48 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:48 INFO - 'HOME': '/Users/cltbld', 19:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:48 INFO - 'LOGNAME': 'cltbld', 19:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:48 INFO - 'MOZ_NO_REMOTE': '1', 19:57:48 INFO - 'NO_EM_RESTART': '1', 19:57:48 INFO - 'PAGER': '/bin/cat', 19:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:48 INFO - 'PWD': '/builds/slave/test', 19:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:48 INFO - 'SHELL': '/bin/bash', 19:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:57:48 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:48 INFO - 'USER': 'cltbld', 19:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:48 INFO - 'XPC_FLAGS': '0x0', 19:57:48 INFO - 'XPC_SERVICE_NAME': '0', 19:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:57:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:57:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:52 INFO - Downloading docopt-0.6.1.tar.gz 19:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:57:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:57:52 INFO - Running setup.py install for blobuploader 19:57:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:57:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:57:52 INFO - Running setup.py install for requests 19:57:53 INFO - Running setup.py install for docopt 19:57:53 INFO - Successfully installed blobuploader requests docopt 19:57:53 INFO - Cleaning up... 19:57:53 INFO - Return code: 0 19:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:53 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:53 INFO - 'HOME': '/Users/cltbld', 19:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:53 INFO - 'LOGNAME': 'cltbld', 19:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:53 INFO - 'MOZ_NO_REMOTE': '1', 19:57:53 INFO - 'NO_EM_RESTART': '1', 19:57:53 INFO - 'PAGER': '/bin/cat', 19:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:53 INFO - 'PWD': '/builds/slave/test', 19:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:53 INFO - 'SHELL': '/bin/bash', 19:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:57:53 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:53 INFO - 'USER': 'cltbld', 19:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:53 INFO - 'XPC_FLAGS': '0x0', 19:57:53 INFO - 'XPC_SERVICE_NAME': '0', 19:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:53 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ejlVH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:53 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-JpGF23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:53 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-z5TThg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:53 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-rmWq2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-xsdqR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-JpcXNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-1CUioW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-ON7uYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-6BLLLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-q3ftJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-f2M2jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-uxkbhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:54 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-eGE1Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:55 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Dk5z4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:55 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-kgGJwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:55 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-0_2q20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:55 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-p39pka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:57:55 INFO - Running setup.py install for manifestparser 19:57:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:57:55 INFO - Running setup.py install for mozcrash 19:57:55 INFO - Running setup.py install for mozdebug 19:57:55 INFO - Running setup.py install for mozdevice 19:57:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Running setup.py install for mozfile 19:57:56 INFO - Running setup.py install for mozhttpd 19:57:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Running setup.py install for mozinfo 19:57:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Running setup.py install for mozInstall 19:57:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Running setup.py install for mozleak 19:57:56 INFO - Running setup.py install for mozlog 19:57:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:57:56 INFO - Running setup.py install for moznetwork 19:57:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:57:57 INFO - Running setup.py install for mozprocess 19:57:57 INFO - Running setup.py install for mozprofile 19:57:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:57:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:57:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:57:57 INFO - Running setup.py install for mozrunner 19:57:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:57:57 INFO - Running setup.py install for mozscreenshot 19:57:57 INFO - Running setup.py install for moztest 19:57:57 INFO - Running setup.py install for mozversion 19:57:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:57:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:57:57 INFO - Cleaning up... 19:57:58 INFO - Return code: 0 19:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:58 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:58 INFO - 'HOME': '/Users/cltbld', 19:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:58 INFO - 'LOGNAME': 'cltbld', 19:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:58 INFO - 'MOZ_NO_REMOTE': '1', 19:57:58 INFO - 'NO_EM_RESTART': '1', 19:57:58 INFO - 'PAGER': '/bin/cat', 19:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:58 INFO - 'PWD': '/builds/slave/test', 19:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:58 INFO - 'SHELL': '/bin/bash', 19:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:57:58 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:58 INFO - 'USER': 'cltbld', 19:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:58 INFO - 'XPC_FLAGS': '0x0', 19:57:58 INFO - 'XPC_SERVICE_NAME': '0', 19:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-AhUsor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-8CsICE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-0O3LWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Ng3hjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-paSe3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-0hbS50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:58 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-hU9yHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-OPFuNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-qv6_H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-M2CnAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-k94MB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-h0gZg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-NmlHzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-jRZhaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Qsj8Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-qouwJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:59 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-9qDclG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:02 INFO - Downloading blessings-1.6.tar.gz 19:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:02 INFO - Installing collected packages: blessings 19:58:02 INFO - Running setup.py install for blessings 19:58:02 INFO - Successfully installed blessings 19:58:02 INFO - Cleaning up... 19:58:02 INFO - Return code: 0 19:58:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:03 INFO - Reading from file tmpfile_stdout 19:58:03 INFO - Current package versions: 19:58:03 INFO - blessings == 1.6 19:58:03 INFO - blobuploader == 1.2.4 19:58:03 INFO - docopt == 0.6.1 19:58:03 INFO - manifestparser == 1.1 19:58:03 INFO - mozInstall == 1.12 19:58:03 INFO - mozcrash == 0.17 19:58:03 INFO - mozdebug == 0.1 19:58:03 INFO - mozdevice == 0.48 19:58:03 INFO - mozfile == 1.2 19:58:03 INFO - mozhttpd == 0.7 19:58:03 INFO - mozinfo == 0.9 19:58:03 INFO - mozleak == 0.1 19:58:03 INFO - mozlog == 3.1 19:58:03 INFO - moznetwork == 0.27 19:58:03 INFO - mozprocess == 0.22 19:58:03 INFO - mozprofile == 0.28 19:58:03 INFO - mozrunner == 6.11 19:58:03 INFO - mozscreenshot == 0.1 19:58:03 INFO - mozsystemmonitor == 0.0 19:58:03 INFO - moztest == 0.7 19:58:03 INFO - mozversion == 1.4 19:58:03 INFO - psutil == 3.1.1 19:58:03 INFO - requests == 1.2.3 19:58:03 INFO - wsgiref == 0.1.2 19:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:03 INFO - 'HOME': '/Users/cltbld', 19:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:03 INFO - 'LOGNAME': 'cltbld', 19:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:03 INFO - 'MOZ_NO_REMOTE': '1', 19:58:03 INFO - 'NO_EM_RESTART': '1', 19:58:03 INFO - 'PAGER': '/bin/cat', 19:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:03 INFO - 'PWD': '/builds/slave/test', 19:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:03 INFO - 'SHELL': '/bin/bash', 19:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:58:03 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:03 INFO - 'USER': 'cltbld', 19:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:03 INFO - 'XPC_FLAGS': '0x0', 19:58:03 INFO - 'XPC_SERVICE_NAME': '0', 19:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:58:03 INFO - Cleaning up... 19:58:03 INFO - Return code: 0 19:58:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:03 INFO - 'HOME': '/Users/cltbld', 19:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:03 INFO - 'LOGNAME': 'cltbld', 19:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:03 INFO - 'MOZ_NO_REMOTE': '1', 19:58:03 INFO - 'NO_EM_RESTART': '1', 19:58:03 INFO - 'PAGER': '/bin/cat', 19:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:03 INFO - 'PWD': '/builds/slave/test', 19:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:03 INFO - 'SHELL': '/bin/bash', 19:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:58:03 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:03 INFO - 'USER': 'cltbld', 19:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:03 INFO - 'XPC_FLAGS': '0x0', 19:58:03 INFO - 'XPC_SERVICE_NAME': '0', 19:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:03 INFO - Downloading/unpacking jsonschema 19:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:05 INFO - Downloading/unpacking functools32 (from jsonschema) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:06 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:06 INFO - warning: no files found matching '*.txt' 19:58:06 INFO - no previously-included directories found matching 'build' 19:58:06 INFO - no previously-included directories found matching 'dist' 19:58:06 INFO - no previously-included directories found matching '.git*' 19:58:06 INFO - Installing collected packages: jsonschema, functools32 19:58:06 INFO - Running setup.py install for functools32 19:58:06 INFO - warning: no files found matching '*.txt' 19:58:06 INFO - no previously-included directories found matching 'build' 19:58:06 INFO - no previously-included directories found matching 'dist' 19:58:06 INFO - no previously-included directories found matching '.git*' 19:58:06 INFO - Successfully installed jsonschema functools32 19:58:06 INFO - Cleaning up... 19:58:06 INFO - Return code: 0 19:58:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:06 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 0x1060bca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060cc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa951dacfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, '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.UUHPfkf22T/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.QpbVGe3AZD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:06 INFO - 'HOME': '/Users/cltbld', 19:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:06 INFO - 'LOGNAME': 'cltbld', 19:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:06 INFO - 'MOZ_NO_REMOTE': '1', 19:58:06 INFO - 'NO_EM_RESTART': '1', 19:58:06 INFO - 'PAGER': '/bin/cat', 19:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:06 INFO - 'PWD': '/builds/slave/test', 19:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:06 INFO - 'SHELL': '/bin/bash', 19:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:58:06 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:06 INFO - 'USER': 'cltbld', 19:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:06 INFO - 'XPC_FLAGS': '0x0', 19:58:06 INFO - 'XPC_SERVICE_NAME': '0', 19:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:06 INFO - Downloading/unpacking flake8 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:58:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:58:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:10 INFO - no previously-included directories found matching 'docs/_build' 19:58:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:58:10 INFO - Running setup.py install for pep8 19:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:10 INFO - no previously-included directories found matching 'docs/_build' 19:58:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:58:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:58:10 INFO - Cleaning up... 19:58:10 INFO - Return code: 0 19:58:10 INFO - Running post-action listener: _resource_record_post_action 19:58:11 INFO - Running post-action listener: _start_resource_monitoring 19:58:11 INFO - Starting resource monitoring. 19:58:11 INFO - ##### 19:58:11 INFO - ##### Running install step. 19:58:11 INFO - ##### 19:58:11 INFO - Running pre-action listener: _resource_record_pre_action 19:58:11 INFO - Running main action method: install 19:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:11 INFO - Reading from file tmpfile_stdout 19:58:11 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:58:11 INFO - Reading from file tmpfile_stdout 19:58:11 INFO - Output received: 19:58:11 INFO - Usage: mozinstall [options] installer 19:58:11 INFO - Options: 19:58:11 INFO - -h, --help show this help message and exit 19:58:11 INFO - -d DEST, --destination=DEST 19:58:11 INFO - Directory to install application into. [default: 19:58:11 INFO - "/builds/slave/test"] 19:58:11 INFO - --app=APP Application being installed. [default: firefox] 19:58:11 INFO - mkdir: /builds/slave/test/build/application 19:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:58:45 INFO - Reading from file tmpfile_stdout 19:58:45 INFO - Output received: 19:58:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:58:45 INFO - Running post-action listener: _resource_record_post_action 19:58:45 INFO - ##### 19:58:45 INFO - ##### Running run-tests step. 19:58:45 INFO - ##### 19:58:45 INFO - Running pre-action listener: _resource_record_pre_action 19:58:45 INFO - Running main action method: run_tests 19:58:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:58:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:58:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:58:45 INFO - 2016-03-18 19:58:45.706 screenresolution[1641:7351] starting screenresolution argv=screenresolution get 19:58:45 INFO - 2016-03-18 19:58:45.709 screenresolution[1641:7351] Display 0: 1600x1200x32@60 19:58:45 INFO - 2016-03-18 19:58:45.715 screenresolution[1642:7353] starting screenresolution argv=screenresolution list 19:58:45 INFO - Available Modes on Display 0 19:58:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:58:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:58:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:58:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:58:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:58:45 INFO - Intel Iris: 19:58:45 INFO - Chipset Model: Intel Iris 19:58:45 INFO - Type: GPU 19:58:45 INFO - Bus: Built-In 19:58:45 INFO - VRAM (Dynamic, Max): 1536 MB 19:58:45 INFO - Vendor: Intel (0x8086) 19:58:45 INFO - Device ID: 0x0a2e 19:58:45 INFO - Revision ID: 0x0009 19:58:45 INFO - Displays: 19:58:45 INFO - Display: 19:58:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:58:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:58:45 INFO - Display Serial Number: 1600x1200 60 19:58:45 INFO - Main Display: Yes 19:58:45 INFO - Mirror: Off 19:58:45 INFO - Online: Yes 19:58:45 INFO - Rotation: Supported 19:58:45 INFO - Return code: 0 19:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:58:45 INFO - Python 2.7.3 19:58:45 INFO - Return code: 0 19:58:45 INFO - grabbing minidump binary from tooltool 19:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:45 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 0x105f5be00>, '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 0x105d84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f56b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:58:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:58:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:58:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:58:46 INFO - Return code: 0 19:58:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:58:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:58:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:58:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:58:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:58:47 INFO - Return code: 0 19:58:47 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/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:58:47 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/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0161 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UUHPfkf22T/Render', 19:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:47 INFO - 'HOME': '/Users/cltbld', 19:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:47 INFO - 'LOGNAME': 'cltbld', 19:58:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:58:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:47 INFO - 'MOZ_NO_REMOTE': '1', 19:58:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:58:47 INFO - 'NO_EM_RESTART': '1', 19:58:47 INFO - 'PAGER': '/bin/cat', 19:58:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:47 INFO - 'PWD': '/builds/slave/test', 19:58:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:47 INFO - 'SHELL': '/bin/bash', 19:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QpbVGe3AZD/Listeners', 19:58:47 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 19:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:47 INFO - 'USER': 'cltbld', 19:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:47 INFO - 'XPC_FLAGS': '0x0', 19:58:47 INFO - 'XPC_SERVICE_NAME': '0', 19:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:47 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/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:58:47 INFO - mozversion application_buildid: 20160318185337 19:58:47 INFO - mozversion application_changeset: ad73190dcc495cfd527d0733df5bbc88fc90cd16 19:58:47 INFO - mozversion application_display_name: Nightly 19:58:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:58:47 INFO - mozversion application_name: Firefox 19:58:47 INFO - mozversion application_remotingname: firefox 19:58:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:58:47 INFO - mozversion application_vendor: Mozilla 19:58:47 INFO - mozversion application_version: 48.0a1 19:58:47 INFO - mozversion platform_buildid: 20160318185337 19:58:47 INFO - mozversion platform_changeset: ad73190dcc495cfd527d0733df5bbc88fc90cd16 19:58:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:58:47 INFO - mozversion platform_version: 48.0a1 19:58:47 INFO - using testdate: 1458356327 19:58:47 INFO - actual date: 1458356327 19:58:47 INFO - starting webserver on 'localhost:49279' 19:58:47 INFO - SUITE-START | Running 2 tests 19:58:47 INFO - TEST-START | dromaeo_css 19:58:47 INFO - operating with platform_type : mac_ 19:58:47 INFO - Initialising browser for dromaeo_css test... 19:58:47 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpUM0v3B/profile http://localhost:49279/getInfo.html) 19:58:49 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 19:58:49 INFO - PROCESS | 1660 | colorDepth:24 19:58:49 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 19:58:49 INFO - PROCESS | 1660 | __metrics 19:58:49 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:58:49 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:58:50 INFO - TEST-INFO | 1660: exit 0 19:58:50 INFO - Browser initialized. 19:58:50 INFO - Running cycle 1/1 for dromaeo_css test... 19:58:50 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpUM0v3B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:02 INFO - PROCESS | 1663 | RSS: Main: 243888128 19:59:02 INFO - PROCESS | 1663 | 19:59:53 INFO - PROCESS | 1663 | 1458356393529 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] 20:02:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 20:02:05 INFO - PROCESS | 1663 | RSS: Main: 451870720 20:02:05 INFO - PROCESS | 1663 | 20:05:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 20:05:09 INFO - PROCESS | 1663 | RSS: Main: 381751296 20:05:09 INFO - PROCESS | 1663 | 20:08:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 20:08:11 INFO - PROCESS | 1663 | RSS: Main: 376422400 20:08:11 INFO - PROCESS | 1663 | 20:11:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 20:11:14 INFO - PROCESS | 1663 | RSS: Main: 343744512 20:11:14 INFO - PROCESS | 1663 | 20:14:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 20:14:17 INFO - PROCESS | 1663 | RSS: Main: 347930624 20:14:17 INFO - PROCESS | 1663 | 20:17:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 20:17:21 INFO - PROCESS | 1663 | RSS: Main: 427737088 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | __start_tp_report 20:17:21 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 20:17:21 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 20:17:21 INFO - PROCESS | 1663 | |i|pagename|runs| 20:17:21 INFO - PROCESS | 1663 | |0;dojo.html;2737.4251407204497;3418.418868792306;3511.2450823073036;3525.242072954315;3558.341706784245;5632.324121105473;5681.744321505537;5684.403137670547;5727.856803579907;5730.684812335325;5728.42715728427;5760.56795740319;5774.942250577493;5855.531557475402;5896.646201227929;5164.793408263665;5184.611154163444;5214.035403450355;5228.0850851101095;5346.946530534684;5357.357117145948;5371.973140134294;5411.621186516945;5428.4028756836715;5456.672599644034;5176.120059589879;5177.197534382177;5240;5277.8416647500635;5308.5487733542695;5252.028374750684;5256.92114618281;5270.5520030797425;5281.419043905167;5291.603129765283;5197.1424714922;5227.634065615409;5231.450697676765;5234.842954711365;5256.579473642099;5516.862078448071;5615.606907516475;5617.4944255016835;5625.212470254168;5681.630694004918;6250.312465628777;6276.905846412307;6281.340459251758;6289.811305660837;6304.243490781089;6275.7489700411925;6308.495320374405;6321.6523091229965;6365.904511432333;6373;5701.714914254312;5722.570807189394;5795.681237531976;5807.2160258365;5809.651420914759;6128.559788449711;6292.528060395397;6330.588511746721;6334.936650633527;6359.427651511386;4977.626677999165;5088.313077734459;6176.320604733476;6176.567640265228;6178.7219575119225;6118.192813661917;6204.193454850841;6286.49708023357;6302.369763023753;6327.367263273728;6207.224096987877;6224.439800417894;6226.875462490725;6227.595206311576;6228.377162283736;6180.351063138306;6247.094171345129;6250.374962503804;6253.249610046732;6275.843103922347;4815.711057336501;4860.489648586848;4872.878178045577;4893.314935908976;4900.901981960412;4387;4407.427034485497;4410.911781764346;4435.223835828717;4498.05540836428;5705.315362156485;5721.199032135504;5736.397678243808;5738.684372359477;5738.770449181986;6136.539759518054;6302.275238347649;6305.3379395163765;6310.684465776692;6324;5608.635438696471;5632.7746890123935;5671.716414179357;5678.375378708339;5681.147827825859;5334.786608535615;5344;5348.465153484621;5352.304200453916;5365.490278423544;5283.920741188886;6269.404406581368;6288.371162883675;6325.810225693236;6353;6249.375062493714;6313.05304204373;6329.778457753957;6343.111964324906;6354.364563543793;6351.396617321347;6351.523635727432;6353.9046914295395;6358.554901156875;6361.681915904093;6109.890546867989;6113.663748493876;6162.26052873658;6202.875942481215;6226.906596400967;6286.779962701284;6288.339724328879;6305.180326557518;6309.305976342691;6310.305866354789;5878.353381127987;6105.023196288573;6110.969445152746;6138.877222455615;6148.569600127948;5944.702764861653;6013.699315034143;6046.939530604637;6055.576109672281;6057.333693293646;5280.81517146898;5545.584081193846;5886.705664716833;5889.911651325319;5896.764129434775;5978.850528736816;5978.910316345346;5993.400659933972;5993.460588547052;5998;5822.184894114743;5856.3558008618165;5877.324107727495;5891.1752354671235;5891.558133139946 20:17:21 INFO - PROCESS | 1663 | |1;ext.html;493.98979087765537;537.5726297593413;576.3084298841392;634.9809505714828;638.1799387786693;26832.463350732975;38014.42978355327;38098;38137.23725525488;38165.80917095418;38778.61221387785;39432.40851387232;39443.605563944424;39468;39489.802550987275;9304.95347523263;9543.04569543047;9555.617775289014;9556.61773529058;9578.568964396583;8942.46345219289;9169.358144929858;9176.495292758895;9179.908200917973;9183;9202.263818894473;9215.907840921573;9223.815523689522;9229.907700922971;9233.53832308382;9157.404768690047;9164.083591640849;9170.082991700776;9187.67843125494;9199.494027828534;9464.053594640549;9630.27772917034;9637.951810240904;9641.27690423221;9647.276454265959;38554.80722596369;38921.61078389208;38944;39025;39222.607773922464;1849.0608925103681;3232.402005628943;3249.8375081245845;3273.1489812648647;3336.899893003214;27542;27834.86082569574;28000.85999569989;28254.434911301658;28385.148445546667;2762.7513523782754;2774.639296891391;2789.9721002789915;2925.093221101465;2987.8207307561615;423492;423613;423687;425000;426040;54548.72725636346;55581.166282505794;61387;62022.68988655028;64122.35877641257;61612;61925;62005.68997154985;62048.68975655093;62203.68898155571;16127.274272657758;16619.66760664804;16623.418180363627;16626.83373166277;16675.166241688108;11718.003969662674;11907.583234586747;12720.236785792882;12825.23048617086;12829.29438880852;19142.87554307185;19914.402567922985;19954.30159944395;19967.600647986957;19985.800141998396;8696.391252612382;8797.912020879709;8841.762153298543;8850.070742572067;8871.379003469825;851.7742798158492;922.260885171041;1031.7162780235344;1101.0145919402091;1129.55947180598;23470.76529234686;27979.803029545732;29470.410591788044;30076.84961575178;30362.392752145275;1090.5855774805523;1106.2035334559105;1137.2153214282118;1147.7704459108045;1157.0974639780984;14947.476838310607;14978.400863965537;14980.700385992437;15398.923005385126;15536.145511996949;627813;634722;636569;638348;638354;59944;60436.09345859816;60476.39523604708;60541.394586054455;60794;1331.3077199856214;1350.6218258887723;1440.1287221231214;1473.432728399574;1542.282838480112;25475.36311592225;28808.84764609392;29248;29482.705172947997;29679.85160074186;47487;48214.035719284715;48312.5168748308;48362.5163748358;48378.51621483881;350707;430065;430430;431824;433020;35304.82347588348;42483.78758106189;42704.718858434295;44071.77964110159;45454.863628409556;41972.17320008238;42579.36130957976;43117;43343;43820.90447738832;36096;37501.43747843839;38252.80873595614;38647.8405647831;39084.80457597694;35273;35290.82354588211;35949.10127246735;36414.63585364113;36530.452043218844;34555.30889382248;34782.82608586941;35040.47439288464;35592.46611300884;35713.64286357103;30854.074377768702;31607.84196079005;31669.841650791597;31680;32676.856310029034;22790.202342917917;23884.76115238895;24495.14267000718;24587.524748515145;24891.875540622183 20:17:21 INFO - PROCESS | 1663 | |2;jquery.html;358.3531725235949;361.6040435722883;365.5795834789991;374.95875453700086;376.57259011022484;19419;19743.308984185558;20473.771573705588;20958.790412095874;20967.266145684905;9675.758106047353;11886.286822790638;12385.690357741061;12398.752024959495;12402.317872517007;5080.441151473335;5278.445763194867;5338;5803.274590676166;5810.273715785527;5758.856028599276;5797.246357973458;5824.621399609033;5832.795852145176;5838;5685.488306052454;5740.081586946089;5747.2241247431475;5769.480746732793;5786.739596718136;5543.77824887006;5719.628224165416;5723.713814309268;5769.942300576982;5777.988851950891;5041.344625198737;5087.109755792759;5105.412877519096;5106.157484015133;5114.872128196787;13592.048556601041;13677.794833077513;19140.5214869628;24781.5043699125;25458;1974.1511150205406;2038.785927477623;2096.67501537262;2161.3299877038166;2293.736220334666;8576.88500494938;9843.852342214872;9955.5022248888;10154.086132248132;13027.348632568428;1543.004761928561;1613.3355837296413;1646.7529870519518;1651.0918994552949;1697.4568138195782;79324;108721.45639271832;108816;108845.45577272063;111934;11273.605423810128;11292.322460652387;11377.203595748219;11405.486753096131;11525.48135333912;13903.374348154357;13966.650833729034;14013.43946242139;14024.929875350763;14028.50900218508;8394;8561.357898157663;8592.398532102692;8653.17794809492;8683.609237584324;8583;8642.222200001905;8681.739547813575;8760.51817150063;8768;4414.249577571821;4498.437695288089;4505.144022635689;4550.97724511382;4554.63562914966;1807.6023274879506;1859.8047205043547;1864.3661155207024;1865.2352535460395;1873.9250429982649;851.7231899632644;900.342749792655;902.9458232506071;918.7978644698155;980.7401038724744;16704.081275529963;20030.298939537337;20281.594368112554;20538.486537836674;20549.69175462369;856.4390324337569;958.3387462650749;960.9567569459391;1001.2890847498358;1036.0934182590233;10766.084882784895;11092.389918554396;11101.500432480558;11107.389093599768;11119.27724697892;575991.9603215824;583881;590206;625767.1156451683;627614;108260;116878.41560792142;117231;121039.39480302543;121213.39393302977;1027.7430642339416;1040.3185913226698;1056.6460235820932;1058.6241884131177;1059.3061544688242;14107.788383174055;15639.843601564295;16462.588435289214;17474.30102795874;17991.280348786426;49120.75439622779;49612;51205.7439712799;52759.944801102996;52776.73611632071;54904;68559;68564.3143568578;71369;73305.16737081615;7556.206598307099;7756.224377562198;7821.022372203474;7873.803154921173;8111.391645626483;9231.953840230755;11839.82240266414;12053.758924821279;12202.450889710162;12426.937865310616;9963.701088967342;10609.681709548726;10952.34285942846;11017.44912754343;11094.722631934266;10261.538230779484;10336;10773.19201059908;10792.784144317227;10897.346159230472;9449.527523623929;10388.168946484111;10827.133829293794;11286.830697539379;11349.319040857576;7599.316061554487;7667.884981725167;7804.219578042377;7908.485948413335;8047.436679432383;10726.839097413389;11039;11273;11281.943590281997;11296.774064518499 20:17:21 INFO - PROCESS | 1663 | |3;mootools.html;1431.8353389360227;1560.134125560314;1564.63094792057;1685.890417122887;2011.3362590345196;7826.373890088794;8469.237768600824;8587.48475091495;8590;8609.827803443943;8305.958470207655;8590.87113693295;8601.91398086019;8602.139786021395;8624.611892464838;2150.2474134053036;2402.95194096118;2445.1686426614947;2462.704475462947;2489.103922587867;2484;2493.339265094751;2496.1263557754824;2498.088197807796;2499.8875050622673;2074.6887966804948;2198.505336299328;2401.267613377928;2435.1842132885504;2453.374389530667;2384.6423036544484;2400.3639035655565;2401.3756423329887;2460.8277420580566;2471.221565206972;2418.5283869645427;2463.322586288767;2470.851748895072;2471.0609968211966;2471.4933438645216;8602.655893764242;8709.95645021777;8714.25928796053;8716.25911797498;8718.782030449225;5292.761825717852;5455.972720136414;5473.2063850741415;5497.615166938316;5499.450054994509;3611.981940090309;3654.853805847763;3731.2164445466483;3745.2696724138805;3779.130799916035;1025.0927928783005;1034.6068493972243;1039.7296702857236;1045.4668119259156;1060.2737125069352;11684.883151168464;11749.765004699944;11759.412029398582;11762.764744705059;11763.882361176364;4895.31465594817;4904.950950490449;4917.87705307363;4938.407391113017;4952.380952380952;9932.10611044995;9933.850992235122;9940.155086817702;9946.80106397868;9953.552090155961;4787.138315103245;5326.92009619856;5430.15832545956;5456.645318054314;5510.6969116698165;4424.668149888771;4605.6085232755595;4791;4984.601231901439;4992.201247800334;3169.667184945594;3325.2518183409024;3928.6660633845872;3946.940795888064;3968.345223038224;1285.1325355385077;1296.2416986063258;1298.3183828490119;1311.5999620115765;1314.1983390132011;1133.8412622232895;1133.8752737198902;1146.5471138900089;1162.6744511536783;1166.393475392791;7976.202379761978;8016.519008859487;8055.154208808108;8090.514569125871;8096.190380961974;1145.6219447582278;1171.5021116025655;1214.7449035702602;1219.0856857356982;1241.0381953985734;6225.00399936008;6288.6855657217875;6319.052142178618;6325.082862984841;6353.142325786052;10127.696169114939;10749.78500429987;10760.085392741705;10767.515461804238;10776.29954052984;9822.165115965223;10469.057784799405;10521.368717876952;10635.255532112833;10650.627228046982;8030.357571394275;8107.55408452529;8161.510309381338;8174.9182508175345;8259.504429734116;8044.919550804417;8049.476784009021;8088.71689490865;8129.430939834155;8159.918400815915;9561.61753529851;9654.324197306121;9699.030096990244;9722.75693107678;9741.172000379764;9794.559244833858;9922.107010369102;9986.400815951067;10089.949550252202;10091;6716.925291953264;6891.483138764513;7330.303621155982;7333.523320984119;7449.702011919462;8112.351011918914;8132.3900707448365;8183.140770219041;8186.590670466334;8195.426320157532;7197.532160409557;7285.162206346338;7293.38006269473;7397.889031664637;7448.813779655552;7196.568205907663;7229.168645605822;7233;7236.023136876454;7257.274272572911;7585.2035536270105;7679.308862202429;7686.385089192963;7693.038370203724;7693.6537855795505;6298.582818865719;6630.46956243509;6914.101166848278;6917.100776898971;7016.122984626922;7031.015657807809;7113.53762005468;7117.395021423237;7120.786376408716;7140.928590714234 20:17:21 INFO - PROCESS | 1663 | |4;prototype.html;287.4810966205997;319.077864970236;325.3265739918368;327.0972116957198;335.7364468891919;5208.921866172011;6295.244570651523;6552.4430423414005;6586.266699319788;6592.835179120519;6336.714847831847;6493.350664933504;6503.658682874162;6536.150300460945;6536.182977127859;4537.591616754491;4656.743879086649;4659.673822832403;4786.880327991811;4795.640326975474;4749.453812811519;4750;4756.976215118937;4770.2606096055;4782.952170478286;4689.671722979393;4709.764511774398;4726;4759.119562880861;4765.404324459442;4553.521880202581;4588.1511920294515;4723.409573803275;4726.66913316068;4764.642651801111;4032.8790136295665;4043.1509383029597;4043.939340909889;4054.493188351456;4059.878203653895;6106.511479081662;6179.474744646665;6199.535034872358;6211.565190436671;6220.066989951543;5488.929658716552;5499.3675727291475;5508.669479831223;5508.91736623951;5517.172424136412;6880.58716477013;6892.621475704879;6897.931020689779;6900.861982760367;6913.481488888303;4476.440444944382;4493.168763778712;4630.282306242504;4635.397398338195;4667.369905062841;7167.569945803217;7250.601216933067;7323.340899319087;7326.926730732731;7336.376408005326;4731.077439899186;4756.21522448799;4757.9048419032115;4761.2382018876815;4763.595094416944;4819.084373968934;4819.807207711652;4826.686265392808;4827.793051737066;4839.491853355417;5636.323641163005;5637.7181140942785;5638.35158956717;5639.379668236491;5643.927653745775;6697.564658297195;6918.619475928772;6953.721851126;6965.562053281413;6966.477514186457;1652.5703317137632;1664.9167541622871;1677.8154403015658;1678.5803549112723;1678.6055277009893;1031.0720351683394;1092.8961748633867;1104.1608377633056;1117.4859564600213;1127.6335191062938;6176.258848938156;6315.715792789244;6513.54405191632;6532.248791388956;6548.1814773153355;7274.454415918722;7285.271472852673;7296.087989001375;7302;7320.524165929304;6422.972324428069;6463.547551671432;6485.6108633482145;6502.577332473374;6526.543141980111;3088.722015018659;3820.255050265227;3824.6175382461533;3827.923441531154;3831.9808400958373;6211.627302361872;7198.7840364789145;7580.696772129163;7584.051993500812;7608.125065617414;7395.593242371614;7459.179490256068;7467.551946883204;7472.551646901204;7484.550926944401;7544.698212071456;7551.886721699069;7553.357964573072;7558.848823023619;7565.886511702219;5479.972600136974;5835.4748072673665;6256.906146407717;7238.963805181151;7245.38414234796;6768.323167683192;7075.469339799432;7080.575165489881;7135;7141.428685705235;6092.482139018233;7486.577550265432;7564.978727871887;7574.394048475999;7584.393248540214;4521.570450807168;4578;4580.9541904581865;4586.014006988514;4586.059857729091;7190.892136618059;7191.17301510333;7194.532355396883;7197.784066478014;7258.0927384076995;6692.163479565054;6894.758683446055;6976.197737260077;6977.372036516738;6988.266232045766;6908.654567271516;6953.6523173842115;6962.582245065312;6968.233494315723;6976.19773726028;6588.868222635616;6792.694328755119;6806.659667016728;6810.31896810315;6810.455163587;5885.970570147293;6951.443884489127;6961.860762784817;6962.930370696431;6982.743106240925;6526.151600291932;6604.966975165094;6689.866202676017;6759.121314229119;6856.965715171392 20:17:21 INFO - PROCESS | 1663 | |5;yui.html;689.8378880962974;749.8350362920156;752.3529764402616;760.7261385901078;774.4772278711872;14665.926670366647;14844.628884277898;14847.88640851935;14848.628784280398;14857.257137143126;13553.728925421485;13655.04414690972;13720.245386503739;13733.107348022371;13755.93122034391;725.9564426134449;738.7414404958275;902.828462592107;922.3128769067055;924.0851556958596;913.0549880873298;934.397313732642;937.320442679059;937.5359197197363;940.8024314893846;974.9415035097917;984.522506584306;985.1921424431969;987.9012098790099;990.6285143071349;761.4974117082727;956.1633570625703;974.3666616699131;976.5263847034183;978;729.2561587181045;729.6935287179398;730.1749023603347;730.6858051038051;730.7625021867862;14803.185824779634;14901.701965960729;14912.850871491255;14925;14925.776113358308;12542.24746515212;12721.936390318082;12916.289604071771;13087.86912130876;13165.144265622705;9268.536573171314;9994.00059994002;10062.158316483203;10366.637167699095;10821.134309255242;3530.947035794465;3533.5583052118486;3579.319929213441;3737.831797569116;3744.5132132822832;78137.04657383554;78802.02994925115;78856;78907.6054619729;78912;9004.774880628036;9098.636054557743;9261.72214833556;9477.383970041925;9802.95098524517;20188.69716954247;20680.689789653166;20782.688259676117;20819.791802082087;20820.583588328147;7538.585377804164;7547.924520754832;7561.243875612505;7704.036995375578;7718.382529397635;3925.4111883217747;4137.441445404892;4168.291390463629;4172.83913670214;4173.853915113017;3604.5314109165643;3663.4687970244167;3666.944995825065;3668.0646435158865;3671.0638787109115;655.4887187993373;658.4107224034462;658.5653468710628;669.5915491550151;672.7140965089817;576.2911618709012;585.1340016775197;595.4313630482878;605.2222893581815;606.0515293565555;7872.409569282212;7959.44283900133;8032.4778889372;8066.8024277272425;8370.204830541088;567.4779203133128;586.9530437564985;599.3976054065636;604.4771272848953;616.9475594574421;3710.777353358807;3743.5882052974152;3759.5112635357227;3781.5334783947815;3844.615538446133;91487;93552;93679;93893;93948.0605193953;82323;83471.7479237812;83631.7455238172;83983;84879.5756021216;72646.63676681583;73730;73778.63110684519;73811;74002.62998685079;6191.907121393273;7561.281678240558;7615.847683046419;7858.882116768367;7986.3610911128135;50226.24660630021;51532.96934061373;51712.48287517077;51978;52223.47776522186;59349.703251483465;64665.67667161634;66431.33921651998;66469.66765166144;67469;9411.81176376455;9600.951995239979;9691.176250018827;9790.216782657513;10292.228082893962;10437.425941573287;10580.523876425734;10964.177686673373;11269.943650281695;11382.373969431761;9965.053319934595;9997.55011024491;10112.544935477774;10268.743281418025;10282.588696452058;10020.849687254842;10161.796764064826;10270.33242839213;10303.330283531546;10564.788704226026;9701.029897010243;9980.500974951368;10046.397216167054;10199.38803671782;10651.786964260516;8445.704400345958;8562.058173600773;8777.297816174818;8802.955985220033;8881.023087460504;8151.551664658501;8459.154084591491;8633.611487483204;8734.213920747163;8736.475811451333 20:17:21 INFO - PROCESS | 1663 | __end_tp_report 20:17:21 INFO - PROCESS | 1663 | __start_cc_report 20:17:21 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2039 20:17:21 INFO - PROCESS | 1663 | __end_cc_report 20:17:21 INFO - PROCESS | 1663 | __startTimestamp1458357441031__endTimestamp 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | ------- Summary: start ------- 20:17:21 INFO - PROCESS | 1663 | Number of tests: 6 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5731.00 Median:5878.35 stddev:647.86 (11.0%) stddev-sans-first:605.79 20:17:21 INFO - PROCESS | 1663 | Values: 2737.4 3418.4 3511.2 3525.2 3558.3 5632.3 5681.7 5684.4 5727.9 5730.7 5728.4 5760.6 5774.9 5855.5 5896.6 5164.8 5184.6 5214.0 5228.1 5346.9 5357.4 5372.0 5411.6 5428.4 5456.7 5176.1 5177.2 5240.0 5277.8 5308.5 5252.0 5256.9 5270.6 5281.4 5291.6 5197.1 5227.6 5231.5 5234.8 5256.6 5516.9 5615.6 5617.5 5625.2 5681.6 6250.3 6276.9 6281.3 6289.8 6304.2 6275.7 6308.5 6321.7 6365.9 6373.0 5701.7 5722.6 5795.7 5807.2 5809.7 6128.6 6292.5 6330.6 6334.9 6359.4 4977.6 5088.3 6176.3 6176.6 6178.7 6118.2 6204.2 6286.5 6302.4 6327.4 6207.2 6224.4 6226.9 6227.6 6228.4 6180.4 6247.1 6250.4 6253.2 6275.8 4815.7 4860.5 4872.9 4893.3 4900.9 4387.0 4407.4 4410.9 4435.2 4498.1 5705.3 5721.2 5736.4 5738.7 5738.8 6136.5 6302.3 6305.3 6310.7 6324.0 5608.6 5632.8 5671.7 5678.4 5681.1 5334.8 5344.0 5348.5 5352.3 5365.5 5283.9 6269.4 6288.4 6325.8 6353.0 6249.4 6313.1 6329.8 6343.1 6354.4 6351.4 6351.5 6353.9 6358.6 6361.7 6109.9 6113.7 6162.3 6202.9 6226.9 6286.8 6288.3 6305.2 6309.3 6310.3 5878.4 6105.0 6111.0 6138.9 6148.6 5944.7 6013.7 6046.9 6055.6 6057.3 5280.8 5545.6 5886.7 5889.9 5896.8 5978.9 5978.9 5993.4 5993.5 5998.0 5822.2 5856.4 5877.3 5891.2 5891.6 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:63411.18 Median:38850.11 stddev:134030.62 (345.0%) stddev-sans-first:134323.37 20:17:21 INFO - PROCESS | 1663 | Values: 494.0 537.6 576.3 635.0 638.2 26832.5 38014.4 38098.0 38137.2 38165.8 38778.6 39432.4 39443.6 39468.0 39489.8 9305.0 9543.0 9555.6 9556.6 9578.6 8942.5 9169.4 9176.5 9179.9 9183.0 9202.3 9215.9 9223.8 9229.9 9233.5 9157.4 9164.1 9170.1 9187.7 9199.5 9464.1 9630.3 9638.0 9641.3 9647.3 38554.8 38921.6 38944.0 39025.0 39222.6 1849.1 3232.4 3249.8 3273.1 3336.9 27542.0 27834.9 28000.9 28254.4 28385.1 2762.8 2774.6 2790.0 2925.1 2987.8 423492.0 423613.0 423687.0 425000.0 426040.0 54548.7 55581.2 61387.0 62022.7 64122.4 61612.0 61925.0 62005.7 62048.7 62203.7 16127.3 16619.7 16623.4 16626.8 16675.2 11718.0 11907.6 12720.2 12825.2 12829.3 19142.9 19914.4 19954.3 19967.6 19985.8 8696.4 8797.9 8841.8 8850.1 8871.4 851.8 922.3 1031.7 1101.0 1129.6 23470.8 27979.8 29470.4 30076.8 30362.4 1090.6 1106.2 1137.2 1147.8 1157.1 14947.5 14978.4 14980.7 15398.9 15536.1 627813.0 634722.0 636569.0 638348.0 638354.0 59944.0 60436.1 60476.4 60541.4 60794.0 1331.3 1350.6 1440.1 1473.4 1542.3 25475.4 28808.8 29248.0 29482.7 29679.9 47487.0 48214.0 48312.5 48362.5 48378.5 350707.0 430065.0 430430.0 431824.0 433020.0 35304.8 42483.8 42704.7 44071.8 45454.9 41972.2 42579.4 43117.0 43343.0 43820.9 36096.0 37501.4 38252.8 38647.8 39084.8 35273.0 35290.8 35949.1 36414.6 36530.5 34555.3 34782.8 35040.5 35592.5 35713.6 30854.1 31607.8 31669.8 31680.0 32676.9 22790.2 23884.8 24495.1 24587.5 24891.9 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33400.41 Median:2227.53 stddev:99736.32 (4477.4%) stddev-sans-first:99985.25 20:17:21 INFO - PROCESS | 1663 | Values: 358.4 361.6 365.6 375.0 376.6 19419.0 19743.3 20473.8 20958.8 20967.3 9675.8 11886.3 12385.7 12398.8 12402.3 5080.4 5278.4 5338.0 5803.3 5810.3 5758.9 5797.2 5824.6 5832.8 5838.0 5685.5 5740.1 5747.2 5769.5 5786.7 5543.8 5719.6 5723.7 5769.9 5778.0 5041.3 5087.1 5105.4 5106.2 5114.9 13592.0 13677.8 19140.5 24781.5 25458.0 1974.2 2038.8 2096.7 2161.3 2293.7 8576.9 9843.9 9955.5 10154.1 13027.3 1543.0 1613.3 1646.8 1651.1 1697.5 79324.0 108721.5 108816.0 108845.5 111934.0 11273.6 11292.3 11377.2 11405.5 11525.5 13903.4 13966.7 14013.4 14024.9 14028.5 8394.0 8561.4 8592.4 8653.2 8683.6 8583.0 8642.2 8681.7 8760.5 8768.0 4414.2 4498.4 4505.1 4551.0 4554.6 1807.6 1859.8 1864.4 1865.2 1873.9 851.7 900.3 902.9 918.8 980.7 16704.1 20030.3 20281.6 20538.5 20549.7 856.4 958.3 961.0 1001.3 1036.1 10766.1 11092.4 11101.5 11107.4 11119.3 575992.0 583881.0 590206.0 625767.1 627614.0 108260.0 116878.4 117231.0 121039.4 121213.4 1027.7 1040.3 1056.6 1058.6 1059.3 14107.8 15639.8 16462.6 17474.3 17991.3 49120.8 49612.0 51205.7 52759.9 52776.7 54904.0 68559.0 68564.3 71369.0 73305.2 7556.2 7756.2 7821.0 7873.8 8111.4 9232.0 11839.8 12053.8 12202.5 12426.9 9963.7 10609.7 10952.3 11017.4 11094.7 10261.5 10336.0 10773.2 10792.8 10897.3 9449.5 10388.2 10827.1 11286.8 11349.3 7599.3 7667.9 7804.2 7908.5 8047.4 10726.8 11039.0 11273.0 11281.9 11296.8 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6006.85 Median:5456.31 stddev:3157.71 (57.9%) stddev-sans-first:3147.84 20:17:21 INFO - PROCESS | 1663 | Values: 1431.8 1560.1 1564.6 1685.9 2011.3 7826.4 8469.2 8587.5 8590.0 8609.8 8306.0 8590.9 8601.9 8602.1 8624.6 2150.2 2403.0 2445.2 2462.7 2489.1 2484.0 2493.3 2496.1 2498.1 2499.9 2074.7 2198.5 2401.3 2435.2 2453.4 2384.6 2400.4 2401.4 2460.8 2471.2 2418.5 2463.3 2470.9 2471.1 2471.5 8602.7 8710.0 8714.3 8716.3 8718.8 5292.8 5456.0 5473.2 5497.6 5499.5 3612.0 3654.9 3731.2 3745.3 3779.1 1025.1 1034.6 1039.7 1045.5 1060.3 11684.9 11749.8 11759.4 11762.8 11763.9 4895.3 4905.0 4917.9 4938.4 4952.4 9932.1 9933.9 9940.2 9946.8 9953.6 4787.1 5326.9 5430.2 5456.6 5510.7 4424.7 4605.6 4791.0 4984.6 4992.2 3169.7 3325.3 3928.7 3946.9 3968.3 1285.1 1296.2 1298.3 1311.6 1314.2 1133.8 1133.9 1146.5 1162.7 1166.4 7976.2 8016.5 8055.2 8090.5 8096.2 1145.6 1171.5 1214.7 1219.1 1241.0 6225.0 6288.7 6319.1 6325.1 6353.1 10127.7 10749.8 10760.1 10767.5 10776.3 9822.2 10469.1 10521.4 10635.3 10650.6 8030.4 8107.6 8161.5 8174.9 8259.5 8044.9 8049.5 8088.7 8129.4 8159.9 9561.6 9654.3 9699.0 9722.8 9741.2 9794.6 9922.1 9986.4 10089.9 10091.0 6716.9 6891.5 7330.3 7333.5 7449.7 8112.4 8132.4 8183.1 8186.6 8195.4 7197.5 7285.2 7293.4 7397.9 7448.8 7196.6 7229.2 7233.0 7236.0 7257.3 7585.2 7679.3 7686.4 7693.0 7693.7 6298.6 6630.5 6914.1 6917.1 7016.1 7031.0 7113.5 7117.4 7120.8 7140.9 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5665.08 Median:6379.84 stddev:1795.76 (28.1%) stddev-sans-first:1754.85 20:17:21 INFO - PROCESS | 1663 | Values: 287.5 319.1 325.3 327.1 335.7 5208.9 6295.2 6552.4 6586.3 6592.8 6336.7 6493.4 6503.7 6536.2 6536.2 4537.6 4656.7 4659.7 4786.9 4795.6 4749.5 4750.0 4757.0 4770.3 4783.0 4689.7 4709.8 4726.0 4759.1 4765.4 4553.5 4588.2 4723.4 4726.7 4764.6 4032.9 4043.2 4043.9 4054.5 4059.9 6106.5 6179.5 6199.5 6211.6 6220.1 5488.9 5499.4 5508.7 5508.9 5517.2 6880.6 6892.6 6897.9 6900.9 6913.5 4476.4 4493.2 4630.3 4635.4 4667.4 7167.6 7250.6 7323.3 7326.9 7336.4 4731.1 4756.2 4757.9 4761.2 4763.6 4819.1 4819.8 4826.7 4827.8 4839.5 5636.3 5637.7 5638.4 5639.4 5643.9 6697.6 6918.6 6953.7 6965.6 6966.5 1652.6 1664.9 1677.8 1678.6 1678.6 1031.1 1092.9 1104.2 1117.5 1127.6 6176.3 6315.7 6513.5 6532.2 6548.2 7274.5 7285.3 7296.1 7302.0 7320.5 6423.0 6463.5 6485.6 6502.6 6526.5 3088.7 3820.3 3824.6 3827.9 3832.0 6211.6 7198.8 7580.7 7584.1 7608.1 7395.6 7459.2 7467.6 7472.6 7484.6 7544.7 7551.9 7553.4 7558.8 7565.9 5480.0 5835.5 6256.9 7239.0 7245.4 6768.3 7075.5 7080.6 7135.0 7141.4 6092.5 7486.6 7565.0 7574.4 7584.4 4521.6 4578.0 4581.0 4586.0 4586.1 7190.9 7191.2 7194.5 7197.8 7258.1 6692.2 6894.8 6976.2 6977.4 6988.3 6908.7 6953.7 6962.6 6968.2 6976.2 6588.9 6792.7 6806.7 6810.3 6810.5 5886.0 6951.4 6961.9 6962.9 6982.7 6526.2 6605.0 6689.9 6759.1 6857.0 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18216.35 Median:34079.42 stddev:26200.48 (76.9%) stddev-sans-first:26240.93 20:17:21 INFO - PROCESS | 1663 | Values: 689.8 749.8 752.4 760.7 774.5 14665.9 14844.6 14847.9 14848.6 14857.3 13553.7 13655.0 13720.2 13733.1 13755.9 726.0 738.7 902.8 922.3 924.1 913.1 934.4 937.3 937.5 940.8 974.9 984.5 985.2 987.9 990.6 761.5 956.2 974.4 976.5 978.0 729.3 729.7 730.2 730.7 730.8 14803.2 14901.7 14912.9 14925.0 14925.8 12542.2 12721.9 12916.3 13087.9 13165.1 9268.5 9994.0 10062.2 10366.6 10821.1 3530.9 3533.6 3579.3 3737.8 3744.5 78137.0 78802.0 78856.0 78907.6 78912.0 9004.8 9098.6 9261.7 9477.4 9803.0 20188.7 20680.7 20782.7 20819.8 20820.6 7538.6 7547.9 7561.2 7704.0 7718.4 3925.4 4137.4 4168.3 4172.8 4173.9 3604.5 3663.5 3666.9 3668.1 3671.1 655.5 658.4 658.6 669.6 672.7 576.3 585.1 595.4 605.2 606.1 7872.4 7959.4 8032.5 8066.8 8370.2 567.5 587.0 599.4 604.5 616.9 3710.8 3743.6 3759.5 3781.5 3844.6 91487.0 93552.0 93679.0 93893.0 93948.1 82323.0 83471.7 83631.7 83983.0 84879.6 72646.6 73730.0 73778.6 73811.0 74002.6 6191.9 7561.3 7615.8 7858.9 7986.4 50226.2 51533.0 51712.5 51978.0 52223.5 59349.7 64665.7 66431.3 66469.7 67469.0 9411.8 9601.0 9691.2 9790.2 10292.2 10437.4 10580.5 10964.2 11269.9 11382.4 9965.1 9997.6 10112.5 10268.7 10282.6 10020.8 10161.8 10270.3 10303.3 10564.8 9701.0 9980.5 10046.4 10199.4 10651.8 8445.7 8562.1 8777.3 8803.0 8881.0 8151.6 8459.2 8633.6 8734.2 8736.5 20:17:21 INFO - PROCESS | 1663 | -------- Summary: end -------- 20:17:21 INFO - PROCESS | 1663 | 20:17:21 INFO - TEST-INFO | 1663: exit 0 20:17:21 INFO - TEST-OK | dromaeo_css | took 1114143ms 20:17:21 INFO - TEST-START | kraken 20:17:21 INFO - operating with platform_type : mac_ 20:17:21 INFO - Initialising browser for kraken test... 20:17:21 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpxqhyqq/profile http://localhost:49279/getInfo.html) 20:17:23 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 20:17:23 INFO - PROCESS | 1673 | colorDepth:24 20:17:23 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 20:17:23 INFO - PROCESS | 1673 | __metrics 20:17:23 INFO - PROCESS | 1673 | 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" 20:17:23 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:17:24 INFO - TEST-INFO | 1673: exit 0 20:17:24 INFO - Browser initialized. 20:17:24 INFO - Running cycle 1/1 for kraken test... 20:17:24 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpxqhyqq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:36 INFO - PROCESS | 1675 | RSS: Main: 245014528 20:17:36 INFO - PROCESS | 1675 | 20:17:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 20:17:39 INFO - PROCESS | 1675 | RSS: Main: 289988608 20:17:39 INFO - PROCESS | 1675 | 20:17:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 20:17:42 INFO - PROCESS | 1675 | RSS: Main: 301387776 20:17:42 INFO - PROCESS | 1675 | 20:17:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 20:17:46 INFO - PROCESS | 1675 | RSS: Main: 287256576 20:17:46 INFO - PROCESS | 1675 | 20:17:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 20:17:49 INFO - PROCESS | 1675 | RSS: Main: 288333824 20:17:49 INFO - PROCESS | 1675 | 20:17:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:17:51 INFO - PROCESS | 1675 | RSS: Main: 289132544 20:17:51 INFO - PROCESS | 1675 | 20:17:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 20:17:55 INFO - PROCESS | 1675 | RSS: Main: 289845248 20:17:55 INFO - PROCESS | 1675 | 20:17:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 20:17:58 INFO - PROCESS | 1675 | RSS: Main: 291893248 20:17:58 INFO - PROCESS | 1675 | 20:18:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 20:18:02 INFO - PROCESS | 1675 | RSS: Main: 291135488 20:18:02 INFO - PROCESS | 1675 | 20:18:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:04 INFO - PROCESS | 1675 | RSS: Main: 325140480 20:18:04 INFO - PROCESS | 1675 | 20:18:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:06 INFO - PROCESS | 1675 | RSS: Main: 324882432 20:18:06 INFO - PROCESS | 1675 | 20:18:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:09 INFO - PROCESS | 1675 | RSS: Main: 332705792 20:18:09 INFO - PROCESS | 1675 | 20:18:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:12 INFO - PROCESS | 1675 | RSS: Main: 333598720 20:18:12 INFO - PROCESS | 1675 | 20:18:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:15 INFO - PROCESS | 1675 | RSS: Main: 334016512 20:18:15 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 20:18:17 INFO - PROCESS | 1675 | RSS: Main: 394915840 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | __start_tp_report 20:18:17 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 20:18:17 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 20:18:17 INFO - PROCESS | 1675 | |i|pagename|runs| 20:18:17 INFO - PROCESS | 1675 | |0;ai-astar;112;107;111;111;112;112;115;112;110;112 20:18:17 INFO - PROCESS | 1675 | |1;audio-beat-detection;176;149;179;161;119;144;139;119;161;117 20:18:17 INFO - PROCESS | 1675 | |2;audio-dft;183;184;188;186;184;184;184;182;182;183 20:18:17 INFO - PROCESS | 1675 | |3;audio-fft;76;98;118;105;57;58;57;81;76;56 20:18:17 INFO - PROCESS | 1675 | |4;audio-oscillator;91;97;121;78;80;93;112;79;79;112 20:18:17 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;88;84;92;130;115;89;90;84;86;84 20:18:17 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;93;93;93;93;93;92;121;149;92 20:18:17 INFO - PROCESS | 1675 | |7;imaging-desaturate;87;87;89;84;86;85;88;87;85;87 20:18:17 INFO - PROCESS | 1675 | |8;json-parse-financial;57;55;56;54;55;54;54;64;56;54 20:18:17 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;65;65;75;75;71;69;66;67;68;68 20:18:17 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;84;83;82;83;82;84;83;84;83 20:18:17 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;124;125;130;131;106;126;125;148;129;118 20:18:17 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;141;129;138;140;138;126;137;135;138;139 20:18:17 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;67;67;68;66;67;66;65;66;67 20:18:17 INFO - PROCESS | 1675 | __end_tp_report 20:18:17 INFO - PROCESS | 1675 | __start_cc_report 20:18:17 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1206 20:18:17 INFO - PROCESS | 1675 | __end_cc_report 20:18:17 INFO - PROCESS | 1675 | __startTimestamp1458357497437__endTimestamp 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | ------- Summary: start ------- 20:18:17 INFO - PROCESS | 1675 | Number of tests: 14 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.01 (1.8%) stddev-sans-first:2.12 20:18:17 INFO - PROCESS | 1675 | Values: 112.0 107.0 111.0 111.0 112.0 112.0 115.0 112.0 110.0 112.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:155.00 stddev:23.09 (14.9%) stddev-sans-first:21.87 20:18:17 INFO - PROCESS | 1675 | Values: 176.0 149.0 179.0 161.0 119.0 144.0 139.0 119.0 161.0 117.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.83 (1.0%) stddev-sans-first:1.90 20:18:17 INFO - PROCESS | 1675 | Values: 183.0 184.0 188.0 186.0 184.0 184.0 184.0 182.0 182.0 183.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:78.20 Median:67.00 stddev:22.39 (33.4%) stddev-sans-first:23.73 20:18:17 INFO - PROCESS | 1675 | Values: 76.0 98.0 118.0 105.0 57.0 58.0 57.0 81.0 76.0 56.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.50 stddev:15.98 (20.1%) stddev-sans-first:16.90 20:18:17 INFO - PROCESS | 1675 | Values: 91.0 97.0 121.0 78.0 80.0 93.0 112.0 79.0 79.0 112.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:87.00 stddev:15.57 (17.9%) stddev-sans-first:16.35 20:18:17 INFO - PROCESS | 1675 | Values: 88.0 84.0 92.0 130.0 115.0 89.0 90.0 84.0 86.0 84.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:93.00 stddev:19.05 (20.5%) stddev-sans-first:19.92 20:18:17 INFO - PROCESS | 1675 | Values: 92.0 93.0 93.0 93.0 93.0 93.0 92.0 121.0 149.0 92.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:1.51 (1.7%) stddev-sans-first:1.59 20:18:17 INFO - PROCESS | 1675 | Values: 87.0 87.0 89.0 84.0 86.0 85.0 88.0 87.0 85.0 87.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:3.03 (5.5%) stddev-sans-first:3.19 20:18:17 INFO - PROCESS | 1675 | Values: 57.0 55.0 56.0 54.0 55.0 54.0 54.0 64.0 56.0 54.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.50 stddev:3.70 (5.4%) stddev-sans-first:3.64 20:18:17 INFO - PROCESS | 1675 | Values: 65.0 65.0 75.0 75.0 71.0 69.0 66.0 67.0 68.0 68.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 20:18:17 INFO - PROCESS | 1675 | Values: 82.0 84.0 83.0 82.0 83.0 82.0 84.0 83.0 84.0 83.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.50 stddev:10.56 (8.3%) stddev-sans-first:11.17 20:18:17 INFO - PROCESS | 1675 | Values: 124.0 125.0 130.0 131.0 106.0 126.0 125.0 148.0 129.0 118.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:138.00 stddev:4.86 (3.5%) stddev-sans-first:4.82 20:18:17 INFO - PROCESS | 1675 | Values: 141.0 129.0 138.0 140.0 138.0 126.0 137.0 135.0 138.0 139.0 20:18:17 INFO - PROCESS | 1675 | 20:18:17 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 20:18:17 INFO - PROCESS | 1675 | Values: 67.0 67.0 67.0 68.0 66.0 67.0 66.0 65.0 66.0 67.0 20:18:17 INFO - PROCESS | 1675 | -------- Summary: end -------- 20:18:17 INFO - PROCESS | 1675 | 20:18:18 INFO - TEST-INFO | 1675: exit 0 20:18:18 INFO - TEST-OK | kraken | took 56572ms 20:18:18 INFO - SUITE-END | took 1170s 20:18:18 INFO - Completed test suite (00:19:31) 20:18:18 INFO - javascript benchmark 20:18:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2737.4251407204497, 3418.418868792306, 3511.2450823073036, 3525.242072954315, 3558.341706784245, 5632.324121105473, 5681.744321505537, 5684.403137670547, 5727.856803579907, 5730.684812335325, 5728.42715728427, 5760.56795740319, 5774.942250577493, 5855.531557475402, 5896.646201227929, 5164.793408263665, 5184.611154163444, 5214.035403450355, 5228.0850851101095, 5346.946530534684, 5357.357117145948, 5371.973140134294, 5411.621186516945, 5428.4028756836715, 5456.672599644034, 5176.120059589879, 5177.197534382177, 5240.0, 5277.8416647500635, 5308.5487733542695, 5252.028374750684, 5256.92114618281, 5270.5520030797425, 5281.419043905167, 5291.603129765283, 5197.1424714922, 5227.634065615409, 5231.450697676765, 5234.842954711365, 5256.579473642099, 5516.862078448071, 5615.606907516475, 5617.4944255016835, 5625.212470254168, 5681.630694004918, 6250.312465628777, 6276.905846412307, 6281.340459251758, 6289.811305660837, 6304.243490781089, 6275.7489700411925, 6308.495320374405, 6321.6523091229965, 6365.904511432333, 6373.0, 5701.714914254312, 5722.570807189394, 5795.681237531976, 5807.2160258365, 5809.651420914759, 6128.559788449711, 6292.528060395397, 6330.588511746721, 6334.936650633527, 6359.427651511386, 4977.626677999165, 5088.313077734459, 6176.320604733476, 6176.567640265228, 6178.7219575119225, 6118.192813661917, 6204.193454850841, 6286.49708023357, 6302.369763023753, 6327.367263273728, 6207.224096987877, 6224.439800417894, 6226.875462490725, 6227.595206311576, 6228.377162283736, 6180.351063138306, 6247.094171345129, 6250.374962503804, 6253.249610046732, 6275.843103922347, 4815.711057336501, 4860.489648586848, 4872.878178045577, 4893.314935908976, 4900.901981960412, 4387.0, 4407.427034485497, 4410.911781764346, 4435.223835828717, 4498.05540836428, 5705.315362156485, 5721.199032135504, 5736.397678243808, 5738.684372359477, 5738.770449181986, 6136.539759518054, 6302.275238347649, 6305.3379395163765, 6310.684465776692, 6324.0, 5608.635438696471, 5632.7746890123935, 5671.716414179357, 5678.375378708339, 5681.147827825859, 5334.786608535615, 5344.0, 5348.465153484621, 5352.304200453916, 5365.490278423544, 5283.920741188886, 6269.404406581368, 6288.371162883675, 6325.810225693236, 6353.0, 6249.375062493714, 6313.05304204373, 6329.778457753957, 6343.111964324906, 6354.364563543793, 6351.396617321347, 6351.523635727432, 6353.9046914295395, 6358.554901156875, 6361.681915904093, 6109.890546867989, 6113.663748493876, 6162.26052873658, 6202.875942481215, 6226.906596400967, 6286.779962701284, 6288.339724328879, 6305.180326557518, 6309.305976342691, 6310.305866354789, 5878.353381127987, 6105.023196288573, 6110.969445152746, 6138.877222455615, 6148.569600127948, 5944.702764861653, 6013.699315034143, 6046.939530604637, 6055.576109672281, 6057.333693293646, 5280.81517146898, 5545.584081193846, 5886.705664716833, 5889.911651325319, 5896.764129434775, 5978.850528736816, 5978.910316345346, 5993.400659933972, 5993.460588547052, 5998.0, 5822.184894114743, 5856.3558008618165, 5877.324107727495, 5891.1752354671235, 5891.558133139946], "unit": "score", "name": "dojo.html", "value": 5689.8429536617905}, {"lowerIsBetter": false, "replicates": [493.98979087765537, 537.5726297593413, 576.3084298841392, 634.9809505714828, 638.1799387786693, 26832.463350732975, 38014.42978355327, 38098.0, 38137.23725525488, 38165.80917095418, 38778.61221387785, 39432.40851387232, 39443.605563944424, 39468.0, 39489.802550987275, 9304.95347523263, 9543.04569543047, 9555.617775289014, 9556.61773529058, 9578.568964396583, 8942.46345219289, 9169.358144929858, 9176.495292758895, 9179.908200917973, 9183.0, 9202.263818894473, 9215.907840921573, 9223.815523689522, 9229.907700922971, 9233.53832308382, 9157.404768690047, 9164.083591640849, 9170.082991700776, 9187.67843125494, 9199.494027828534, 9464.053594640549, 9630.27772917034, 9637.951810240904, 9641.27690423221, 9647.276454265959, 38554.80722596369, 38921.61078389208, 38944.0, 39025.0, 39222.607773922464, 1849.0608925103681, 3232.402005628943, 3249.8375081245845, 3273.1489812648647, 3336.899893003214, 27542.0, 27834.86082569574, 28000.85999569989, 28254.434911301658, 28385.148445546667, 2762.7513523782754, 2774.639296891391, 2789.9721002789915, 2925.093221101465, 2987.8207307561615, 423492.0, 423613.0, 423687.0, 425000.0, 426040.0, 54548.72725636346, 55581.166282505794, 61387.0, 62022.68988655028, 64122.35877641257, 61612.0, 61925.0, 62005.68997154985, 62048.68975655093, 62203.68898155571, 16127.274272657758, 16619.66760664804, 16623.418180363627, 16626.83373166277, 16675.166241688108, 11718.003969662674, 11907.583234586747, 12720.236785792882, 12825.23048617086, 12829.29438880852, 19142.87554307185, 19914.402567922985, 19954.30159944395, 19967.600647986957, 19985.800141998396, 8696.391252612382, 8797.912020879709, 8841.762153298543, 8850.070742572067, 8871.379003469825, 851.7742798158492, 922.260885171041, 1031.7162780235344, 1101.0145919402091, 1129.55947180598, 23470.76529234686, 27979.803029545732, 29470.410591788044, 30076.84961575178, 30362.392752145275, 1090.5855774805523, 1106.2035334559105, 1137.2153214282118, 1147.7704459108045, 1157.0974639780984, 14947.476838310607, 14978.400863965537, 14980.700385992437, 15398.923005385126, 15536.145511996949, 627813.0, 634722.0, 636569.0, 638348.0, 638354.0, 59944.0, 60436.09345859816, 60476.39523604708, 60541.394586054455, 60794.0, 1331.3077199856214, 1350.6218258887723, 1440.1287221231214, 1473.432728399574, 1542.282838480112, 25475.36311592225, 28808.84764609392, 29248.0, 29482.705172947997, 29679.85160074186, 47487.0, 48214.035719284715, 48312.5168748308, 48362.5163748358, 48378.51621483881, 350707.0, 430065.0, 430430.0, 431824.0, 433020.0, 35304.82347588348, 42483.78758106189, 42704.718858434295, 44071.77964110159, 45454.863628409556, 41972.17320008238, 42579.36130957976, 43117.0, 43343.0, 43820.90447738832, 36096.0, 37501.43747843839, 38252.80873595614, 38647.8405647831, 39084.80457597694, 35273.0, 35290.82354588211, 35949.10127246735, 36414.63585364113, 36530.452043218844, 34555.30889382248, 34782.82608586941, 35040.47439288464, 35592.46611300884, 35713.64286357103, 30854.074377768702, 31607.84196079005, 31669.841650791597, 31680.0, 32676.856310029034, 22790.202342917917, 23884.76115238895, 24495.14267000718, 24587.524748515145, 24891.875540622183], "unit": "score", "name": "ext.html", "value": 19545.823923039097}, {"lowerIsBetter": false, "replicates": [358.3531725235949, 361.6040435722883, 365.5795834789991, 374.95875453700086, 376.57259011022484, 19419.0, 19743.308984185558, 20473.771573705588, 20958.790412095874, 20967.266145684905, 9675.758106047353, 11886.286822790638, 12385.690357741061, 12398.752024959495, 12402.317872517007, 5080.441151473335, 5278.445763194867, 5338.0, 5803.274590676166, 5810.273715785527, 5758.856028599276, 5797.246357973458, 5824.621399609033, 5832.795852145176, 5838.0, 5685.488306052454, 5740.081586946089, 5747.2241247431475, 5769.480746732793, 5786.739596718136, 5543.77824887006, 5719.628224165416, 5723.713814309268, 5769.942300576982, 5777.988851950891, 5041.344625198737, 5087.109755792759, 5105.412877519096, 5106.157484015133, 5114.872128196787, 13592.048556601041, 13677.794833077513, 19140.5214869628, 24781.5043699125, 25458.0, 1974.1511150205406, 2038.785927477623, 2096.67501537262, 2161.3299877038166, 2293.736220334666, 8576.88500494938, 9843.852342214872, 9955.5022248888, 10154.086132248132, 13027.348632568428, 1543.004761928561, 1613.3355837296413, 1646.7529870519518, 1651.0918994552949, 1697.4568138195782, 79324.0, 108721.45639271832, 108816.0, 108845.45577272063, 111934.0, 11273.605423810128, 11292.322460652387, 11377.203595748219, 11405.486753096131, 11525.48135333912, 13903.374348154357, 13966.650833729034, 14013.43946242139, 14024.929875350763, 14028.50900218508, 8394.0, 8561.357898157663, 8592.398532102692, 8653.17794809492, 8683.609237584324, 8583.0, 8642.222200001905, 8681.739547813575, 8760.51817150063, 8768.0, 4414.249577571821, 4498.437695288089, 4505.144022635689, 4550.97724511382, 4554.63562914966, 1807.6023274879506, 1859.8047205043547, 1864.3661155207024, 1865.2352535460395, 1873.9250429982649, 851.7231899632644, 900.342749792655, 902.9458232506071, 918.7978644698155, 980.7401038724744, 16704.081275529963, 20030.298939537337, 20281.594368112554, 20538.486537836674, 20549.69175462369, 856.4390324337569, 958.3387462650749, 960.9567569459391, 1001.2890847498358, 1036.0934182590233, 10766.084882784895, 11092.389918554396, 11101.500432480558, 11107.389093599768, 11119.27724697892, 575991.9603215824, 583881.0, 590206.0, 625767.1156451683, 627614.0, 108260.0, 116878.41560792142, 117231.0, 121039.39480302543, 121213.39393302977, 1027.7430642339416, 1040.3185913226698, 1056.6460235820932, 1058.6241884131177, 1059.3061544688242, 14107.788383174055, 15639.843601564295, 16462.588435289214, 17474.30102795874, 17991.280348786426, 49120.75439622779, 49612.0, 51205.7439712799, 52759.944801102996, 52776.73611632071, 54904.0, 68559.0, 68564.3143568578, 71369.0, 73305.16737081615, 7556.206598307099, 7756.224377562198, 7821.022372203474, 7873.803154921173, 8111.391645626483, 9231.953840230755, 11839.82240266414, 12053.758924821279, 12202.450889710162, 12426.937865310616, 9963.701088967342, 10609.681709548726, 10952.34285942846, 11017.44912754343, 11094.722631934266, 10261.538230779484, 10336.0, 10773.19201059908, 10792.784144317227, 10897.346159230472, 9449.527523623929, 10388.168946484111, 10827.133829293794, 11286.830697539379, 11349.319040857576, 7599.316061554487, 7667.884981725167, 7804.219578042377, 7908.485948413335, 8047.436679432383, 10726.839097413389, 11039.0, 11273.0, 11281.943590281997, 11296.774064518499], "unit": "score", "name": "jquery.html", "value": 9022.294940948854}, {"lowerIsBetter": false, "replicates": [1431.8353389360227, 1560.134125560314, 1564.63094792057, 1685.890417122887, 2011.3362590345196, 7826.373890088794, 8469.237768600824, 8587.48475091495, 8590.0, 8609.827803443943, 8305.958470207655, 8590.87113693295, 8601.91398086019, 8602.139786021395, 8624.611892464838, 2150.2474134053036, 2402.95194096118, 2445.1686426614947, 2462.704475462947, 2489.103922587867, 2484.0, 2493.339265094751, 2496.1263557754824, 2498.088197807796, 2499.8875050622673, 2074.6887966804948, 2198.505336299328, 2401.267613377928, 2435.1842132885504, 2453.374389530667, 2384.6423036544484, 2400.3639035655565, 2401.3756423329887, 2460.8277420580566, 2471.221565206972, 2418.5283869645427, 2463.322586288767, 2470.851748895072, 2471.0609968211966, 2471.4933438645216, 8602.655893764242, 8709.95645021777, 8714.25928796053, 8716.25911797498, 8718.782030449225, 5292.761825717852, 5455.972720136414, 5473.2063850741415, 5497.615166938316, 5499.450054994509, 3611.981940090309, 3654.853805847763, 3731.2164445466483, 3745.2696724138805, 3779.130799916035, 1025.0927928783005, 1034.6068493972243, 1039.7296702857236, 1045.4668119259156, 1060.2737125069352, 11684.883151168464, 11749.765004699944, 11759.412029398582, 11762.764744705059, 11763.882361176364, 4895.31465594817, 4904.950950490449, 4917.87705307363, 4938.407391113017, 4952.380952380952, 9932.10611044995, 9933.850992235122, 9940.155086817702, 9946.80106397868, 9953.552090155961, 4787.138315103245, 5326.92009619856, 5430.15832545956, 5456.645318054314, 5510.6969116698165, 4424.668149888771, 4605.6085232755595, 4791.0, 4984.601231901439, 4992.201247800334, 3169.667184945594, 3325.2518183409024, 3928.6660633845872, 3946.940795888064, 3968.345223038224, 1285.1325355385077, 1296.2416986063258, 1298.3183828490119, 1311.5999620115765, 1314.1983390132011, 1133.8412622232895, 1133.8752737198902, 1146.5471138900089, 1162.6744511536783, 1166.393475392791, 7976.202379761978, 8016.519008859487, 8055.154208808108, 8090.514569125871, 8096.190380961974, 1145.6219447582278, 1171.5021116025655, 1214.7449035702602, 1219.0856857356982, 1241.0381953985734, 6225.00399936008, 6288.6855657217875, 6319.052142178618, 6325.082862984841, 6353.142325786052, 10127.696169114939, 10749.78500429987, 10760.085392741705, 10767.515461804238, 10776.29954052984, 9822.165115965223, 10469.057784799405, 10521.368717876952, 10635.255532112833, 10650.627228046982, 8030.357571394275, 8107.55408452529, 8161.510309381338, 8174.9182508175345, 8259.504429734116, 8044.919550804417, 8049.476784009021, 8088.71689490865, 8129.430939834155, 8159.918400815915, 9561.61753529851, 9654.324197306121, 9699.030096990244, 9722.75693107678, 9741.172000379764, 9794.559244833858, 9922.107010369102, 9986.400815951067, 10089.949550252202, 10091.0, 6716.925291953264, 6891.483138764513, 7330.303621155982, 7333.523320984119, 7449.702011919462, 8112.351011918914, 8132.3900707448365, 8183.140770219041, 8186.590670466334, 8195.426320157532, 7197.532160409557, 7285.162206346338, 7293.38006269473, 7397.889031664637, 7448.813779655552, 7196.568205907663, 7229.168645605822, 7233.0, 7236.023136876454, 7257.274272572911, 7585.2035536270105, 7679.308862202429, 7686.385089192963, 7693.038370203724, 7693.6537855795505, 6298.582818865719, 6630.46956243509, 6914.101166848278, 6917.100776898971, 7016.122984626922, 7031.015657807809, 7113.53762005468, 7117.395021423237, 7120.786376408716, 7140.928590714234], "unit": "score", "name": "mootools.html", "value": 4897.680552784522}, {"lowerIsBetter": false, "replicates": [287.4810966205997, 319.077864970236, 325.3265739918368, 327.0972116957198, 335.7364468891919, 5208.921866172011, 6295.244570651523, 6552.4430423414005, 6586.266699319788, 6592.835179120519, 6336.714847831847, 6493.350664933504, 6503.658682874162, 6536.150300460945, 6536.182977127859, 4537.591616754491, 4656.743879086649, 4659.673822832403, 4786.880327991811, 4795.640326975474, 4749.453812811519, 4750.0, 4756.976215118937, 4770.2606096055, 4782.952170478286, 4689.671722979393, 4709.764511774398, 4726.0, 4759.119562880861, 4765.404324459442, 4553.521880202581, 4588.1511920294515, 4723.409573803275, 4726.66913316068, 4764.642651801111, 4032.8790136295665, 4043.1509383029597, 4043.939340909889, 4054.493188351456, 4059.878203653895, 6106.511479081662, 6179.474744646665, 6199.535034872358, 6211.565190436671, 6220.066989951543, 5488.929658716552, 5499.3675727291475, 5508.669479831223, 5508.91736623951, 5517.172424136412, 6880.58716477013, 6892.621475704879, 6897.931020689779, 6900.861982760367, 6913.481488888303, 4476.440444944382, 4493.168763778712, 4630.282306242504, 4635.397398338195, 4667.369905062841, 7167.569945803217, 7250.601216933067, 7323.340899319087, 7326.926730732731, 7336.376408005326, 4731.077439899186, 4756.21522448799, 4757.9048419032115, 4761.2382018876815, 4763.595094416944, 4819.084373968934, 4819.807207711652, 4826.686265392808, 4827.793051737066, 4839.491853355417, 5636.323641163005, 5637.7181140942785, 5638.35158956717, 5639.379668236491, 5643.927653745775, 6697.564658297195, 6918.619475928772, 6953.721851126, 6965.562053281413, 6966.477514186457, 1652.5703317137632, 1664.9167541622871, 1677.8154403015658, 1678.5803549112723, 1678.6055277009893, 1031.0720351683394, 1092.8961748633867, 1104.1608377633056, 1117.4859564600213, 1127.6335191062938, 6176.258848938156, 6315.715792789244, 6513.54405191632, 6532.248791388956, 6548.1814773153355, 7274.454415918722, 7285.271472852673, 7296.087989001375, 7302.0, 7320.524165929304, 6422.972324428069, 6463.547551671432, 6485.6108633482145, 6502.577332473374, 6526.543141980111, 3088.722015018659, 3820.255050265227, 3824.6175382461533, 3827.923441531154, 3831.9808400958373, 6211.627302361872, 7198.7840364789145, 7580.696772129163, 7584.051993500812, 7608.125065617414, 7395.593242371614, 7459.179490256068, 7467.551946883204, 7472.551646901204, 7484.550926944401, 7544.698212071456, 7551.886721699069, 7553.357964573072, 7558.848823023619, 7565.886511702219, 5479.972600136974, 5835.4748072673665, 6256.906146407717, 7238.963805181151, 7245.38414234796, 6768.323167683192, 7075.469339799432, 7080.575165489881, 7135.0, 7141.428685705235, 6092.482139018233, 7486.577550265432, 7564.978727871887, 7574.394048475999, 7584.393248540214, 4521.570450807168, 4578.0, 4580.9541904581865, 4586.014006988514, 4586.059857729091, 7190.892136618059, 7191.17301510333, 7194.532355396883, 7197.784066478014, 7258.0927384076995, 6692.163479565054, 6894.758683446055, 6976.197737260077, 6977.372036516738, 6988.266232045766, 6908.654567271516, 6953.6523173842115, 6962.582245065312, 6968.233494315723, 6976.19773726028, 6588.868222635616, 6792.694328755119, 6806.659667016728, 6810.31896810315, 6810.455163587, 5885.970570147293, 6951.443884489127, 6961.860762784817, 6962.930370696431, 6982.743106240925, 6526.151600291932, 6604.966975165094, 6689.866202676017, 6759.121314229119, 6856.965715171392], "unit": "score", "name": "prototype.html", "value": 5068.720925978217}, {"lowerIsBetter": false, "replicates": [689.8378880962974, 749.8350362920156, 752.3529764402616, 760.7261385901078, 774.4772278711872, 14665.926670366647, 14844.628884277898, 14847.88640851935, 14848.628784280398, 14857.257137143126, 13553.728925421485, 13655.04414690972, 13720.245386503739, 13733.107348022371, 13755.93122034391, 725.9564426134449, 738.7414404958275, 902.828462592107, 922.3128769067055, 924.0851556958596, 913.0549880873298, 934.397313732642, 937.320442679059, 937.5359197197363, 940.8024314893846, 974.9415035097917, 984.522506584306, 985.1921424431969, 987.9012098790099, 990.6285143071349, 761.4974117082727, 956.1633570625703, 974.3666616699131, 976.5263847034183, 978.0, 729.2561587181045, 729.6935287179398, 730.1749023603347, 730.6858051038051, 730.7625021867862, 14803.185824779634, 14901.701965960729, 14912.850871491255, 14925.0, 14925.776113358308, 12542.24746515212, 12721.936390318082, 12916.289604071771, 13087.86912130876, 13165.144265622705, 9268.536573171314, 9994.00059994002, 10062.158316483203, 10366.637167699095, 10821.134309255242, 3530.947035794465, 3533.5583052118486, 3579.319929213441, 3737.831797569116, 3744.5132132822832, 78137.04657383554, 78802.02994925115, 78856.0, 78907.6054619729, 78912.0, 9004.774880628036, 9098.636054557743, 9261.72214833556, 9477.383970041925, 9802.95098524517, 20188.69716954247, 20680.689789653166, 20782.688259676117, 20819.791802082087, 20820.583588328147, 7538.585377804164, 7547.924520754832, 7561.243875612505, 7704.036995375578, 7718.382529397635, 3925.4111883217747, 4137.441445404892, 4168.291390463629, 4172.83913670214, 4173.853915113017, 3604.5314109165643, 3663.4687970244167, 3666.944995825065, 3668.0646435158865, 3671.0638787109115, 655.4887187993373, 658.4107224034462, 658.5653468710628, 669.5915491550151, 672.7140965089817, 576.2911618709012, 585.1340016775197, 595.4313630482878, 605.2222893581815, 606.0515293565555, 7872.409569282212, 7959.44283900133, 8032.4778889372, 8066.8024277272425, 8370.204830541088, 567.4779203133128, 586.9530437564985, 599.3976054065636, 604.4771272848953, 616.9475594574421, 3710.777353358807, 3743.5882052974152, 3759.5112635357227, 3781.5334783947815, 3844.615538446133, 91487.0, 93552.0, 93679.0, 93893.0, 93948.0605193953, 82323.0, 83471.7479237812, 83631.7455238172, 83983.0, 84879.5756021216, 72646.63676681583, 73730.0, 73778.63110684519, 73811.0, 74002.62998685079, 6191.907121393273, 7561.281678240558, 7615.847683046419, 7858.882116768367, 7986.3610911128135, 50226.24660630021, 51532.96934061373, 51712.48287517077, 51978.0, 52223.47776522186, 59349.703251483465, 64665.67667161634, 66431.33921651998, 66469.66765166144, 67469.0, 9411.81176376455, 9600.951995239979, 9691.176250018827, 9790.216782657513, 10292.228082893962, 10437.425941573287, 10580.523876425734, 10964.177686673373, 11269.943650281695, 11382.373969431761, 9965.053319934595, 9997.55011024491, 10112.544935477774, 10268.743281418025, 10282.588696452058, 10020.849687254842, 10161.796764064826, 10270.33242839213, 10303.330283531546, 10564.788704226026, 9701.029897010243, 9980.500974951368, 10046.397216167054, 10199.38803671782, 10651.786964260516, 8445.704400345958, 8562.058173600773, 8777.297816174818, 8802.955985220033, 8881.023087460504, 8151.551664658501, 8459.154084591491, 8633.611487483204, 8734.213920747163, 8736.475811451333], "unit": "score", "name": "yui.html", "value": 6777.306517699105}], "name": "dromaeo_css", "value": 7434.332400057188}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 111.0, 111.0, 112.0, 112.0, 115.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [176.0, 149.0, 179.0, 161.0, 119.0, 144.0, 139.0, 119.0, 161.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 188.0, 186.0, 184.0, 184.0, 184.0, 182.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [76.0, 98.0, 118.0, 105.0, 57.0, 58.0, 57.0, 81.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 78.2}, {"lowerIsBetter": true, "replicates": [91.0, 97.0, 121.0, 78.0, 80.0, 93.0, 112.0, 79.0, 79.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 92.0, 130.0, 115.0, 89.0, 90.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.2}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 121.0, 149.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 101.1}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 89.0, 84.0, 86.0, 85.0, 88.0, 87.0, 85.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.5}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 54.0, 55.0, 54.0, 54.0, 64.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 75.0, 75.0, 71.0, 69.0, 66.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 82.0, 83.0, 82.0, 84.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [124.0, 125.0, 130.0, 131.0, 106.0, 126.0, 125.0, 148.0, 129.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [141.0, 129.0, 138.0, 140.0, 138.0, 126.0, 137.0, 135.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1432.7}]} 20:18:18 INFO - Return code: 0 20:18:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:18:18 ERROR - # TBPL SUCCESS # 20:18:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:18:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:18:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:18:18 INFO - 2016-03-18 20:18:18.738 screenresolution[1679:9607] starting screenresolution argv=screenresolution get 20:18:18 INFO - 2016-03-18 20:18:18.741 screenresolution[1679:9607] Display 0: 1600x1200x32@60 20:18:18 INFO - 2016-03-18 20:18:18.747 screenresolution[1680:9610] starting screenresolution argv=screenresolution list 20:18:18 INFO - Available Modes on Display 0 20:18:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:18:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:18:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:18:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:18:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:18:18 INFO - Intel Iris: 20:18:18 INFO - Chipset Model: Intel Iris 20:18:18 INFO - Type: GPU 20:18:18 INFO - Bus: Built-In 20:18:18 INFO - VRAM (Dynamic, Max): 1536 MB 20:18:18 INFO - Vendor: Intel (0x8086) 20:18:18 INFO - Device ID: 0x0a2e 20:18:18 INFO - Revision ID: 0x0009 20:18:18 INFO - Displays: 20:18:18 INFO - Display: 20:18:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:18:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:18:18 INFO - Display Serial Number: 1600x1200 60 20:18:18 INFO - Main Display: Yes 20:18:18 INFO - Mirror: Off 20:18:18 INFO - Online: Yes 20:18:18 INFO - Rotation: Supported 20:18:18 INFO - Return code: 0 20:18:18 INFO - Running post-action listener: _resource_record_post_action 20:18:18 INFO - Running post-run listener: _resource_record_post_run 20:18:20 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39187968; Write bytes: 706571264; Read time: 433; Write time: 1927 20:18:20 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389458432; Write bytes: 383031296; Read time: 30012; Write time: 675 20:18:20 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37398016; Write bytes: 300092416; Read time: 414; Write time: 1120 20:18:20 INFO - Running post-run listener: _upload_blobber_files 20:18:20 INFO - Blob upload gear active. 20:18:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:18:20 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 20:18:20 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'] 20:18:20 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 20:18:20 INFO - (blobuploader) - INFO - Open directory for files ... 20:18:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:18:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:21 INFO - (blobuploader) - INFO - Done attempting. 20:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:22 INFO - (blobuploader) - INFO - Done attempting. 20:18:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:18:22 INFO - Return code: 0 20:18:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:18:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:18:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a98ab6d00f6295cd443fd15559616f03243b0e25d01dd7b9b34166ffe2c24660da932142e258853356b5202f328ba19b9440e8a0fddff9d08d04763e49044b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ab5bc01d2269e4b491fd2ecc6e6a22ba58f7c02f0f9c43f7e4017ef9f613be1dc40c3595aa07eb5ac4fa4399c39a10fb9acf84afb5bc9e4d59311616c51d03f"} 20:18:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:18:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:18:22 INFO - Contents: 20:18:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a98ab6d00f6295cd443fd15559616f03243b0e25d01dd7b9b34166ffe2c24660da932142e258853356b5202f328ba19b9440e8a0fddff9d08d04763e49044b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ab5bc01d2269e4b491fd2ecc6e6a22ba58f7c02f0f9c43f7e4017ef9f613be1dc40c3595aa07eb5ac4fa4399c39a10fb9acf84afb5bc9e4d59311616c51d03f"} 20:18:22 INFO - Running post-run listener: copy_logs_to_upload_dir 20:18:22 INFO - Copying logs to upload dir... 20:18:22 INFO - mkdir: /builds/slave/test/build/upload/logs 20:18:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.957621 ========= master_lag: 44.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-03-18 20:19:07.772845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 20:19:07.773973) ========= 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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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/a98ab6d00f6295cd443fd15559616f03243b0e25d01dd7b9b34166ffe2c24660da932142e258853356b5202f328ba19b9440e8a0fddff9d08d04763e49044b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ab5bc01d2269e4b491fd2ecc6e6a22ba58f7c02f0f9c43f7e4017ef9f613be1dc40c3595aa07eb5ac4fa4399c39a10fb9acf84afb5bc9e4d59311616c51d03f"} build_url:https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010632 build_url: 'https://queue.taskcluster.net/v1/task/NS5bMhGbS9avevO7O1BXpw/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/a98ab6d00f6295cd443fd15559616f03243b0e25d01dd7b9b34166ffe2c24660da932142e258853356b5202f328ba19b9440e8a0fddff9d08d04763e49044b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ab5bc01d2269e4b491fd2ecc6e6a22ba58f7c02f0f9c43f7e4017ef9f613be1dc40c3595aa07eb5ac4fa4399c39a10fb9acf84afb5bc9e4d59311616c51d03f"}' ========= master_lag: 0.51 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 20:19:08.294726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 20:19:08.295069) ========= 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.UUHPfkf22T/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.QpbVGe3AZD/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005105 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 20:19:08.366341) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-03-18 20:19:08.366662) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-03-18 20:19:10.640406) ========= ========= Total master_lag: 49.19 =========