builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1456119735.68 results: success (0) buildid: 20160221195056 builduid: e9abe59b5d2a43bf8e0e8291f09b77ad revision: 08d7af2bfe303f01069475abebfe4c2407e9d719 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.684755) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.685167) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.685486) ========= 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.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005518 basedir: '/builds/slave/test' ========= master_lag: 0.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.805013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.805321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.861180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.861457) ========= 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.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005714 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.926005) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.926354) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.926737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:15.927053) ========= 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.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-21 21:42:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.4M=0s 2016-02-21 21:42:16 (48.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:16.075063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:16.075401) ========= 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.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.026570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:16.128215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:16.128550) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08d7af2bfe303f01069475abebfe4c2407e9d719 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 08d7af2bfe303f01069475abebfe4c2407e9d719 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-21 21:42:16,201 truncating revision to first 12 chars 2016-02-21 21:42:16,201 Setting DEBUG logging. 2016-02-21 21:42:16,201 attempt 1/10 2016-02-21 21:42:16,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08d7af2bfe30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-21 21:42:16,790 unpacking tar archive at: mozilla-central-08d7af2bfe30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.838939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:16.986727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:16.987214) ========= echo 08d7af2bfe303f01069475abebfe4c2407e9d719 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'08d7af2bfe303f01069475abebfe4c2407e9d719'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 08d7af2bfe303f01069475abebfe4c2407e9d719 program finished with exit code 0 elapsedTime=0.005807 script_repo_revision: '08d7af2bfe303f01069475abebfe4c2407e9d719' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:17.038593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:17.038930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 21:42:17.060284) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-02-21 21:42:17.060603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:42:17 INFO - MultiFileLogger online at 20160221 21:42:17 in /builds/slave/test 21:42:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:42:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:42:17 INFO - {'append_to_log': False, 21:42:17 INFO - 'base_work_dir': '/builds/slave/test', 21:42:17 INFO - 'blob_upload_branch': 'Firefox', 21:42:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:42:17 INFO - 'branch': 'Firefox', 21:42:17 INFO - 'buildbot_json_path': 'buildprops.json', 21:42:17 INFO - 'config_files': ('talos/mac_config.py',), 21:42:17 INFO - 'default_actions': ('clobber', 21:42:17 INFO - 'read-buildbot-config', 21:42:17 INFO - 'download-and-extract', 21:42:17 INFO - 'populate-webroot', 21:42:17 INFO - 'create-virtualenv', 21:42:17 INFO - 'install', 21:42:17 INFO - 'run-tests'), 21:42:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:42:17 INFO - 'download_minidump_stackwalk': True, 21:42:17 INFO - 'download_symbols': 'ondemand', 21:42:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:42:17 INFO - 'tooltool.py': '/tools/tooltool.py', 21:42:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:42:17 INFO - '/tools/misc-python/virtualenv.py')}, 21:42:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:42:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:42:17 INFO - 'installer_path': 'installer.exe', 21:42:17 INFO - 'log_level': 'info', 21:42:17 INFO - 'log_name': 'talos', 21:42:17 INFO - 'log_to_console': True, 21:42:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:42:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:42:17 INFO - 'opt_config_files': (), 21:42:17 INFO - 'pip_index': False, 21:42:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:42:17 INFO - 'cmd': ('bash', 21:42:17 INFO - '-c', 21:42:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:42:17 INFO - 'enabled': True, 21:42:17 INFO - 'halt_on_failure': False, 21:42:17 INFO - 'name': 'check_screen_resolution'},), 21:42:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:42:17 INFO - 'cmd': ('bash', 21:42:17 INFO - '-c', 21:42:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:42:17 INFO - 'enabled': True, 21:42:17 INFO - 'halt_on_failure': False, 21:42:17 INFO - 'name': 'check_screen_resolution'},), 21:42:17 INFO - 'run_cmd_checks_enabled': True, 21:42:17 INFO - 'sps_profile': False, 21:42:17 INFO - 'sps_profile_interval': 0, 21:42:17 INFO - 'suite': 'dromaeojs', 21:42:17 INFO - 'system_bits': '32', 21:42:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:42:17 INFO - 'title': 't-yosemite-r7-0103', 21:42:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:42:17 INFO - 'use_talos_json': True, 21:42:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:42:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:42:17 INFO - 'work_dir': 'build'} 21:42:17 INFO - ##### 21:42:17 INFO - ##### Running clobber step. 21:42:17 INFO - ##### 21:42:17 INFO - Running pre-action listener: _resource_record_pre_action 21:42:17 INFO - Running main action method: clobber 21:42:17 INFO - rmtree: /builds/slave/test/build 21:42:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:42:18 INFO - Running post-action listener: _resource_record_post_action 21:42:18 INFO - ##### 21:42:18 INFO - ##### Running read-buildbot-config step. 21:42:18 INFO - ##### 21:42:18 INFO - Running pre-action listener: _resource_record_pre_action 21:42:18 INFO - Running main action method: read_buildbot_config 21:42:18 INFO - Using buildbot properties: 21:42:18 INFO - { 21:42:18 INFO - "project": "", 21:42:18 INFO - "product": "firefox", 21:42:18 INFO - "script_repo_revision": "production", 21:42:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:42:18 INFO - "repository": "", 21:42:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:42:18 INFO - "buildid": "20160221195056", 21:42:18 INFO - "pgo_build": "False", 21:42:18 INFO - "basedir": "/builds/slave/test", 21:42:18 INFO - "buildnumber": 130, 21:42:18 INFO - "slavename": "t-yosemite-r7-0103", 21:42:18 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:42:18 INFO - "platform": "yosemite_r7", 21:42:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:42:18 INFO - "branch": "mozilla-central", 21:42:18 INFO - "repo_path": "mozilla-central", 21:42:18 INFO - "revision": "08d7af2bfe303f01069475abebfe4c2407e9d719", 21:42:18 INFO - "stage_platform": "macosx64", 21:42:18 INFO - "builduid": "e9abe59b5d2a43bf8e0e8291f09b77ad", 21:42:18 INFO - "slavebuilddir": "test" 21:42:18 INFO - } 21:42:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 21:42:18 INFO - Running post-action listener: _resource_record_post_action 21:42:18 INFO - ##### 21:42:18 INFO - ##### Running download-and-extract step. 21:42:18 INFO - ##### 21:42:18 INFO - Running pre-action listener: _resource_record_pre_action 21:42:18 INFO - Running main action method: download_and_extract 21:42:18 INFO - mkdir: /builds/slave/test/build/tests 21:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:42:18 INFO - https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:42:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/test_packages.json 21:42:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/test_packages.json 21:42:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:42:24 INFO - Downloaded 1277 bytes. 21:42:24 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:42:24 INFO - Using the following test package requirements: 21:42:24 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:42:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 21:42:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 21:42:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'jsshell-mac.zip'], 21:42:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 21:42:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:42:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 21:42:24 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 21:42:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 21:42:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:42:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:42:24 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 21:42:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:42:24 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')]} 21:42:24 INFO - https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:42:25 INFO - Downloaded 17825449 bytes. 21:42:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:42:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:42:28 INFO - Return code: 0 21:42:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:42:28 INFO - https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:42:30 INFO - Downloaded 17825449 bytes. 21:42:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:42:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:42:34 INFO - Return code: 0 21:42:34 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')]} 21:42:34 INFO - https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:42:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:42:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:42:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:42:35 INFO - Downloaded 10707015 bytes. 21:42:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:42:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:42:35 INFO - Return code: 0 21:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:42:35 INFO - https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:42:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:42:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:42:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 21:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 21:42:38 INFO - Downloaded 111280248 bytes. 21:42:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:42:38 INFO - mkdir: /builds/slave/test/properties 21:42:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:42:38 INFO - Writing to file /builds/slave/test/properties/build_url 21:42:38 INFO - Contents: 21:42:38 INFO - build_url:https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:42:39 INFO - Running post-action listener: _resource_record_post_action 21:42:39 INFO - Running post-action listener: set_extra_try_arguments 21:42:39 INFO - ##### 21:42:39 INFO - ##### Running populate-webroot step. 21:42:39 INFO - ##### 21:42:39 INFO - Running pre-action listener: _resource_record_pre_action 21:42:39 INFO - Running main action method: populate_webroot 21:42:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:42:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:42:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:42:39 INFO - '--tppagecycles', 21:42:39 INFO - '7'], 21:42:39 INFO - 'tests': ['tsvgm']}}, 21:42:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:42:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:42:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:42:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:42:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'tests': ['damp', 'tps']}, 21:42:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['damp', 'tps']}, 21:42:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:42:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:42:39 INFO - 'other': {'tests': ['a11yr', 21:42:39 INFO - 'ts_paint', 21:42:39 INFO - 'tpaint', 21:42:39 INFO - 'sessionrestore', 21:42:39 INFO - 'sessionrestore_no_auto_restore']}, 21:42:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['a11yr', 21:42:39 INFO - 'ts_paint', 21:42:39 INFO - 'tpaint', 21:42:39 INFO - 'sessionrestore', 21:42:39 INFO - 'sessionrestore_no_auto_restore']}, 21:42:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['a11yr', 21:42:39 INFO - 'ts_paint', 21:42:39 INFO - 'tpaint', 21:42:39 INFO - 'sessionrestore', 21:42:39 INFO - 'sessionrestore_no_auto_restore']}, 21:42:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['a11yr', 21:42:39 INFO - 'ts_paint', 21:42:39 INFO - 'tpaint', 21:42:39 INFO - 'sessionrestore', 21:42:39 INFO - 'sessionrestore_no_auto_restore']}, 21:42:39 INFO - 'other_l64': {'tests': ['a11yr', 21:42:39 INFO - 'ts_paint', 21:42:39 INFO - 'tpaint', 21:42:39 INFO - 'sessionrestore', 21:42:39 INFO - 'sessionrestore_no_auto_restore']}, 21:42:39 INFO - 'other_nol64': {'tests': ['a11yr', 21:42:39 INFO - 'ts_paint', 21:42:39 INFO - 'tpaint', 21:42:39 INFO - 'sessionrestore', 21:42:39 INFO - 'sessionrestore_no_auto_restore']}, 21:42:39 INFO - 'svgr': {'tests': ['tsvgx', 21:42:39 INFO - 'tsvgr_opacity', 21:42:39 INFO - 'tart', 21:42:39 INFO - 'tscrollx', 21:42:39 INFO - 'cart']}, 21:42:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['tsvgx', 21:42:39 INFO - 'tsvgr_opacity', 21:42:39 INFO - 'tart', 21:42:39 INFO - 'tscrollx', 21:42:39 INFO - 'cart']}, 21:42:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'tests': ['tp5o']}, 21:42:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'talos_options': ['--e10s'], 21:42:39 INFO - 'tests': ['tp5o']}, 21:42:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'talos_options': ['--xperf_path', 21:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:39 INFO - 'tests': ['tp5n']}, 21:42:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:42:39 INFO - 'talos_options': ['--e10s', 21:42:39 INFO - '--xperf_path', 21:42:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:39 INFO - 'tests': ['tp5n']}}, 21:42:39 INFO - 'talos.zip': {'path': '', 21:42:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:42:39 INFO - Running post-action listener: _resource_record_post_action 21:42:39 INFO - ##### 21:42:39 INFO - ##### Running create-virtualenv step. 21:42:39 INFO - ##### 21:42:39 INFO - Running pre-action listener: _resource_record_pre_action 21:42:39 INFO - Running main action method: create_virtualenv 21:42:39 INFO - Creating virtualenv /builds/slave/test/build/venv 21:42:39 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 21:42:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:42:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:42:39 INFO - Using real prefix '/tools/python27' 21:42:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:42:40 INFO - Installing distribute.............................................................................................................................................................................................done. 21:42:43 INFO - Installing pip.................done. 21:42:43 INFO - Return code: 0 21:42:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:42:43 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')]} 21:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:43 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')]} 21:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:43 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:42:43 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 21:42:43 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 21:42:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:42:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:42:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:42:43 INFO - 'HOME': '/Users/cltbld', 21:42:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:42:43 INFO - 'LOGNAME': 'cltbld', 21:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:43 INFO - 'MOZ_NO_REMOTE': '1', 21:42:43 INFO - 'NO_EM_RESTART': '1', 21:42:43 INFO - 'PAGER': '/bin/cat', 21:42:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:43 INFO - 'PWD': '/builds/slave/test', 21:42:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:42:43 INFO - 'SHELL': '/bin/bash', 21:42:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:42:43 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:42:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:42:43 INFO - 'USER': 'cltbld', 21:42:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:42:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:43 INFO - 'XPC_FLAGS': '0x0', 21:42:43 INFO - 'XPC_SERVICE_NAME': '0', 21:42:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:43 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 21:42:43 INFO - Cleaning up... 21:42:43 INFO - Return code: 0 21:42:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:42:43 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')]} 21:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:43 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')]} 21:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:43 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:42:43 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 21:42:43 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 21:42:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:42:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:42:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:42:43 INFO - 'HOME': '/Users/cltbld', 21:42:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:42:43 INFO - 'LOGNAME': 'cltbld', 21:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:43 INFO - 'MOZ_NO_REMOTE': '1', 21:42:43 INFO - 'NO_EM_RESTART': '1', 21:42:43 INFO - 'PAGER': '/bin/cat', 21:42:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:43 INFO - 'PWD': '/builds/slave/test', 21:42:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:42:43 INFO - 'SHELL': '/bin/bash', 21:42:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:42:43 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:42:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:42:43 INFO - 'USER': 'cltbld', 21:42:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:42:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:43 INFO - 'XPC_FLAGS': '0x0', 21:42:43 INFO - 'XPC_SERVICE_NAME': '0', 21:42:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:43 INFO - Downloading/unpacking psutil>=0.7.1 21:42:43 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 21:42:43 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 21:42:43 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 21:42:43 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 21:42:43 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 21:42:43 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 21:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:42:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:46 INFO - Installing collected packages: psutil 21:42:46 INFO - Running setup.py install for psutil 21:42:46 INFO - building 'psutil._psutil_osx' extension 21:42:46 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 21:42:47 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 21:42:47 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 21:42:47 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 21:42:47 INFO - building 'psutil._psutil_posix' extension 21:42:47 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 21:42:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:42:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:42:47 INFO - ^ 21:42:47 INFO - 1 warning generated. 21:42:47 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 21:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:48 INFO - Successfully installed psutil 21:42:48 INFO - Cleaning up... 21:42:48 INFO - Return code: 0 21:42:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:42: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')]} 21:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42: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')]} 21:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42: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', '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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:42: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:42: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 mozsystemmonitor==0.0.0 21:42:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:42:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:42:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:42:48 INFO - 'HOME': '/Users/cltbld', 21:42:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:42:48 INFO - 'LOGNAME': 'cltbld', 21:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:48 INFO - 'MOZ_NO_REMOTE': '1', 21:42:48 INFO - 'NO_EM_RESTART': '1', 21:42:48 INFO - 'PAGER': '/bin/cat', 21:42:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:48 INFO - 'PWD': '/builds/slave/test', 21:42:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:42:48 INFO - 'SHELL': '/bin/bash', 21:42:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:42:48 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:42:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:42:48 INFO - 'USER': 'cltbld', 21:42:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:42:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:48 INFO - 'XPC_FLAGS': '0x0', 21:42:48 INFO - 'XPC_SERVICE_NAME': '0', 21:42:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:42:50 INFO - Installing collected packages: mozsystemmonitor 21:42:50 INFO - Running setup.py install for mozsystemmonitor 21:42:50 INFO - Successfully installed mozsystemmonitor 21:42:50 INFO - Cleaning up... 21:42:50 INFO - Return code: 0 21:42:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:42:51 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')]} 21:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:51 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')]} 21:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:51 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:42:51 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 21:42:51 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 21:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:42:51 INFO - 'HOME': '/Users/cltbld', 21:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:42:51 INFO - 'LOGNAME': 'cltbld', 21:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:51 INFO - 'MOZ_NO_REMOTE': '1', 21:42:51 INFO - 'NO_EM_RESTART': '1', 21:42:51 INFO - 'PAGER': '/bin/cat', 21:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:51 INFO - 'PWD': '/builds/slave/test', 21:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:42:51 INFO - 'SHELL': '/bin/bash', 21:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:42:51 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:42:51 INFO - 'USER': 'cltbld', 21:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:51 INFO - 'XPC_FLAGS': '0x0', 21:42:51 INFO - 'XPC_SERVICE_NAME': '0', 21:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:51 INFO - Downloading/unpacking blobuploader==1.2.4 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42: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 21:42:53 INFO - Downloading blobuploader-1.2.4.tar.gz 21:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:42:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:42:53 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 21:42:53 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 21:42:53 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 21:42:53 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 21:42:53 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 21:42:53 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 21:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:42:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:54 INFO - Downloading docopt-0.6.1.tar.gz 21:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:42:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:42:54 INFO - Running setup.py install for blobuploader 21:42:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:42:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:42:54 INFO - Running setup.py install for requests 21:42:55 INFO - Running setup.py install for docopt 21:42:55 INFO - Successfully installed blobuploader requests docopt 21:42:55 INFO - Cleaning up... 21:42:55 INFO - Return code: 0 21:42:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:55 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')]} 21:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:55 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')]} 21:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:42:55 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:42:55 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 21:42:55 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 21:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:42:55 INFO - 'HOME': '/Users/cltbld', 21:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:42:55 INFO - 'LOGNAME': 'cltbld', 21:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:55 INFO - 'MOZ_NO_REMOTE': '1', 21:42:55 INFO - 'NO_EM_RESTART': '1', 21:42:55 INFO - 'PAGER': '/bin/cat', 21:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:55 INFO - 'PWD': '/builds/slave/test', 21:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:42:55 INFO - 'SHELL': '/bin/bash', 21:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:42:55 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:42:55 INFO - 'USER': 'cltbld', 21:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:55 INFO - 'XPC_FLAGS': '0x0', 21:42:55 INFO - 'XPC_SERVICE_NAME': '0', 21:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-YgUwsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-OTxDZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gQDxr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-H2oGNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Ls74vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-SnnwPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HbHL9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pe6lrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-YM7EX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-p2nF63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ZiMF4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:57 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-27JFlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:57 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-kTzjS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:57 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-tzS_qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:57 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-p8cKIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:57 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-1Ijg2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:57 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-fYNQRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:42:57 INFO - Running setup.py install for manifestparser 21:42:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:42:57 INFO - Running setup.py install for mozcrash 21:42:57 INFO - Running setup.py install for mozdebug 21:42:58 INFO - Running setup.py install for mozdevice 21:42:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Running setup.py install for mozfile 21:42:58 INFO - Running setup.py install for mozhttpd 21:42:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Running setup.py install for mozinfo 21:42:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Running setup.py install for mozInstall 21:42:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:42:58 INFO - Running setup.py install for mozleak 21:42:58 INFO - Running setup.py install for mozlog 21:42:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:42:59 INFO - Running setup.py install for moznetwork 21:42:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:42:59 INFO - Running setup.py install for mozprocess 21:42:59 INFO - Running setup.py install for mozprofile 21:42:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:42:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:42:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:42:59 INFO - Running setup.py install for mozrunner 21:42:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:42:59 INFO - Running setup.py install for mozscreenshot 21:42:59 INFO - Running setup.py install for moztest 21:43:00 INFO - Running setup.py install for mozversion 21:43:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:43:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:43:00 INFO - Cleaning up... 21:43:00 INFO - Return code: 0 21:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:00 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:43:00 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 21:43:00 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 21:43:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:43:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:43:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:43:00 INFO - 'HOME': '/Users/cltbld', 21:43:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:43:00 INFO - 'LOGNAME': 'cltbld', 21:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:00 INFO - 'MOZ_NO_REMOTE': '1', 21:43:00 INFO - 'NO_EM_RESTART': '1', 21:43:00 INFO - 'PAGER': '/bin/cat', 21:43:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:00 INFO - 'PWD': '/builds/slave/test', 21:43:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:43:00 INFO - 'SHELL': '/bin/bash', 21:43:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:43:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:43:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:43:00 INFO - 'USER': 'cltbld', 21:43:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:43:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:00 INFO - 'XPC_FLAGS': '0x0', 21:43:00 INFO - 'XPC_SERVICE_NAME': '0', 21:43:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:43:00 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Xs7KB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:43:00 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)) 21:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:43:00 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-MFAy0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:43:00 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-U3bIFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:43:00 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)) 21:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:43:00 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-9OAdZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:43:00 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)) 21:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:43:00 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eTJxbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HthJHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-WcNvcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-fLhN4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-3LfXjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ZCZTUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-8Dl7yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-XIAQPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-9dsigq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:43:01 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)) 21:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:43:01 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ojcjRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:43:02 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)) 21:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:43:02 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-2HaQul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:43:02 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)) 21:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:43:02 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-JrcKkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:43:02 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)) 21:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:43:02 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Vt4TVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:43:02 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)) 21:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:43:02 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)) 21:43:02 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)) 21:43:02 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)) 21:43:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:04 INFO - Downloading blessings-1.6.tar.gz 21:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:43:04 INFO - Installing collected packages: blessings 21:43:04 INFO - Running setup.py install for blessings 21:43:04 INFO - Successfully installed blessings 21:43:04 INFO - Cleaning up... 21:43:05 INFO - Return code: 0 21:43:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:43:05 INFO - Reading from file tmpfile_stdout 21:43:05 INFO - Current package versions: 21:43:05 INFO - blessings == 1.6 21:43:05 INFO - blobuploader == 1.2.4 21:43:05 INFO - docopt == 0.6.1 21:43:05 INFO - manifestparser == 1.1 21:43:05 INFO - mozInstall == 1.12 21:43:05 INFO - mozcrash == 0.16 21:43:05 INFO - mozdebug == 0.1 21:43:05 INFO - mozdevice == 0.48 21:43:05 INFO - mozfile == 1.2 21:43:05 INFO - mozhttpd == 0.7 21:43:05 INFO - mozinfo == 0.9 21:43:05 INFO - mozleak == 0.1 21:43:05 INFO - mozlog == 3.1 21:43:05 INFO - moznetwork == 0.27 21:43:05 INFO - mozprocess == 0.22 21:43:05 INFO - mozprofile == 0.28 21:43:05 INFO - mozrunner == 6.11 21:43:05 INFO - mozscreenshot == 0.1 21:43:05 INFO - mozsystemmonitor == 0.0 21:43:05 INFO - moztest == 0.7 21:43:05 INFO - mozversion == 1.4 21:43:05 INFO - psutil == 3.1.1 21:43:05 INFO - requests == 1.2.3 21:43:05 INFO - wsgiref == 0.1.2 21:43:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:43:05 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')]} 21:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:05 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')]} 21:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:05 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:43:05 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 21:43:05 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 21:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:43:05 INFO - 'HOME': '/Users/cltbld', 21:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:43:05 INFO - 'LOGNAME': 'cltbld', 21:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:05 INFO - 'MOZ_NO_REMOTE': '1', 21:43:05 INFO - 'NO_EM_RESTART': '1', 21:43:05 INFO - 'PAGER': '/bin/cat', 21:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:05 INFO - 'PWD': '/builds/slave/test', 21:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:43:05 INFO - 'SHELL': '/bin/bash', 21:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:43:05 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:43:05 INFO - 'USER': 'cltbld', 21:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:05 INFO - 'XPC_FLAGS': '0x0', 21:43:05 INFO - 'XPC_SERVICE_NAME': '0', 21:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 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)) 21:43:05 INFO - Cleaning up... 21:43:05 INFO - Return code: 0 21:43:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:43:05 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')]} 21:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:05 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')]} 21:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:05 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:43:05 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 21:43:05 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 21:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:43:05 INFO - 'HOME': '/Users/cltbld', 21:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:43:05 INFO - 'LOGNAME': 'cltbld', 21:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:05 INFO - 'MOZ_NO_REMOTE': '1', 21:43:05 INFO - 'NO_EM_RESTART': '1', 21:43:05 INFO - 'PAGER': '/bin/cat', 21:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:05 INFO - 'PWD': '/builds/slave/test', 21:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:43:05 INFO - 'SHELL': '/bin/bash', 21:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:43:05 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:43:05 INFO - 'USER': 'cltbld', 21:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:05 INFO - 'XPC_FLAGS': '0x0', 21:43:05 INFO - 'XPC_SERVICE_NAME': '0', 21:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:05 INFO - Downloading/unpacking jsonschema 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:43:08 INFO - Downloading/unpacking functools32 (from jsonschema) 21:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:08 INFO - Downloading functools32-3.2.3-2.tar.gz 21:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:43:08 INFO - warning: no files found matching '*.txt' 21:43:08 INFO - no previously-included directories found matching 'build' 21:43:08 INFO - no previously-included directories found matching 'dist' 21:43:08 INFO - no previously-included directories found matching '.git*' 21:43:08 INFO - Installing collected packages: jsonschema, functools32 21:43:08 INFO - Running setup.py install for functools32 21:43:08 INFO - warning: no files found matching '*.txt' 21:43:08 INFO - no previously-included directories found matching 'build' 21:43:08 INFO - no previously-included directories found matching 'dist' 21:43:08 INFO - no previously-included directories found matching '.git*' 21:43:08 INFO - Successfully installed jsonschema functools32 21:43:08 INFO - Cleaning up... 21:43:08 INFO - Return code: 0 21:43:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:43:08 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 0x10cd8aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc642498c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, '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.W28yJfNX1E/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.UAFHS3tcge/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21:43:08 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 21:43:08 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 21:43:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:43:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:43:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:43:08 INFO - 'HOME': '/Users/cltbld', 21:43:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:43:08 INFO - 'LOGNAME': 'cltbld', 21:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:08 INFO - 'MOZ_NO_REMOTE': '1', 21:43:08 INFO - 'NO_EM_RESTART': '1', 21:43:08 INFO - 'PAGER': '/bin/cat', 21:43:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:08 INFO - 'PWD': '/builds/slave/test', 21:43:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:43:08 INFO - 'SHELL': '/bin/bash', 21:43:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:43:08 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:43:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:43:08 INFO - 'USER': 'cltbld', 21:43:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:43:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:08 INFO - 'XPC_FLAGS': '0x0', 21:43:08 INFO - 'XPC_SERVICE_NAME': '0', 21:43:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:43:09 INFO - Downloading/unpacking flake8 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43: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 21:43:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:43:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:43:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:43:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:43:12 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 21:43:12 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 21:43:12 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 21:43:12 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 21:43:12 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 21:43:12 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 21:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:43:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:43:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:43:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:43:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:43:12 INFO - no previously-included directories found matching 'docs/_build' 21:43:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:43:12 INFO - Running setup.py install for pep8 21:43:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:43:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:43:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:43:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:43:12 INFO - no previously-included directories found matching 'docs/_build' 21:43:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:43:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:43:13 INFO - Cleaning up... 21:43:13 INFO - Return code: 0 21:43:13 INFO - Running post-action listener: _resource_record_post_action 21:43:13 INFO - Running post-action listener: _start_resource_monitoring 21:43:13 INFO - Starting resource monitoring. 21:43:13 INFO - ##### 21:43:13 INFO - ##### Running install step. 21:43:13 INFO - ##### 21:43:13 INFO - Running pre-action listener: _resource_record_pre_action 21:43:13 INFO - Running main action method: install 21:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:43:13 INFO - Reading from file tmpfile_stdout 21:43:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:43:13 INFO - Reading from file tmpfile_stdout 21:43:13 INFO - Output received: 21:43:13 INFO - Usage: mozinstall [options] installer 21:43:13 INFO - Options: 21:43:13 INFO - -h, --help show this help message and exit 21:43:13 INFO - -d DEST, --destination=DEST 21:43:13 INFO - Directory to install application into. [default: 21:43:13 INFO - "/builds/slave/test"] 21:43:13 INFO - --app=APP Application being installed. [default: firefox] 21:43:13 INFO - mkdir: /builds/slave/test/build/application 21:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:43:47 INFO - Reading from file tmpfile_stdout 21:43:47 INFO - Output received: 21:43:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:43:47 INFO - Running post-action listener: _resource_record_post_action 21:43:47 INFO - ##### 21:43:47 INFO - ##### Running run-tests step. 21:43:47 INFO - ##### 21:43:47 INFO - Running pre-action listener: _resource_record_pre_action 21:43:47 INFO - Running main action method: run_tests 21:43:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:43:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:43:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:43:47 INFO - 2016-02-21 21:43:47.200 screenresolution[1656:8599] starting screenresolution argv=screenresolution get 21:43:47 INFO - 2016-02-21 21:43:47.203 screenresolution[1656:8599] Display 0: 1600x1200x32@60 21:43:47 INFO - 2016-02-21 21:43:47.209 screenresolution[1657:8602] starting screenresolution argv=screenresolution list 21:43:47 INFO - Available Modes on Display 0 21:43:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:43:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:43:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:43:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:43:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:43:47 INFO - Intel Iris: 21:43:47 INFO - Chipset Model: Intel Iris 21:43:47 INFO - Type: GPU 21:43:47 INFO - Bus: Built-In 21:43:47 INFO - VRAM (Dynamic, Max): 1536 MB 21:43:47 INFO - Vendor: Intel (0x8086) 21:43:47 INFO - Device ID: 0x0a2e 21:43:47 INFO - Revision ID: 0x0009 21:43:47 INFO - Displays: 21:43:47 INFO - Display: 21:43:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:43:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:43:47 INFO - Display Serial Number: 1600x1200 60 21:43:47 INFO - Main Display: Yes 21:43:47 INFO - Mirror: Off 21:43:47 INFO - Online: Yes 21:43:47 INFO - Rotation: Supported 21:43:47 INFO - Return code: 0 21:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:43:47 INFO - Python 2.7.3 21:43:47 INFO - Return code: 0 21:43:47 INFO - grabbing minidump binary from tooltool 21:43:47 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')]} 21:43:47 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 0x10cc2ed30>, '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 0x10ca52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cc25b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:43:47 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 21:43:47 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 21:43:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:43:47 INFO - Return code: 0 21:43:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:43:48 INFO - Return code: 0 21:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 21:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --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 21:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W28yJfNX1E/Render', 21:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:43:48 INFO - 'HOME': '/Users/cltbld', 21:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:43:48 INFO - 'LOGNAME': 'cltbld', 21:43:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:43:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:43:48 INFO - 'MOZ_NO_REMOTE': '1', 21:43:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:43:48 INFO - 'NO_EM_RESTART': '1', 21:43:48 INFO - 'PAGER': '/bin/cat', 21:43:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:43:48 INFO - 'PWD': '/builds/slave/test', 21:43:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:43:48 INFO - 'SHELL': '/bin/bash', 21:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UAFHS3tcge/Listeners', 21:43:48 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 21:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:43:48 INFO - 'USER': 'cltbld', 21:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:43:48 INFO - 'XPC_FLAGS': '0x0', 21:43:48 INFO - 'XPC_SERVICE_NAME': '0', 21:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:43:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 21:43:48 INFO - mozversion application_buildid: 20160221195056 21:43:48 INFO - mozversion application_changeset: 08d7af2bfe303f01069475abebfe4c2407e9d719 21:43:48 INFO - mozversion application_display_name: Nightly 21:43:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:43:48 INFO - mozversion application_name: Firefox 21:43:48 INFO - mozversion application_remotingname: firefox 21:43:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:43:48 INFO - mozversion application_vendor: Mozilla 21:43:48 INFO - mozversion application_version: 47.0a1 21:43:48 INFO - mozversion platform_buildid: 20160221195056 21:43:48 INFO - mozversion platform_changeset: 08d7af2bfe303f01069475abebfe4c2407e9d719 21:43:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:43:48 INFO - mozversion platform_version: 47.0a1 21:43:48 INFO - using testdate: 1456119828 21:43:48 INFO - actual date: 1456119828 21:43:49 INFO - starting webserver on 'localhost:49274' 21:43:49 INFO - SUITE-START | Running 2 tests 21:43:49 INFO - TEST-START | dromaeo_css 21:43:49 INFO - operating with platform_type : mac_ 21:43:49 INFO - Initialising browser for dromaeo_css test... 21:43:49 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmphQ3XF0/profile http://localhost:49274/getInfo.html) 21:43:51 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 21:43:51 INFO - PROCESS | 1675 | colorDepth:24 21:43:51 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 21:43:51 INFO - PROCESS | 1675 | __metrics 21:43:52 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:43:52 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:43:52 INFO - TEST-INFO | 1675: exit 0 21:43:52 INFO - Browser initialized. 21:43:52 INFO - Running cycle 1/1 for dromaeo_css test... 21:43:52 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmphQ3XF0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:44:04 INFO - PROCESS | 1679 | RSS: Main: 244289536 21:44:04 INFO - PROCESS | 1679 | 21:44:56 INFO - PROCESS | 1679 | 1456119896207 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] 21:47:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 21:47:08 INFO - PROCESS | 1679 | RSS: Main: 369766400 21:47:08 INFO - PROCESS | 1679 | 21:50:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 21:50:11 INFO - PROCESS | 1679 | RSS: Main: 379977728 21:50:11 INFO - PROCESS | 1679 | 21:53:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 21:53:14 INFO - PROCESS | 1679 | RSS: Main: 370995200 21:53:14 INFO - PROCESS | 1679 | 21:56:16 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 21:56:16 INFO - PROCESS | 1679 | RSS: Main: 335818752 21:56:16 INFO - PROCESS | 1679 | 21:59:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 21:59:20 INFO - PROCESS | 1679 | RSS: Main: 336961536 21:59:20 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 22:02:23 INFO - PROCESS | 1679 | RSS: Main: 402788352 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | __start_tp_report 22:02:23 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 22:02:23 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 22:02:23 INFO - PROCESS | 1679 | |i|pagename|runs| 22:02:23 INFO - PROCESS | 1679 | |0;dojo.html;3455.9654403455966;3501.1464460173484;3510.5611798525183;3529.5940966788817;3580.892573222804;5654.293213348332;5694.943050569498;5716.971415142919;5724.885502289946;5743;5670.291213598301;5729.742161602728;5733.827985160452;5734.340550836655;5740.483356497914;4647.395838540993;4886.291487734276;5240.580753539727;5247;5314.681119132845;5327.334083239595;5330.227117068022;5331.920021199685;5332.760025798829;5343.893122137555;5221.634485586011;5241.895162096775;5302.893942121155;5314.707691076989;5319.468053194688;5277.076511610472;5309.7610607522365;5324.068288049576;5328.46715328468;5339.839804805862;5134.666246693953;5171.637985341028;5223.268742376071;5237.659552129137;5245.527902488794;5538.972305138448;5539.086050801613;5554.19464177696;5575.69333686647;5584.441555844423;6139.723712432951;6160.969195153995;6165.290991535986;6168.907466388007;6170.167027451326;6135.416406698409;6140.508759299245;6198.845028874269;6220.284667263232;6249.375062493714;5766.452187042224;5784.4504772046585;5797.275340582427;5804.071348584206;5837.795677151279;6162.722677479434;6287.339829317947;6301.6219026858535;6316.4315211630255;6330.145430366933;6068.630585978089;6113.32428171423;6140.048292514667;6160.661163635953;6174.5060395168275;6192.628442293477;6198.411150940653;6216.191895053614;6219.533534984804;6241.875162496724;6103.115048317969;6115.288719462083;6184.6598437085495;6190.009598464314;6206.162168107338;6161.168242287324;6200.3179650238435;6205.689715514206;6206.596571222856;6213.409726076015;4847.151748444008;4898.657094003385;4899.069176856386;4902.14212512816;4939.357883475125;4365.170617582713;4372.23485889968;4442.933355999663;4462.620677242471;4464.995376040365;4773.856784296477;5835.9708201458725;5836.153757705109;5839.620424672383;5846.298444186725;6158.076288556663;6295.024271237966;6306.180196574416;6315.778947736807;6324.114623952651;5761.740721667451;5826.417358264224;5849.327327357323;5854.619449735754;5892.057270836645;5386.48828361305;5407.567394608422;5408.891822163535;5411.83764487066;5422;6228.34602366745;6293.653849038347;6373.458256048288;6373.808785736435;6377.936220637827;6198.566100372931;6245.5628106032145;6253.093301471352;6255.562110652393;6255.96872015637;6281.748730050746;6285.874282514415;6290.874182516415;6299.590526615755;6304.432601065926;6095.573309868267;6112.5946701277735;6146.200993870947;6203.47270481996;6204.658743768956;6238.532110091671;6247.156633854554;6269.153664255267;6272.09054687077;6283.748650053946;6012.428819262163;6141.048137538689;6147.661878596541;6164.4760195382105;6170.074488826712;6068.302145253352;6072.605280656743;6127.097902969389;6131.743695906945;6144.617461071223;5736.827895163152;5948.167256583995;5949.1076338549565;5954.19618351517;5959.22530071088;6009.969950150221;6062.6665533394325;6132.816015519542;6153.2000839890525;6156.168917196122;5827.912581311199;5915.408459154222;5921.259842519685;5965.791197308074;5986.161937328865 22:02:23 INFO - PROCESS | 1679 | |1;ext.html;428.07322147550553;454.1076784119205;560.2101037537074;573.4924591736312;589.5902347868227;29076.273093172655;38532;38997.41503877444;39075.0231244219;39162.412563811566;35423.11442213946;42076.579234207646;42432.36351454723;42549.574504254946;42680.78659606705;9400.341976061662;9617.182539484118;9617.182539484153;9634.518274086302;9648.71053868385;9500.097490738368;9621.663241786538;9631.133198012178;9632.566534505964;9645.565949532252;9631.229501639851;9662.4202547847;9667.033296670312;9668.081532254424;9680.56437460316;9569.090936361035;9643.27675424346;9649.324547281658;9656.179224765903;9664.323497355188;9501.762455938657;9656.22750179984;9665.371750836173;9666.709998700051;9671.081247281498;38915.02712432184;39322.60677393218;39354.60645393567;39386;39457.60542394568;3221.387936292097;3246.805191688506;3360.4455264881267;3529.9294014119832;3638.5451818522683;27977.580336294974;28194.85902570474;28226.2943426416;28721.425571488453;28891.85554072216;2791.0649932272713;2801.859907004662;2851.957220641692;2872.741453269216;2976.598159248517;354255.2287238573;355046;356949;358017;358594;43295;43392.3491147633;43465.69602911918;56875;57429.71285143548;42633.93415164584;42876.57123428788;42887.142257155305;42978.785106074894;43033.35449968253;14822.851771482363;14964.401423943138;14986.175760333286;14986.625334366729;14991.17548534841;12208.75582488363;12222.388880556115;12256.08079394049;12262.957648599791;12263.816042759367;14193.07744996572;14218.715625687428;14231.85768142326;14257;14339.354729037219;6196.690165491707;6234.657093859791;6257.2491301044165;6258.870564717641;6290.21372328459;904.5206040798388;977.2426369563645;981.4651015196735;1040.2614143957724;1066.0192622787054;25875.48249035009;26673.06644267441;27181.728182718314;27223.727762722516;27254.182374528795;900.2662829793697;969.3699095587924;1080.8216644253766;1082.480409403475;1084.203110713625;14284;14551.3451894665;15580.532584022498;15617.687646247012;16018.679626407407;654124;661188;669868;701304;711269;54460.638484038216;54494.91010179854;55148.448515515134;55154.44845551493;55336;1441.8774404175554;1442.9971170036724;1456.3228098934046;1458.3510337899745;1558.532440267915;25551;30142.69857301399;30374.240643984078;30823.691763082083;31116.853430068782;51716;51753.48246517637;52421.21368179557;52453.950920980606;52553;509858;513997;514041;514143;514611;31779;32177.678223217466;41531.792341038104;42807.792870033045;43036;40135.59864401319;40863.7956810214;40965.795171025144;41021.794891025354;41781.328746851;34361.312773743884;34949.30101398009;35156.47265290972;35388.11529711778;35621.64378356287;33167.83416082904;33538.664613353554;34605.30789384249;35519.46720799242;35638.465423018155;35407.64592354043;36305.81847090748;36380.45429318615;36463.81768091142;36585.81707091554;28516.57225141666;29438.969636062637;30223.848880755457;32152.839235803673;32244.35511289808;22160.889195554562;24033.879830600734;24120.517589648458;24506.754932450447;24714.50570988606 22:02:23 INFO - PROCESS | 1679 | |2;jquery.html;317.960254968129;362.5540585080351;369.31123454756886;369.6192921291071;374.24029220682024;15313.157776322298;15825.05049697019;18736.156872940715;19050.523736906565;19484.51288717783;18467.35364262251;18643.720344194815;19244;19244.230230790785;19298.90350548249;5161.561267292275;5617.634853734515;5895.764169433239;5926.4073592640825;5973.940260597382;4086.509618845743;4291.141771645668;5770.278715160605;6086.269647642289;6353.714082866259;6294.779682711106;6300.180976473052;6300.653464059475;6312.621242725451;6318.210223722035;6188.443040126388;6191.566590338678;6379.904301435482;6386.64873431961;6389.584676995981;5500.4499550045075;5515.283013208297;5523.696196709179;5526.972365138148;5532.834014979557;24079.157229497057;24598.893049812803;24824.751752482603;24878.626820597707;24912.878920448624;2105.4420578546697;2124.7768984256586;2287.1537531113427;2316.8030717389042;2348.988255058731;13908;14121.223332716696;14169.716605667829;14226.145213635762;14690.63273418173;1651.644896347279;1699.864010879139;1721.122227663888;1759.727242277449;1797.8921264724027;88418;88769;89730;90327.09672903319;94959;10050.246231532517;10269.640562580424;10486.26596138263;10506.73733156662;10566.154707623371;12715.173513721578;12716.491340346467;12719.173253738478;12757.936210318889;12768.872311276768;8066.7579972600915;8205.917940820635;8212.917870821335;8255.339572834158;8293.046299675494;8285.4200205985;8286.917130828735;8310.501369917703;8377.036640786266;8430;4529.886752831206;6024.457798798042;6050.485708714808;6052.213212282375;6069.969650151721;1643.967120657604;1727.497077542546;1730.853741360729;1758.5603599100225;1836.2471386731377;418.57892455114717;421.8586773430935;423.4770058977161;459.0383147306454;868.1882439918696;11205;11308.151888608387;11391.544338226544;11505.079593632488;11944.761104777856;385.7319163181618;452.0461825548091;462.28115280738103;464.40787995306255;467.6048738815695;10788.51451684676;11076.612318568812;11174.944125279322;11178.385188814693;11215.383153926448;610706;639390.8030459818;645278;667152;669318;118767;123971.76028239782;125333.37333313457;126253.10620340702;127774;1036.8237399642078;1037.2687255484866;1039.1323245090434;1075.1936047964027;1098.9505472253768;17794.5551361217;18039.647026472805;18077.638447230718;18116.456506304832;18401.3559525416;54254.728726356116;54629.18056229239;54776.17835732547;54927.450725492236;55068.44931550793;74149.62925185339;77366;78202;78865.02837428881;79035.20964790278;7688.884666729891;7940.483868548526;8149.388795840454;8251.793705157179;8280.461769984931;8437.578121094044;10248.59005639796;12757.936210318889;13580.52468163649;13583.52457663977;10701.250912436055;11189.832152517882;11194.832077519006;11284.266522676;11344.376059316817;9787.217022638315;10854.782904342026;11233.943830280796;11303.43482825839;11418.429078546205;11545.595904143314;11559.422028898352;11593.304401735923;11659.300441973508;11710.00464960488;6229.750809967551;6706.631135287606;7873.763787086396;8110.026796784424;8232.547209903512;8468.872966905377;9792.167665748491;11058.557657693924;11595.13036522281;11613.114656418089 22:02:23 INFO - PROCESS | 1679 | |3;mootools.html;1418.2270662488943;1528.9541313760585;1582.1298285942732;1812.0848971269506;1948.5810550731599;7792.571408572526;8371.581420928953;8549.572521373937;8552.657893684262;8558.400911936167;8276.83446331073;8498.065212826585;8499.702510412137;8507.489550626951;8510.404271700983;2147.194801949269;2204.812590929773;2414.215380001502;2437.695288088989;2439.0975339124548;1869.9065046747676;2413.3966508372905;2476.0590975429313;2476.950460990779;2478.5166892455977;2397.7482364351754;2424.4544977380037;2431.489387228684;2431.659567660529;2454.361865914866;2411.0476361836977;2438.8658623775686;2447.3269850791;2448.6327050942323;2451.44842410458;2430.9756902430927;2439.902403903842;2441.4628781668002;2442.1330427698267;2460.803135749136;8547.871781923277;8600.311975041981;8622.137786221328;8623;8667.609957551926;5253.3170687810725;5290.206469029637;5356.571474282087;5381.919271210935;5387.838364849061;3641.6904563112166;3704.685101766353;3709.51776269086;3765.190484045916;3774.698024158088;1054.093479607537;1065.1425602390073;1074.666853275487;1075.5052675769155;1087.8857719939451;11525.42372881361;11566.363849988247;11585.6524304271;11608.361540115291;11613.593524226611;4829.517048295143;4849;4857.125717370836;4906.386701662293;4911.950880491221;9879.75300617476;9884.851727224097;9886.50567471638;9889.505524723734;9932.006799320156;5364.8658783529945;5374.059539580558;5383.946160538423;5399.136138217867;5400.567954563626;3737.626237376295;4329.96080940572;4695.060987802385;4890.706557606555;4890.731009794425;3598.586162591283;3612.7716576363637;3905.902352441155;3938.7636741795586;3968.980155099206;1300.3758196065942;1311.7901135818224;1312.1274352555633;1323.5103011885665;1325.032726109945;1311.9212847229196;1342.9865701343058;1357.470586471277;1358.5245164192454;1365.41287246483;7931.325837303779;7983.880241796378;8258.380621453414;8273.420860539705;8279.875801862976;1193.5822462138183;1205.73473835756;1208.4803534480081;1212.4119801896074;1228.7542491501736;6206.813795586139;6218.378162183745;6261.24865016201;6277.466415354746;6283;10149.137323327452;10489.842652360221;10502.002309780559;10509.264351495474;10623.89376106229;9889.20886329092;10336.896631033593;10468.895311046945;10479;10521.158307335394;8032.919670803217;8047.959760201162;8139.79650508742;8142.51144931306;8155.836883262302;7841.176676448891;7888.684452621831;7940.364770818436;7960.920390796018;7964.482308649919;9147.222486088756;9159.496227707274;9162.129597688208;9355.719328420158;9414.811703766023;9376.906230937604;9644.03559644058;9672.274579406432;9715.417074975525;9907.950460247652;6762.8985565217545;6923.099997000358;7178.712851485882;7397.704091836266;7540.208278130936;8068.47554908929;8106.594670266345;8114.959425202836;8137.8372432552205;8145.674173033012;7125.893111603226;7183.066201393785;7240.746573869889;7341.669624866787;7377.1885092638695;7018.298170183145;7043.929560704532;7093.467989900675;7148.64256787169;7172.820679483055;7377.815554610963;7585.355244804254;7597.582132982739;7602.46782725204;7607.505512141693;6812.761553345807;6907.34380233877;6917.654117294216;6919.37725604698;6921.2732663069655;6904.758333458305;7055.929440705732;7067.787966361017;7076.540024898365;7078.539894906815 22:02:23 INFO - PROCESS | 1679 | |4;prototype.html;267.69349095285895;328.57285528812537;329.5699112657981;332.55437713463954;339.7774457730184;6315.9368406315925;6494.610323380589;6503.2196136463635;6567.146270984771;6599.868002639956;6398.3601639836;6489.35106489352;6500.25247096584;6529.216494020712;6573.737050517973;4564.132814765184;4687.086018226447;4698.671093023489;4819.927701084478;4833.960698449832;4750.144973904696;4765.928511072319;4767.332573439721;4792.640551958617;4806.687565308262;4709.081729062834;4736.621070314367;4746.098241334153;4750.4299484061785;4770.880727981794;4518.186726389248;4639.628829693616;4746.288056791474;4760.309755085494;4766.594839438651;4042.7776472294013;4053.655439287664;4057.2696914555368;4057.6348128668265;4058.02607374231;6161.4146656067605;6179.721912513947;6183.443490085869;6204.534659900525;6214.937850621481;5478.890422191574;5492.505674489315;5498.202760599691;5498.9826882026955;5512.173174023888;6838.7264509419565;6849.623270720109;6859.519833611649;6861.2795656455855;6861.862762744717;4294.957050429487;4462.754548499831;4488.214562451558;4488.910221795579;4491.056878055612;7159.427245820322;7263.89104163438;7267.927320726778;7292.34368906801;7300.160481544637;4542.636589072867;4550.567696068868;4551.180787458289;4552.226121559343;4554.134714404318;4596.770161491979;4604.746738929324;4607.2398054320665;4615.815367385334;4618.983823558811;5444.292242008513;5460.706503268557;5463.399026107125;5463.781448742086;5468.644538105011;6581;6849.726010959605;6859.868121759854;6895.379415852497;6955.617441040791;1592.3789722008426;1610.428297954233;1614.007385457935;1614.4188092286768;1615.5557221763875;959.9392671098475;973.868527748759;1023.4064242739194;1027.5222021759917;1048.4443245079967;6406.8718625627225;6500.674966251669;6517.348265173539;6517.4134327910715;6533.346665333524;7167.032450619204;7180.281971802882;7182.209956904736;7190.352868241884;7195.172555156224;6476.643784591798;6478.578892372075;6488.994205898093;6495.545311828127;6496.805095847132;3751.0997360633796;3804.6956243500454;3807.010177353908;3810.48558444612;3813.828377723009;7270.091238595176;7486.101667799899;7520.097588289331;7545.584992825447;7594.81012974669;7451.366633836076;7480.17718051014;7484;7487.775366739006;7493.6511427942405;7551.244875512405;7554.811129721801;7567.091948966269;7573.583452910143;7578.962105189439;6980.406665433292;7202.96398518004;7210.531315464478;7213.71145154188;7229.09636295463;6565.621219543758;7141.857162856818;7179.353858152791;7188.3530482254755;7199.568025918462;6835.726570937306;7620.390368770374;7628.237176282328;7629.351505122127;7637.427192960439;4540.772961351985;4585.19759042173;4589.770511474346;4593.793279302373;4594.0582180653555;5118;7142.464315176487;7171.067761191011;7178.569285842657;7182.928170718226;6709.798706038827;6944.2708515607155;6956.756513522002;6967.895481567882;6968.756093536702;6056.152138700498;6856.868616678193;6947.7220911162985;6947.826304342432;6950.270221626656;6771.187457505131;6781.966090169518;6787.21946976104;6787.762428315183;6790.694418751267;6673.265940746417;6945.236024037251;6955.965220173866;6956.373926346653;6956.582605043714;6546.901796473152;6637.6681165940545;6709.060731497691;6738.225104113089;6778 22:02:23 INFO - PROCESS | 1679 | |5;yui.html;679.5888487465083;686.7081490366593;700.5761514283855;710.2435905760368;728.7340120855886;14776.187309697962;14865.702685946275;15061.171635560067;15078.849211507883;15089.547313580582;13722;13872.861271387283;13919.860801391984;13928.233947132903;13928.930355348235;713.9571625702474;723.7322190789415;866.6576702202642;873.026575368466;881.039666763228;883.5626364949359;885.2519620920312;887.1926546842375;887.3344991256557;887.4763889305309;927.3601215161517;930.1907340613676;930.5440334236209;933.5425641435716;934.2479304160148;733.611186071383;741.2735519191169;741.929516695913;743.1824992508225;906.3972458315278;674.0563211503934;675.0279597379806;677.9762708305235;681.7375310505441;683.2518392360357;15040.398384064625;15090.245487725679;15105.47130850415;15115.697686046218;15128.319225634763;13045.478180872753;13092.541761038414;13173.341332933314;13474.865251347459;13590.864091359059;10131.189504839595;10148.746281342952;10376.066154046097;10489.63286284984;10836.458177091194;3516.0423157382056;3531.876384326536;3554.20030493137;3632.382494975834;3718.535183102112;81854.18145818525;81885.18114818895;83145.58427207886;83314;84265.57867210686;9270.490123043162;9273.072692730673;9299.53502324881;9324.90675093254;9556.713298601053;20421.48946276355;20424.38726838197;20445.182192712124;20459.28392506255;20478.795212047688;7031.437485001187;7332.81489149862;7354.889676654854;7418.443616728659;7524.736634217886;4059.0055436417674;4060.898477538026;4064.7967601620394;4088.4889388826396;4106.973256685828;3491.581010278732;3516.384632689269;3518.2963407318125;3524.6122926478065;3526.9647303526635;630.8990561510136;650.6844180572418;654.5614438326332;661.798151563768;663.7975417497613;472.6384315998264;563.9464250896158;580.613891761982;589.2910559377754;590.6249531547412;8420.434117945866;8454.915450845536;8593.097724738938;8640.438371505832;8731.563421828883;490.4996903158758;573.320615071142;595.8718875441714;608.0939400293531;615.9538034647419;3884.6503814656817;4292.441982542312;4299.204647140289;4331.848385306499;4399.274119770266;94904.52547737217;98615.52076718854;98831.50584247033;98859;98912;75335.62332188305;80934.595327023;81099.7835032475;82819;83236;72279.55440891153;72736.63631681913;72991.63504182445;73630.2636973634;74466.8829967551;8567.27178189861;8617.353698472765;8664.23117888893;8816.382853200214;8866.77402789064;45879.54120458753;47705.761471192425;47776;48515.6335929768;48864.033904065036;65550;66826.66586667036;70632.64683676549;71632;72855.27144728485;10891;10921.781564368826;10966.067884229611;11097.611583594535;11320.377379243891;11926.986206172573;12292.502498172793;12310.26138431697;12401.069919755873;12625.81061284063;6079.945501889167;10398.636047738595;10647.094996925038;11241.55033798639;11337;11001.729612257599;11023.44882755875;11210.775784484427;11268.83096753533;11725.472353743931;10730.8926910733;10881.619143330263;11291.491882865126;11754.177207595729;11823.763524729286;9317.208037316905;9564.138714386163;9754.658586949707;9841.360311579725;10011.749706257402;8881.955590222007;9178.173964342974;10034.8702053468;10038.247600786968;10103.292769506357 22:02:23 INFO - PROCESS | 1679 | __end_tp_report 22:02:23 INFO - PROCESS | 1679 | __start_cc_report 22:02:23 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1209 22:02:23 INFO - PROCESS | 1679 | __end_cc_report 22:02:23 INFO - PROCESS | 1679 | __startTimestamp1456120943689__endTimestamp 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | ------- Summary: start ------- 22:02:23 INFO - PROCESS | 1679 | Number of tests: 6 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5750.03 Median:5959.23 stddev:622.56 (10.4%) stddev-sans-first:597.90 22:02:23 INFO - PROCESS | 1679 | Values: 3456.0 3501.1 3510.6 3529.6 3580.9 5654.3 5694.9 5717.0 5724.9 5743.0 5670.3 5729.7 5733.8 5734.3 5740.5 4647.4 4886.3 5240.6 5247.0 5314.7 5327.3 5330.2 5331.9 5332.8 5343.9 5221.6 5241.9 5302.9 5314.7 5319.5 5277.1 5309.8 5324.1 5328.5 5339.8 5134.7 5171.6 5223.3 5237.7 5245.5 5539.0 5539.1 5554.2 5575.7 5584.4 6139.7 6161.0 6165.3 6168.9 6170.2 6135.4 6140.5 6198.8 6220.3 6249.4 5766.5 5784.5 5797.3 5804.1 5837.8 6162.7 6287.3 6301.6 6316.4 6330.1 6068.6 6113.3 6140.0 6160.7 6174.5 6192.6 6198.4 6216.2 6219.5 6241.9 6103.1 6115.3 6184.7 6190.0 6206.2 6161.2 6200.3 6205.7 6206.6 6213.4 4847.2 4898.7 4899.1 4902.1 4939.4 4365.2 4372.2 4442.9 4462.6 4465.0 4773.9 5836.0 5836.2 5839.6 5846.3 6158.1 6295.0 6306.2 6315.8 6324.1 5761.7 5826.4 5849.3 5854.6 5892.1 5386.5 5407.6 5408.9 5411.8 5422.0 6228.3 6293.7 6373.5 6373.8 6377.9 6198.6 6245.6 6253.1 6255.6 6256.0 6281.7 6285.9 6290.9 6299.6 6304.4 6095.6 6112.6 6146.2 6203.5 6204.7 6238.5 6247.2 6269.2 6272.1 6283.7 6012.4 6141.0 6147.7 6164.5 6170.1 6068.3 6072.6 6127.1 6131.7 6144.6 5736.8 5948.2 5949.1 5954.2 5959.2 6010.0 6062.7 6132.8 6153.2 6156.2 5827.9 5915.4 5921.3 5965.8 5986.2 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:64200.20 Median:38956.22 stddev:142930.35 (366.9%) stddev-sans-first:143251.11 22:02:23 INFO - PROCESS | 1679 | Values: 428.1 454.1 560.2 573.5 589.6 29076.3 38532.0 38997.4 39075.0 39162.4 35423.1 42076.6 42432.4 42549.6 42680.8 9400.3 9617.2 9617.2 9634.5 9648.7 9500.1 9621.7 9631.1 9632.6 9645.6 9631.2 9662.4 9667.0 9668.1 9680.6 9569.1 9643.3 9649.3 9656.2 9664.3 9501.8 9656.2 9665.4 9666.7 9671.1 38915.0 39322.6 39354.6 39386.0 39457.6 3221.4 3246.8 3360.4 3529.9 3638.5 27977.6 28194.9 28226.3 28721.4 28891.9 2791.1 2801.9 2852.0 2872.7 2976.6 354255.2 355046.0 356949.0 358017.0 358594.0 43295.0 43392.3 43465.7 56875.0 57429.7 42633.9 42876.6 42887.1 42978.8 43033.4 14822.9 14964.4 14986.2 14986.6 14991.2 12208.8 12222.4 12256.1 12263.0 12263.8 14193.1 14218.7 14231.9 14257.0 14339.4 6196.7 6234.7 6257.2 6258.9 6290.2 904.5 977.2 981.5 1040.3 1066.0 25875.5 26673.1 27181.7 27223.7 27254.2 900.3 969.4 1080.8 1082.5 1084.2 14284.0 14551.3 15580.5 15617.7 16018.7 654124.0 661188.0 669868.0 701304.0 711269.0 54460.6 54494.9 55148.4 55154.4 55336.0 1441.9 1443.0 1456.3 1458.4 1558.5 25551.0 30142.7 30374.2 30823.7 31116.9 51716.0 51753.5 52421.2 52454.0 52553.0 509858.0 513997.0 514041.0 514143.0 514611.0 31779.0 32177.7 41531.8 42807.8 43036.0 40135.6 40863.8 40965.8 41021.8 41781.3 34361.3 34949.3 35156.5 35388.1 35621.6 33167.8 33538.7 34605.3 35519.5 35638.5 35407.6 36305.8 36380.5 36463.8 36585.8 28516.6 29439.0 30223.8 32152.8 32244.4 22160.9 24033.9 24120.5 24506.8 24714.5 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:35103.24 Median:12615.42 stddev:107018.78 (848.3%) stddev-sans-first:107287.12 22:02:23 INFO - PROCESS | 1679 | Values: 318.0 362.6 369.3 369.6 374.2 15313.2 15825.1 18736.2 19050.5 19484.5 18467.4 18643.7 19244.0 19244.2 19298.9 5161.6 5617.6 5895.8 5926.4 5973.9 4086.5 4291.1 5770.3 6086.3 6353.7 6294.8 6300.2 6300.7 6312.6 6318.2 6188.4 6191.6 6379.9 6386.6 6389.6 5500.4 5515.3 5523.7 5527.0 5532.8 24079.2 24598.9 24824.8 24878.6 24912.9 2105.4 2124.8 2287.2 2316.8 2349.0 13908.0 14121.2 14169.7 14226.1 14690.6 1651.6 1699.9 1721.1 1759.7 1797.9 88418.0 88769.0 89730.0 90327.1 94959.0 10050.2 10269.6 10486.3 10506.7 10566.2 12715.2 12716.5 12719.2 12757.9 12768.9 8066.8 8205.9 8212.9 8255.3 8293.0 8285.4 8286.9 8310.5 8377.0 8430.0 4529.9 6024.5 6050.5 6052.2 6070.0 1644.0 1727.5 1730.9 1758.6 1836.2 418.6 421.9 423.5 459.0 868.2 11205.0 11308.2 11391.5 11505.1 11944.8 385.7 452.0 462.3 464.4 467.6 10788.5 11076.6 11174.9 11178.4 11215.4 610706.0 639390.8 645278.0 667152.0 669318.0 118767.0 123971.8 125333.4 126253.1 127774.0 1036.8 1037.3 1039.1 1075.2 1099.0 17794.6 18039.6 18077.6 18116.5 18401.4 54254.7 54629.2 54776.2 54927.5 55068.4 74149.6 77366.0 78202.0 78865.0 79035.2 7688.9 7940.5 8149.4 8251.8 8280.5 8437.6 10248.6 12757.9 13580.5 13583.5 10701.3 11189.8 11194.8 11284.3 11344.4 9787.2 10854.8 11233.9 11303.4 11418.4 11545.6 11559.4 11593.3 11659.3 11710.0 6229.8 6706.6 7873.8 8110.0 8232.5 8468.9 9792.2 11058.6 11595.1 11613.1 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5954.14 Median:5385.89 stddev:3093.76 (57.4%) stddev-sans-first:3083.65 22:02:23 INFO - PROCESS | 1679 | Values: 1418.2 1529.0 1582.1 1812.1 1948.6 7792.6 8371.6 8549.6 8552.7 8558.4 8276.8 8498.1 8499.7 8507.5 8510.4 2147.2 2204.8 2414.2 2437.7 2439.1 1869.9 2413.4 2476.1 2477.0 2478.5 2397.7 2424.5 2431.5 2431.7 2454.4 2411.0 2438.9 2447.3 2448.6 2451.4 2431.0 2439.9 2441.5 2442.1 2460.8 8547.9 8600.3 8622.1 8623.0 8667.6 5253.3 5290.2 5356.6 5381.9 5387.8 3641.7 3704.7 3709.5 3765.2 3774.7 1054.1 1065.1 1074.7 1075.5 1087.9 11525.4 11566.4 11585.7 11608.4 11613.6 4829.5 4849.0 4857.1 4906.4 4912.0 9879.8 9884.9 9886.5 9889.5 9932.0 5364.9 5374.1 5383.9 5399.1 5400.6 3737.6 4330.0 4695.1 4890.7 4890.7 3598.6 3612.8 3905.9 3938.8 3969.0 1300.4 1311.8 1312.1 1323.5 1325.0 1311.9 1343.0 1357.5 1358.5 1365.4 7931.3 7983.9 8258.4 8273.4 8279.9 1193.6 1205.7 1208.5 1212.4 1228.8 6206.8 6218.4 6261.2 6277.5 6283.0 10149.1 10489.8 10502.0 10509.3 10623.9 9889.2 10336.9 10468.9 10479.0 10521.2 8032.9 8048.0 8139.8 8142.5 8155.8 7841.2 7888.7 7940.4 7960.9 7964.5 9147.2 9159.5 9162.1 9355.7 9414.8 9376.9 9644.0 9672.3 9715.4 9908.0 6762.9 6923.1 7178.7 7397.7 7540.2 8068.5 8106.6 8115.0 8137.8 8145.7 7125.9 7183.1 7240.7 7341.7 7377.2 7018.3 7043.9 7093.5 7148.6 7172.8 7377.8 7585.4 7597.6 7602.5 7607.5 6812.8 6907.3 6917.7 6919.4 6921.3 6904.8 7055.9 7067.8 7076.5 7078.5 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:5670.71 Median:6500.46 stddev:1819.16 (28.0%) stddev-sans-first:1778.49 22:02:23 INFO - PROCESS | 1679 | Values: 267.7 328.6 329.6 332.6 339.8 6315.9 6494.6 6503.2 6567.1 6599.9 6398.4 6489.4 6500.3 6529.2 6573.7 4564.1 4687.1 4698.7 4819.9 4834.0 4750.1 4765.9 4767.3 4792.6 4806.7 4709.1 4736.6 4746.1 4750.4 4770.9 4518.2 4639.6 4746.3 4760.3 4766.6 4042.8 4053.7 4057.3 4057.6 4058.0 6161.4 6179.7 6183.4 6204.5 6214.9 5478.9 5492.5 5498.2 5499.0 5512.2 6838.7 6849.6 6859.5 6861.3 6861.9 4295.0 4462.8 4488.2 4488.9 4491.1 7159.4 7263.9 7267.9 7292.3 7300.2 4542.6 4550.6 4551.2 4552.2 4554.1 4596.8 4604.7 4607.2 4615.8 4619.0 5444.3 5460.7 5463.4 5463.8 5468.6 6581.0 6849.7 6859.9 6895.4 6955.6 1592.4 1610.4 1614.0 1614.4 1615.6 959.9 973.9 1023.4 1027.5 1048.4 6406.9 6500.7 6517.3 6517.4 6533.3 7167.0 7180.3 7182.2 7190.4 7195.2 6476.6 6478.6 6489.0 6495.5 6496.8 3751.1 3804.7 3807.0 3810.5 3813.8 7270.1 7486.1 7520.1 7545.6 7594.8 7451.4 7480.2 7484.0 7487.8 7493.7 7551.2 7554.8 7567.1 7573.6 7579.0 6980.4 7203.0 7210.5 7213.7 7229.1 6565.6 7141.9 7179.4 7188.4 7199.6 6835.7 7620.4 7628.2 7629.4 7637.4 4540.8 4585.2 4589.8 4593.8 4594.1 5118.0 7142.5 7171.1 7178.6 7182.9 6709.8 6944.3 6956.8 6967.9 6968.8 6056.2 6856.9 6947.7 6947.8 6950.3 6771.2 6782.0 6787.2 6787.8 6790.7 6673.3 6945.2 6956.0 6956.4 6956.6 6546.9 6637.7 6709.1 6738.2 6778.0 22:02:23 INFO - PROCESS | 1679 | 22:02:23 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:18646.07 Median:3337.91 stddev:26681.61 (799.4%) stddev-sans-first:26722.35 22:02:23 INFO - PROCESS | 1679 | Values: 679.6 686.7 700.6 710.2 728.7 14776.2 14865.7 15061.2 15078.8 15089.5 13722.0 13872.9 13919.9 13928.2 13928.9 714.0 723.7 866.7 873.0 881.0 883.6 885.3 887.2 887.3 887.5 927.4 930.2 930.5 933.5 934.2 733.6 741.3 741.9 743.2 906.4 674.1 675.0 678.0 681.7 683.3 15040.4 15090.2 15105.5 15115.7 15128.3 13045.5 13092.5 13173.3 13474.9 13590.9 10131.2 10148.7 10376.1 10489.6 10836.5 3516.0 3531.9 3554.2 3632.4 3718.5 81854.2 81885.2 83145.6 83314.0 84265.6 9270.5 9273.1 9299.5 9324.9 9556.7 20421.5 20424.4 20445.2 20459.3 20478.8 7031.4 7332.8 7354.9 7418.4 7524.7 4059.0 4060.9 4064.8 4088.5 4107.0 3491.6 3516.4 3518.3 3524.6 3527.0 630.9 650.7 654.6 661.8 663.8 472.6 563.9 580.6 589.3 590.6 8420.4 8454.9 8593.1 8640.4 8731.6 490.5 573.3 595.9 608.1 616.0 3884.7 4292.4 4299.2 4331.8 4399.3 94904.5 98615.5 98831.5 98859.0 98912.0 75335.6 80934.6 81099.8 82819.0 83236.0 72279.6 72736.6 72991.6 73630.3 74466.9 8567.3 8617.4 8664.2 8816.4 8866.8 45879.5 47705.8 47776.0 48515.6 48864.0 65550.0 66826.7 70632.6 71632.0 72855.3 10891.0 10921.8 10966.1 11097.6 11320.4 11927.0 12292.5 12310.3 12401.1 12625.8 6079.9 10398.6 10647.1 11241.6 11337.0 11001.7 11023.4 11210.8 11268.8 11725.5 10730.9 10881.6 11291.5 11754.2 11823.8 9317.2 9564.1 9754.7 9841.4 10011.7 8882.0 9178.2 10034.9 10038.2 10103.3 22:02:23 INFO - PROCESS | 1679 | -------- Summary: end -------- 22:02:23 INFO - PROCESS | 1679 | 22:02:24 INFO - TEST-INFO | 1679: exit 0 22:02:24 INFO - TEST-OK | dromaeo_css | took 1114806ms 22:02:24 INFO - TEST-START | kraken 22:02:24 INFO - operating with platform_type : mac_ 22:02:24 INFO - Initialising browser for kraken test... 22:02:24 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp2037y5/profile http://localhost:49274/getInfo.html) 22:02:26 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 22:02:26 INFO - PROCESS | 1685 | colorDepth:24 22:02:26 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 22:02:26 INFO - PROCESS | 1685 | __metrics 22:02:26 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:02:26 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:02:27 INFO - TEST-INFO | 1685: exit 0 22:02:27 INFO - Browser initialized. 22:02:27 INFO - Running cycle 1/1 for kraken test... 22:02:27 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmp2037y5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:39 INFO - PROCESS | 1687 | RSS: Main: 244449280 22:02:39 INFO - PROCESS | 1687 | 22:02:41 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 22:02:42 INFO - PROCESS | 1687 | RSS: Main: 290242560 22:02:42 INFO - PROCESS | 1687 | 22:02:45 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 22:02:45 INFO - PROCESS | 1687 | RSS: Main: 301142016 22:02:45 INFO - PROCESS | 1687 | 22:02:48 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 22:02:49 INFO - PROCESS | 1687 | RSS: Main: 285536256 22:02:49 INFO - PROCESS | 1687 | 22:02:51 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 22:02:52 INFO - PROCESS | 1687 | RSS: Main: 287371264 22:02:52 INFO - PROCESS | 1687 | 22:02:54 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:02:54 INFO - PROCESS | 1687 | RSS: Main: 290013184 22:02:54 INFO - PROCESS | 1687 | 22:02:57 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 22:02:58 INFO - PROCESS | 1687 | RSS: Main: 288702464 22:02:58 INFO - PROCESS | 1687 | 22:03:00 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 22:03:01 INFO - PROCESS | 1687 | RSS: Main: 289988608 22:03:01 INFO - PROCESS | 1687 | 22:03:04 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 22:03:04 INFO - PROCESS | 1687 | RSS: Main: 290906112 22:03:04 INFO - PROCESS | 1687 | 22:03:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:03:06 INFO - PROCESS | 1687 | RSS: Main: 326356992 22:03:06 INFO - PROCESS | 1687 | 22:03:08 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:03:09 INFO - PROCESS | 1687 | RSS: Main: 326361088 22:03:09 INFO - PROCESS | 1687 | 22:03:11 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:03:12 INFO - PROCESS | 1687 | RSS: Main: 331317248 22:03:12 INFO - PROCESS | 1687 | 22:03:14 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:03:15 INFO - PROCESS | 1687 | RSS: Main: 333807616 22:03:15 INFO - PROCESS | 1687 | 22:03:17 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:03:18 INFO - PROCESS | 1687 | RSS: Main: 333668352 22:03:18 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 22:03:20 INFO - PROCESS | 1687 | RSS: Main: 394334208 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | __start_tp_report 22:03:20 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 22:03:20 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 22:03:20 INFO - PROCESS | 1687 | |i|pagename|runs| 22:03:20 INFO - PROCESS | 1687 | |0;ai-astar;111;109;110;111;110;109;114;109;112;110 22:03:20 INFO - PROCESS | 1687 | |1;audio-beat-detection;177;152;168;180;152;140;145;144;173;119 22:03:20 INFO - PROCESS | 1687 | |2;audio-dft;176;185;186;186;184;186;183;178;178;180 22:03:20 INFO - PROCESS | 1687 | |3;audio-fft;73;77;86;81;72;87;85;111;106;57 22:03:20 INFO - PROCESS | 1687 | |4;audio-oscillator;91;96;129;78;78;85;134;111;78;115 22:03:20 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;84;90;85;89;84;89;83;89;85;89 22:03:20 INFO - PROCESS | 1687 | |6;imaging-darkroom;93;93;94;92;94;93;93;101;122;92 22:03:20 INFO - PROCESS | 1687 | |7;imaging-desaturate;84;88;84;86;84;85;87;85;84;84 22:03:20 INFO - PROCESS | 1687 | |8;json-parse-financial;55;55;54;53;53;54;55;64;53;53 22:03:20 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;62;62;74;73;70;68;65;66;66;67 22:03:20 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;82;83;83;85;77;81;82;81;81;83 22:03:20 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;127;133;125;135;126;119;137;119;142;130 22:03:20 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;140;127;138;138;139;128;138;139;138;137 22:03:20 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;67;66;66;66;67;67;67;72;85;92 22:03:20 INFO - PROCESS | 1687 | __end_tp_report 22:03:20 INFO - PROCESS | 1687 | __start_cc_report 22:03:20 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1200 22:03:20 INFO - PROCESS | 1687 | __end_cc_report 22:03:20 INFO - PROCESS | 1687 | __startTimestamp1456121000329__endTimestamp 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | ------- Summary: start ------- 22:03:20 INFO - PROCESS | 1687 | Number of tests: 14 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:1.58 (1.4%) stddev-sans-first:1.67 22:03:20 INFO - PROCESS | 1687 | Values: 111.0 109.0 110.0 111.0 110.0 109.0 114.0 109.0 112.0 110.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:160.00 stddev:19.33 (12.1%) stddev-sans-first:18.79 22:03:20 INFO - PROCESS | 1687 | Values: 177.0 152.0 168.0 180.0 152.0 140.0 145.0 144.0 173.0 119.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:182.20 Median:184.50 stddev:3.85 (2.1%) stddev-sans-first:3.37 22:03:20 INFO - PROCESS | 1687 | Values: 176.0 185.0 186.0 186.0 184.0 186.0 183.0 178.0 178.0 180.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:83.50 Median:79.00 stddev:15.90 (20.1%) stddev-sans-first:16.41 22:03:20 INFO - PROCESS | 1687 | Values: 73.0 77.0 86.0 81.0 72.0 87.0 85.0 111.0 106.0 57.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:78.00 stddev:21.38 (27.4%) stddev-sans-first:22.46 22:03:20 INFO - PROCESS | 1687 | Values: 91.0 96.0 129.0 78.0 78.0 85.0 134.0 111.0 78.0 115.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:89.00 stddev:2.71 (3.0%) stddev-sans-first:2.69 22:03:20 INFO - PROCESS | 1687 | Values: 84.0 90.0 85.0 89.0 84.0 89.0 83.0 89.0 85.0 89.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:93.00 stddev:9.26 (10.0%) stddev-sans-first:9.73 22:03:20 INFO - PROCESS | 1687 | Values: 93.0 93.0 94.0 92.0 94.0 93.0 93.0 101.0 122.0 92.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.48 22:03:20 INFO - PROCESS | 1687 | Values: 84.0 88.0 84.0 86.0 84.0 85.0 87.0 85.0 84.0 84.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.31 (6.1%) stddev-sans-first:3.52 22:03:20 INFO - PROCESS | 1687 | Values: 55.0 55.0 54.0 53.0 53.0 54.0 55.0 64.0 53.0 53.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:4.08 (6.1%) stddev-sans-first:3.86 22:03:20 INFO - PROCESS | 1687 | Values: 62.0 62.0 74.0 73.0 70.0 68.0 65.0 66.0 66.0 67.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:2.10 (2.5%) stddev-sans-first:2.22 22:03:20 INFO - PROCESS | 1687 | Values: 82.0 83.0 83.0 85.0 77.0 81.0 82.0 81.0 81.0 83.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:131.50 stddev:7.56 (5.7%) stddev-sans-first:7.97 22:03:20 INFO - PROCESS | 1687 | Values: 127.0 133.0 125.0 135.0 126.0 119.0 137.0 119.0 142.0 130.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:138.00 stddev:4.66 (3.4%) stddev-sans-first:4.74 22:03:20 INFO - PROCESS | 1687 | Values: 140.0 127.0 138.0 138.0 139.0 128.0 138.0 139.0 138.0 137.0 22:03:20 INFO - PROCESS | 1687 | 22:03:20 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:67.00 stddev:9.28 (13.8%) stddev-sans-first:9.70 22:03:20 INFO - PROCESS | 1687 | Values: 67.0 66.0 66.0 66.0 67.0 67.0 67.0 72.0 85.0 92.0 22:03:20 INFO - PROCESS | 1687 | -------- Summary: end -------- 22:03:20 INFO - PROCESS | 1687 | 22:03:21 INFO - TEST-INFO | 1687: exit 0 22:03:21 INFO - TEST-OK | kraken | took 56834ms 22:03:21 INFO - SUITE-END | took 1171s 22:03:21 INFO - Completed test suite (00:19:32) 22:03:21 INFO - Working with test: dromaeo_css 22:03:21 INFO - Generating results file: dromaeo_css 22:03:21 INFO - Working with test: kraken 22:03:21 INFO - Generating results file: kraken 22:03:21 INFO - javascript benchmark 22:03:21 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:03:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 22:03:21 INFO - process_Request line: dromaeo_css 7392.97 graph.html#tests=[[72,1,59]] 22:03:21 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:03:21 INFO - process_Request line: kraken 1440.20 graph.html#tests=[[232,1,59]] 22:03:21 INFO - RETURN: dromaeo_css: 7392.97 22:03:21 INFO - RETURN: kraken: 1440.20 22:03:21 INFO - javascript benchmark 22:03:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3455.9654403455966, 3501.1464460173484, 3510.5611798525183, 3529.5940966788817, 3580.892573222804, 5654.293213348332, 5694.943050569498, 5716.971415142919, 5724.885502289946, 5743.0, 5670.291213598301, 5729.742161602728, 5733.827985160452, 5734.340550836655, 5740.483356497914, 4647.395838540993, 4886.291487734276, 5240.580753539727, 5247.0, 5314.681119132845, 5327.334083239595, 5330.227117068022, 5331.920021199685, 5332.760025798829, 5343.893122137555, 5221.634485586011, 5241.895162096775, 5302.893942121155, 5314.707691076989, 5319.468053194688, 5277.076511610472, 5309.7610607522365, 5324.068288049576, 5328.46715328468, 5339.839804805862, 5134.666246693953, 5171.637985341028, 5223.268742376071, 5237.659552129137, 5245.527902488794, 5538.972305138448, 5539.086050801613, 5554.19464177696, 5575.69333686647, 5584.441555844423, 6139.723712432951, 6160.969195153995, 6165.290991535986, 6168.907466388007, 6170.167027451326, 6135.416406698409, 6140.508759299245, 6198.845028874269, 6220.284667263232, 6249.375062493714, 5766.452187042224, 5784.4504772046585, 5797.275340582427, 5804.071348584206, 5837.795677151279, 6162.722677479434, 6287.339829317947, 6301.6219026858535, 6316.4315211630255, 6330.145430366933, 6068.630585978089, 6113.32428171423, 6140.048292514667, 6160.661163635953, 6174.5060395168275, 6192.628442293477, 6198.411150940653, 6216.191895053614, 6219.533534984804, 6241.875162496724, 6103.115048317969, 6115.288719462083, 6184.6598437085495, 6190.009598464314, 6206.162168107338, 6161.168242287324, 6200.3179650238435, 6205.689715514206, 6206.596571222856, 6213.409726076015, 4847.151748444008, 4898.657094003385, 4899.069176856386, 4902.14212512816, 4939.357883475125, 4365.170617582713, 4372.23485889968, 4442.933355999663, 4462.620677242471, 4464.995376040365, 4773.856784296477, 5835.9708201458725, 5836.153757705109, 5839.620424672383, 5846.298444186725, 6158.076288556663, 6295.024271237966, 6306.180196574416, 6315.778947736807, 6324.114623952651, 5761.740721667451, 5826.417358264224, 5849.327327357323, 5854.619449735754, 5892.057270836645, 5386.48828361305, 5407.567394608422, 5408.891822163535, 5411.83764487066, 5422.0, 6228.34602366745, 6293.653849038347, 6373.458256048288, 6373.808785736435, 6377.936220637827, 6198.566100372931, 6245.5628106032145, 6253.093301471352, 6255.562110652393, 6255.96872015637, 6281.748730050746, 6285.874282514415, 6290.874182516415, 6299.590526615755, 6304.432601065926, 6095.573309868267, 6112.5946701277735, 6146.200993870947, 6203.47270481996, 6204.658743768956, 6238.532110091671, 6247.156633854554, 6269.153664255267, 6272.09054687077, 6283.748650053946, 6012.428819262163, 6141.048137538689, 6147.661878596541, 6164.4760195382105, 6170.074488826712, 6068.302145253352, 6072.605280656743, 6127.097902969389, 6131.743695906945, 6144.617461071223, 5736.827895163152, 5948.167256583995, 5949.1076338549565, 5954.19618351517, 5959.22530071088, 6009.969950150221, 6062.6665533394325, 6132.816015519542, 6153.2000839890525, 6156.168917196122, 5827.912581311199, 5915.408459154222, 5921.259842519685, 5965.791197308074, 5986.161937328865], "unit": "score", "name": "dojo.html", "value": 5711.710124363305}, {"lowerIsBetter": false, "replicates": [428.07322147550553, 454.1076784119205, 560.2101037537074, 573.4924591736312, 589.5902347868227, 29076.273093172655, 38532.0, 38997.41503877444, 39075.0231244219, 39162.412563811566, 35423.11442213946, 42076.579234207646, 42432.36351454723, 42549.574504254946, 42680.78659606705, 9400.341976061662, 9617.182539484118, 9617.182539484153, 9634.518274086302, 9648.71053868385, 9500.097490738368, 9621.663241786538, 9631.133198012178, 9632.566534505964, 9645.565949532252, 9631.229501639851, 9662.4202547847, 9667.033296670312, 9668.081532254424, 9680.56437460316, 9569.090936361035, 9643.27675424346, 9649.324547281658, 9656.179224765903, 9664.323497355188, 9501.762455938657, 9656.22750179984, 9665.371750836173, 9666.709998700051, 9671.081247281498, 38915.02712432184, 39322.60677393218, 39354.60645393567, 39386.0, 39457.60542394568, 3221.387936292097, 3246.805191688506, 3360.4455264881267, 3529.9294014119832, 3638.5451818522683, 27977.580336294974, 28194.85902570474, 28226.2943426416, 28721.425571488453, 28891.85554072216, 2791.0649932272713, 2801.859907004662, 2851.957220641692, 2872.741453269216, 2976.598159248517, 354255.2287238573, 355046.0, 356949.0, 358017.0, 358594.0, 43295.0, 43392.3491147633, 43465.69602911918, 56875.0, 57429.71285143548, 42633.93415164584, 42876.57123428788, 42887.142257155305, 42978.785106074894, 43033.35449968253, 14822.851771482363, 14964.401423943138, 14986.175760333286, 14986.625334366729, 14991.17548534841, 12208.75582488363, 12222.388880556115, 12256.08079394049, 12262.957648599791, 12263.816042759367, 14193.07744996572, 14218.715625687428, 14231.85768142326, 14257.0, 14339.354729037219, 6196.690165491707, 6234.657093859791, 6257.2491301044165, 6258.870564717641, 6290.21372328459, 904.5206040798388, 977.2426369563645, 981.4651015196735, 1040.2614143957724, 1066.0192622787054, 25875.48249035009, 26673.06644267441, 27181.728182718314, 27223.727762722516, 27254.182374528795, 900.2662829793697, 969.3699095587924, 1080.8216644253766, 1082.480409403475, 1084.203110713625, 14284.0, 14551.3451894665, 15580.532584022498, 15617.687646247012, 16018.679626407407, 654124.0, 661188.0, 669868.0, 701304.0, 711269.0, 54460.638484038216, 54494.91010179854, 55148.448515515134, 55154.44845551493, 55336.0, 1441.8774404175554, 1442.9971170036724, 1456.3228098934046, 1458.3510337899745, 1558.532440267915, 25551.0, 30142.69857301399, 30374.240643984078, 30823.691763082083, 31116.853430068782, 51716.0, 51753.48246517637, 52421.21368179557, 52453.950920980606, 52553.0, 509858.0, 513997.0, 514041.0, 514143.0, 514611.0, 31779.0, 32177.678223217466, 41531.792341038104, 42807.792870033045, 43036.0, 40135.59864401319, 40863.7956810214, 40965.795171025144, 41021.794891025354, 41781.328746851, 34361.312773743884, 34949.30101398009, 35156.47265290972, 35388.11529711778, 35621.64378356287, 33167.83416082904, 33538.664613353554, 34605.30789384249, 35519.46720799242, 35638.465423018155, 35407.64592354043, 36305.81847090748, 36380.45429318615, 36463.81768091142, 36585.81707091554, 28516.57225141666, 29438.969636062637, 30223.848880755457, 32152.839235803673, 32244.35511289808, 22160.889195554562, 24033.879830600734, 24120.517589648458, 24506.754932450447, 24714.50570988606], "unit": "score", "name": "ext.html", "value": 18830.570712041437}, {"lowerIsBetter": false, "replicates": [317.960254968129, 362.5540585080351, 369.31123454756886, 369.6192921291071, 374.24029220682024, 15313.157776322298, 15825.05049697019, 18736.156872940715, 19050.523736906565, 19484.51288717783, 18467.35364262251, 18643.720344194815, 19244.0, 19244.230230790785, 19298.90350548249, 5161.561267292275, 5617.634853734515, 5895.764169433239, 5926.4073592640825, 5973.940260597382, 4086.509618845743, 4291.141771645668, 5770.278715160605, 6086.269647642289, 6353.714082866259, 6294.779682711106, 6300.180976473052, 6300.653464059475, 6312.621242725451, 6318.210223722035, 6188.443040126388, 6191.566590338678, 6379.904301435482, 6386.64873431961, 6389.584676995981, 5500.4499550045075, 5515.283013208297, 5523.696196709179, 5526.972365138148, 5532.834014979557, 24079.157229497057, 24598.893049812803, 24824.751752482603, 24878.626820597707, 24912.878920448624, 2105.4420578546697, 2124.7768984256586, 2287.1537531113427, 2316.8030717389042, 2348.988255058731, 13908.0, 14121.223332716696, 14169.716605667829, 14226.145213635762, 14690.63273418173, 1651.644896347279, 1699.864010879139, 1721.122227663888, 1759.727242277449, 1797.8921264724027, 88418.0, 88769.0, 89730.0, 90327.09672903319, 94959.0, 10050.246231532517, 10269.640562580424, 10486.26596138263, 10506.73733156662, 10566.154707623371, 12715.173513721578, 12716.491340346467, 12719.173253738478, 12757.936210318889, 12768.872311276768, 8066.7579972600915, 8205.917940820635, 8212.917870821335, 8255.339572834158, 8293.046299675494, 8285.4200205985, 8286.917130828735, 8310.501369917703, 8377.036640786266, 8430.0, 4529.886752831206, 6024.457798798042, 6050.485708714808, 6052.213212282375, 6069.969650151721, 1643.967120657604, 1727.497077542546, 1730.853741360729, 1758.5603599100225, 1836.2471386731377, 418.57892455114717, 421.8586773430935, 423.4770058977161, 459.0383147306454, 868.1882439918696, 11205.0, 11308.151888608387, 11391.544338226544, 11505.079593632488, 11944.761104777856, 385.7319163181618, 452.0461825548091, 462.28115280738103, 464.40787995306255, 467.6048738815695, 10788.51451684676, 11076.612318568812, 11174.944125279322, 11178.385188814693, 11215.383153926448, 610706.0, 639390.8030459818, 645278.0, 667152.0, 669318.0, 118767.0, 123971.76028239782, 125333.37333313457, 126253.10620340702, 127774.0, 1036.8237399642078, 1037.2687255484866, 1039.1323245090434, 1075.1936047964027, 1098.9505472253768, 17794.5551361217, 18039.647026472805, 18077.638447230718, 18116.456506304832, 18401.3559525416, 54254.728726356116, 54629.18056229239, 54776.17835732547, 54927.450725492236, 55068.44931550793, 74149.62925185339, 77366.0, 78202.0, 78865.02837428881, 79035.20964790278, 7688.884666729891, 7940.483868548526, 8149.388795840454, 8251.793705157179, 8280.461769984931, 8437.578121094044, 10248.59005639796, 12757.936210318889, 13580.52468163649, 13583.52457663977, 10701.250912436055, 11189.832152517882, 11194.832077519006, 11284.266522676, 11344.376059316817, 9787.217022638315, 10854.782904342026, 11233.943830280796, 11303.43482825839, 11418.429078546205, 11545.595904143314, 11559.422028898352, 11593.304401735923, 11659.300441973508, 11710.00464960488, 6229.750809967551, 6706.631135287606, 7873.763787086396, 8110.026796784424, 8232.547209903512, 8468.872966905377, 9792.167665748491, 11058.557657693924, 11595.13036522281, 11613.114656418089], "unit": "score", "name": "jquery.html", "value": 8943.157406670038}, {"lowerIsBetter": false, "replicates": [1418.2270662488943, 1528.9541313760585, 1582.1298285942732, 1812.0848971269506, 1948.5810550731599, 7792.571408572526, 8371.581420928953, 8549.572521373937, 8552.657893684262, 8558.400911936167, 8276.83446331073, 8498.065212826585, 8499.702510412137, 8507.489550626951, 8510.404271700983, 2147.194801949269, 2204.812590929773, 2414.215380001502, 2437.695288088989, 2439.0975339124548, 1869.9065046747676, 2413.3966508372905, 2476.0590975429313, 2476.950460990779, 2478.5166892455977, 2397.7482364351754, 2424.4544977380037, 2431.489387228684, 2431.659567660529, 2454.361865914866, 2411.0476361836977, 2438.8658623775686, 2447.3269850791, 2448.6327050942323, 2451.44842410458, 2430.9756902430927, 2439.902403903842, 2441.4628781668002, 2442.1330427698267, 2460.803135749136, 8547.871781923277, 8600.311975041981, 8622.137786221328, 8623.0, 8667.609957551926, 5253.3170687810725, 5290.206469029637, 5356.571474282087, 5381.919271210935, 5387.838364849061, 3641.6904563112166, 3704.685101766353, 3709.51776269086, 3765.190484045916, 3774.698024158088, 1054.093479607537, 1065.1425602390073, 1074.666853275487, 1075.5052675769155, 1087.8857719939451, 11525.42372881361, 11566.363849988247, 11585.6524304271, 11608.361540115291, 11613.593524226611, 4829.517048295143, 4849.0, 4857.125717370836, 4906.386701662293, 4911.950880491221, 9879.75300617476, 9884.851727224097, 9886.50567471638, 9889.505524723734, 9932.006799320156, 5364.8658783529945, 5374.059539580558, 5383.946160538423, 5399.136138217867, 5400.567954563626, 3737.626237376295, 4329.96080940572, 4695.060987802385, 4890.706557606555, 4890.731009794425, 3598.586162591283, 3612.7716576363637, 3905.902352441155, 3938.7636741795586, 3968.980155099206, 1300.3758196065942, 1311.7901135818224, 1312.1274352555633, 1323.5103011885665, 1325.032726109945, 1311.9212847229196, 1342.9865701343058, 1357.470586471277, 1358.5245164192454, 1365.41287246483, 7931.325837303779, 7983.880241796378, 8258.380621453414, 8273.420860539705, 8279.875801862976, 1193.5822462138183, 1205.73473835756, 1208.4803534480081, 1212.4119801896074, 1228.7542491501736, 6206.813795586139, 6218.378162183745, 6261.24865016201, 6277.466415354746, 6283.0, 10149.137323327452, 10489.842652360221, 10502.002309780559, 10509.264351495474, 10623.89376106229, 9889.20886329092, 10336.896631033593, 10468.895311046945, 10479.0, 10521.158307335394, 8032.919670803217, 8047.959760201162, 8139.79650508742, 8142.51144931306, 8155.836883262302, 7841.176676448891, 7888.684452621831, 7940.364770818436, 7960.920390796018, 7964.482308649919, 9147.222486088756, 9159.496227707274, 9162.129597688208, 9355.719328420158, 9414.811703766023, 9376.906230937604, 9644.03559644058, 9672.274579406432, 9715.417074975525, 9907.950460247652, 6762.8985565217545, 6923.099997000358, 7178.712851485882, 7397.704091836266, 7540.208278130936, 8068.47554908929, 8106.594670266345, 8114.959425202836, 8137.8372432552205, 8145.674173033012, 7125.893111603226, 7183.066201393785, 7240.746573869889, 7341.669624866787, 7377.1885092638695, 7018.298170183145, 7043.929560704532, 7093.467989900675, 7148.64256787169, 7172.820679483055, 7377.815554610963, 7585.355244804254, 7597.582132982739, 7602.46782725204, 7607.505512141693, 6812.761553345807, 6907.34380233877, 6917.654117294216, 6919.37725604698, 6921.2732663069655, 6904.758333458305, 7055.929440705732, 7067.787966361017, 7076.540024898365, 7078.539894906815], "unit": "score", "name": "mootools.html", "value": 4889.166689258199}, {"lowerIsBetter": false, "replicates": [267.69349095285895, 328.57285528812537, 329.5699112657981, 332.55437713463954, 339.7774457730184, 6315.9368406315925, 6494.610323380589, 6503.2196136463635, 6567.146270984771, 6599.868002639956, 6398.3601639836, 6489.35106489352, 6500.25247096584, 6529.216494020712, 6573.737050517973, 4564.132814765184, 4687.086018226447, 4698.671093023489, 4819.927701084478, 4833.960698449832, 4750.144973904696, 4765.928511072319, 4767.332573439721, 4792.640551958617, 4806.687565308262, 4709.081729062834, 4736.621070314367, 4746.098241334153, 4750.4299484061785, 4770.880727981794, 4518.186726389248, 4639.628829693616, 4746.288056791474, 4760.309755085494, 4766.594839438651, 4042.7776472294013, 4053.655439287664, 4057.2696914555368, 4057.6348128668265, 4058.02607374231, 6161.4146656067605, 6179.721912513947, 6183.443490085869, 6204.534659900525, 6214.937850621481, 5478.890422191574, 5492.505674489315, 5498.202760599691, 5498.9826882026955, 5512.173174023888, 6838.7264509419565, 6849.623270720109, 6859.519833611649, 6861.2795656455855, 6861.862762744717, 4294.957050429487, 4462.754548499831, 4488.214562451558, 4488.910221795579, 4491.056878055612, 7159.427245820322, 7263.89104163438, 7267.927320726778, 7292.34368906801, 7300.160481544637, 4542.636589072867, 4550.567696068868, 4551.180787458289, 4552.226121559343, 4554.134714404318, 4596.770161491979, 4604.746738929324, 4607.2398054320665, 4615.815367385334, 4618.983823558811, 5444.292242008513, 5460.706503268557, 5463.399026107125, 5463.781448742086, 5468.644538105011, 6581.0, 6849.726010959605, 6859.868121759854, 6895.379415852497, 6955.617441040791, 1592.3789722008426, 1610.428297954233, 1614.007385457935, 1614.4188092286768, 1615.5557221763875, 959.9392671098475, 973.868527748759, 1023.4064242739194, 1027.5222021759917, 1048.4443245079967, 6406.8718625627225, 6500.674966251669, 6517.348265173539, 6517.4134327910715, 6533.346665333524, 7167.032450619204, 7180.281971802882, 7182.209956904736, 7190.352868241884, 7195.172555156224, 6476.643784591798, 6478.578892372075, 6488.994205898093, 6495.545311828127, 6496.805095847132, 3751.0997360633796, 3804.6956243500454, 3807.010177353908, 3810.48558444612, 3813.828377723009, 7270.091238595176, 7486.101667799899, 7520.097588289331, 7545.584992825447, 7594.81012974669, 7451.366633836076, 7480.17718051014, 7484.0, 7487.775366739006, 7493.6511427942405, 7551.244875512405, 7554.811129721801, 7567.091948966269, 7573.583452910143, 7578.962105189439, 6980.406665433292, 7202.96398518004, 7210.531315464478, 7213.71145154188, 7229.09636295463, 6565.621219543758, 7141.857162856818, 7179.353858152791, 7188.3530482254755, 7199.568025918462, 6835.726570937306, 7620.390368770374, 7628.237176282328, 7629.351505122127, 7637.427192960439, 4540.772961351985, 4585.19759042173, 4589.770511474346, 4593.793279302373, 4594.0582180653555, 5118.0, 7142.464315176487, 7171.067761191011, 7178.569285842657, 7182.928170718226, 6709.798706038827, 6944.2708515607155, 6956.756513522002, 6967.895481567882, 6968.756093536702, 6056.152138700498, 6856.868616678193, 6947.7220911162985, 6947.826304342432, 6950.270221626656, 6771.187457505131, 6781.966090169518, 6787.21946976104, 6787.762428315183, 6790.694418751267, 6673.265940746417, 6945.236024037251, 6955.965220173866, 6956.373926346653, 6956.582605043714, 6546.901796473152, 6637.6681165940545, 6709.060731497691, 6738.225104113089, 6778.0], "unit": "score", "name": "prototype.html", "value": 5056.108745152121}, {"lowerIsBetter": false, "replicates": [679.5888487465083, 686.7081490366593, 700.5761514283855, 710.2435905760368, 728.7340120855886, 14776.187309697962, 14865.702685946275, 15061.171635560067, 15078.849211507883, 15089.547313580582, 13722.0, 13872.861271387283, 13919.860801391984, 13928.233947132903, 13928.930355348235, 713.9571625702474, 723.7322190789415, 866.6576702202642, 873.026575368466, 881.039666763228, 883.5626364949359, 885.2519620920312, 887.1926546842375, 887.3344991256557, 887.4763889305309, 927.3601215161517, 930.1907340613676, 930.5440334236209, 933.5425641435716, 934.2479304160148, 733.611186071383, 741.2735519191169, 741.929516695913, 743.1824992508225, 906.3972458315278, 674.0563211503934, 675.0279597379806, 677.9762708305235, 681.7375310505441, 683.2518392360357, 15040.398384064625, 15090.245487725679, 15105.47130850415, 15115.697686046218, 15128.319225634763, 13045.478180872753, 13092.541761038414, 13173.341332933314, 13474.865251347459, 13590.864091359059, 10131.189504839595, 10148.746281342952, 10376.066154046097, 10489.63286284984, 10836.458177091194, 3516.0423157382056, 3531.876384326536, 3554.20030493137, 3632.382494975834, 3718.535183102112, 81854.18145818525, 81885.18114818895, 83145.58427207886, 83314.0, 84265.57867210686, 9270.490123043162, 9273.072692730673, 9299.53502324881, 9324.90675093254, 9556.713298601053, 20421.48946276355, 20424.38726838197, 20445.182192712124, 20459.28392506255, 20478.795212047688, 7031.437485001187, 7332.81489149862, 7354.889676654854, 7418.443616728659, 7524.736634217886, 4059.0055436417674, 4060.898477538026, 4064.7967601620394, 4088.4889388826396, 4106.973256685828, 3491.581010278732, 3516.384632689269, 3518.2963407318125, 3524.6122926478065, 3526.9647303526635, 630.8990561510136, 650.6844180572418, 654.5614438326332, 661.798151563768, 663.7975417497613, 472.6384315998264, 563.9464250896158, 580.613891761982, 589.2910559377754, 590.6249531547412, 8420.434117945866, 8454.915450845536, 8593.097724738938, 8640.438371505832, 8731.563421828883, 490.4996903158758, 573.320615071142, 595.8718875441714, 608.0939400293531, 615.9538034647419, 3884.6503814656817, 4292.441982542312, 4299.204647140289, 4331.848385306499, 4399.274119770266, 94904.52547737217, 98615.52076718854, 98831.50584247033, 98859.0, 98912.0, 75335.62332188305, 80934.595327023, 81099.7835032475, 82819.0, 83236.0, 72279.55440891153, 72736.63631681913, 72991.63504182445, 73630.2636973634, 74466.8829967551, 8567.27178189861, 8617.353698472765, 8664.23117888893, 8816.382853200214, 8866.77402789064, 45879.54120458753, 47705.761471192425, 47776.0, 48515.6335929768, 48864.033904065036, 65550.0, 66826.66586667036, 70632.64683676549, 71632.0, 72855.27144728485, 10891.0, 10921.781564368826, 10966.067884229611, 11097.611583594535, 11320.377379243891, 11926.986206172573, 12292.502498172793, 12310.26138431697, 12401.069919755873, 12625.81061284063, 6079.945501889167, 10398.636047738595, 10647.094996925038, 11241.55033798639, 11337.0, 11001.729612257599, 11023.44882755875, 11210.775784484427, 11268.83096753533, 11725.472353743931, 10730.8926910733, 10881.619143330263, 11291.491882865126, 11754.177207595729, 11823.763524729286, 9317.208037316905, 9564.138714386163, 9754.658586949707, 9841.360311579725, 10011.749706257402, 8881.955590222007, 9178.173964342974, 10034.8702053468, 10038.247600786968, 10103.292769506357], "unit": "score", "name": "yui.html", "value": 6866.080720970272}], "name": "dromaeo_css", "value": 7392.97048151507}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 111.0, 110.0, 109.0, 114.0, 109.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [177.0, 152.0, 168.0, 180.0, 152.0, 140.0, 145.0, 144.0, 173.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 155.0}, {"lowerIsBetter": true, "replicates": [176.0, 185.0, 186.0, 186.0, 184.0, 186.0, 183.0, 178.0, 178.0, 180.0], "unit": "score", "name": "audio-dft", "value": 182.2}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 86.0, 81.0, 72.0, 87.0, 85.0, 111.0, 106.0, 57.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 129.0, 78.0, 78.0, 85.0, 134.0, 111.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 99.5}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 85.0, 89.0, 84.0, 89.0, 83.0, 89.0, 85.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 92.0, 94.0, 93.0, 93.0, 101.0, 122.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 96.7}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 84.0, 86.0, 84.0, 85.0, 87.0, 85.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 53.0, 53.0, 54.0, 55.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 74.0, 73.0, 70.0, 68.0, 65.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 85.0, 77.0, 81.0, 82.0, 81.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [127.0, 133.0, 125.0, 135.0, 126.0, 119.0, 137.0, 119.0, 142.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.3}, {"lowerIsBetter": true, "replicates": [140.0, 127.0, 138.0, 138.0, 139.0, 128.0, 138.0, 139.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 72.0, 85.0, 92.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1440.2}]} 22:03:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1440.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7392.97"}}} 22:03:21 INFO - Return code: 0 22:03:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:03:21 INFO - # TBPL SUCCESS # 22:03:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:03:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:03:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:03:21 INFO - 2016-02-21 22:03:21.696 screenresolution[1691:10841] starting screenresolution argv=screenresolution get 22:03:21 INFO - 2016-02-21 22:03:21.699 screenresolution[1691:10841] Display 0: 1600x1200x32@60 22:03:21 INFO - 2016-02-21 22:03:21.705 screenresolution[1692:10844] starting screenresolution argv=screenresolution list 22:03:21 INFO - Available Modes on Display 0 22:03:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:03:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:03:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:03:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:03:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:03:21 INFO - Intel Iris: 22:03:21 INFO - Chipset Model: Intel Iris 22:03:21 INFO - Type: GPU 22:03:21 INFO - Bus: Built-In 22:03:21 INFO - VRAM (Dynamic, Max): 1536 MB 22:03:21 INFO - Vendor: Intel (0x8086) 22:03:21 INFO - Device ID: 0x0a2e 22:03:21 INFO - Revision ID: 0x0009 22:03:21 INFO - Displays: 22:03:21 INFO - Display: 22:03:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:03:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:03:21 INFO - Display Serial Number: 1600x1200 60 22:03:21 INFO - Main Display: Yes 22:03:21 INFO - Mirror: Off 22:03:21 INFO - Online: Yes 22:03:21 INFO - Rotation: Supported 22:03:21 INFO - Return code: 0 22:03:21 INFO - Running post-action listener: _resource_record_post_action 22:03:21 INFO - Running post-run listener: _resource_record_post_run 22:03:22 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33988096; Write bytes: 709464064; Read time: 351; Write time: 2464 22:03:22 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404816384; Write bytes: 406939136; Read time: 30059; Write time: 784 22:03:23 INFO - run-tests - Wall time: 1175s; CPU: 52.0%; Read bytes: 32206336; Write bytes: 301677056; Read time: 332; Write time: 1679 22:03:23 INFO - Running post-run listener: _upload_blobber_files 22:03:23 INFO - Blob upload gear active. 22:03:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:03:23 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 22:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:03:23 INFO - (blobuploader) - INFO - Open directory for files ... 22:03:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:03:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:03:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:03:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:03:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:03:24 INFO - (blobuploader) - INFO - Done attempting. 22:03:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:03:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:03:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:03:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:03:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:03:25 INFO - (blobuploader) - INFO - Done attempting. 22:03:25 INFO - (blobuploader) - INFO - Iteration through files over. 22:03:25 INFO - Return code: 0 22:03:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:03:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:03:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c1c6e9dc70feef2620d9cd98555571734135044a7526989dd4be783c9b02c5bc926793fefc86c52f4883c506708d71084cf8ed442771adac02e9d0eb65ce2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4958ee56da81a402f0ab254ac7106c910c5742e78d0380f4cce4b3ffc0cf0a981315d0df238f4b5733cf87739ea69b54962f5f15a72778f5843667f3b6a2b61"} 22:03:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:03:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:03:25 INFO - Contents: 22:03:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c1c6e9dc70feef2620d9cd98555571734135044a7526989dd4be783c9b02c5bc926793fefc86c52f4883c506708d71084cf8ed442771adac02e9d0eb65ce2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4958ee56da81a402f0ab254ac7106c910c5742e78d0380f4cce4b3ffc0cf0a981315d0df238f4b5733cf87739ea69b54962f5f15a72778f5843667f3b6a2b61"} 22:03:25 INFO - Running post-run listener: copy_logs_to_upload_dir 22:03:25 INFO - Copying logs to upload dir... 22:03:25 INFO - mkdir: /builds/slave/test/build/upload/logs 22:03:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.638923 ========= master_lag: 34.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-02-21 22:04:00.169249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 17 secs) (at 2016-02-21 22:04:00.173063) ========= 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.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c1c6e9dc70feef2620d9cd98555571734135044a7526989dd4be783c9b02c5bc926793fefc86c52f4883c506708d71084cf8ed442771adac02e9d0eb65ce2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4958ee56da81a402f0ab254ac7106c910c5742e78d0380f4cce4b3ffc0cf0a981315d0df238f4b5733cf87739ea69b54962f5f15a72778f5843667f3b6a2b61"} build_url:https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/EqrmobWDTgG9u-zSruA3kw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c1c6e9dc70feef2620d9cd98555571734135044a7526989dd4be783c9b02c5bc926793fefc86c52f4883c506708d71084cf8ed442771adac02e9d0eb65ce2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4958ee56da81a402f0ab254ac7106c910c5742e78d0380f4cce4b3ffc0cf0a981315d0df238f4b5733cf87739ea69b54962f5f15a72778f5843667f3b6a2b61"}' ========= master_lag: 17.90 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 17 secs) (at 2016-02-21 22:04:18.088622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 22:04:18.089072) ========= 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.W28yJfNX1E/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.UAFHS3tcge/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005230 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 22:04:18.207360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 22:04:18.207715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 22:04:18.224039) ========= ========= Total master_lag: 52.77 =========