builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0099 starttime: 1456455420.08 results: success (0) buildid: 20160225171127 builduid: 1840a943ffdd42d3bdf67bf60af14fa6 revision: 89eb5bb84d99324522bad7a707e08ff34932e6e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.077151) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.077599) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.077919) ========= 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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005459 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.139962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.140274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.265921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.266271) ========= 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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005906 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.378231) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.378584) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.378959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.379238) ========= 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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-25 18:57:00-- 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% 25.5M=0s 2016-02-25 18:57:00 (25.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.277360 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.695164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.695488) ========= 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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.025947 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:00.765364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 18:57:00.765750) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 89eb5bb84d99324522bad7a707e08ff34932e6e9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 89eb5bb84d99324522bad7a707e08ff34932e6e9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-25 18:57:00,858 truncating revision to first 12 chars 2016-02-25 18:57:00,858 Setting DEBUG logging. 2016-02-25 18:57:00,859 attempt 1/10 2016-02-25 18:57:00,859 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/89eb5bb84d99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 18:57:02,553 unpacking tar archive at: fx-team-89eb5bb84d99/testing/mozharness/ program finished with exit code 0 elapsedTime=1.949199 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 18:57:02.746444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:02.746793) ========= echo 89eb5bb84d99324522bad7a707e08ff34932e6e9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'89eb5bb84d99324522bad7a707e08ff34932e6e9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 89eb5bb84d99324522bad7a707e08ff34932e6e9 program finished with exit code 0 elapsedTime=0.005743 script_repo_revision: '89eb5bb84d99324522bad7a707e08ff34932e6e9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:02.802663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:02.802982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 18:57:02.817423) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-25 18:57:02.817767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:02 INFO - MultiFileLogger online at 20160225 18:57:02 in /builds/slave/test 18:57:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:57:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:57:03 INFO - {'append_to_log': False, 18:57:03 INFO - 'base_work_dir': '/builds/slave/test', 18:57:03 INFO - 'blob_upload_branch': 'Fx-Team', 18:57:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:57:03 INFO - 'branch': 'Fx-Team', 18:57:03 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:03 INFO - 'config_files': ('talos/mac_config.py',), 18:57:03 INFO - 'default_actions': ('clobber', 18:57:03 INFO - 'read-buildbot-config', 18:57:03 INFO - 'download-and-extract', 18:57:03 INFO - 'populate-webroot', 18:57:03 INFO - 'create-virtualenv', 18:57:03 INFO - 'install', 18:57:03 INFO - 'run-tests'), 18:57:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:03 INFO - 'download_minidump_stackwalk': True, 18:57:03 INFO - 'download_symbols': 'ondemand', 18:57:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:57:03 INFO - 'tooltool.py': '/tools/tooltool.py', 18:57:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:57:03 INFO - '/tools/misc-python/virtualenv.py')}, 18:57:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:03 INFO - 'installer_path': 'installer.exe', 18:57:03 INFO - 'log_level': 'info', 18:57:03 INFO - 'log_name': 'talos', 18:57:03 INFO - 'log_to_console': True, 18:57:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:57:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:57:03 INFO - 'opt_config_files': (), 18:57:03 INFO - 'pip_index': False, 18:57:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:57:03 INFO - 'cmd': ('bash', 18:57:03 INFO - '-c', 18:57:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:57:03 INFO - 'enabled': True, 18:57:03 INFO - 'halt_on_failure': False, 18:57:03 INFO - 'name': 'check_screen_resolution'},), 18:57:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:57:03 INFO - 'cmd': ('bash', 18:57:03 INFO - '-c', 18:57:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:57:03 INFO - 'enabled': True, 18:57:03 INFO - 'halt_on_failure': False, 18:57:03 INFO - 'name': 'check_screen_resolution'},), 18:57:03 INFO - 'run_cmd_checks_enabled': True, 18:57:03 INFO - 'sps_profile': False, 18:57:03 INFO - 'sps_profile_interval': 0, 18:57:03 INFO - 'suite': 'dromaeojs', 18:57:03 INFO - 'system_bits': '32', 18:57:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:03 INFO - 'title': 't-yosemite-r7-0099', 18:57:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:03 INFO - 'use_talos_json': True, 18:57:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:57:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:03 INFO - 'work_dir': 'build'} 18:57:03 INFO - ##### 18:57:03 INFO - ##### Running clobber step. 18:57:03 INFO - ##### 18:57:03 INFO - Running pre-action listener: _resource_record_pre_action 18:57:03 INFO - Running main action method: clobber 18:57:03 INFO - rmtree: /builds/slave/test/build 18:57:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:57:04 INFO - Running post-action listener: _resource_record_post_action 18:57:04 INFO - ##### 18:57:04 INFO - ##### Running read-buildbot-config step. 18:57:04 INFO - ##### 18:57:04 INFO - Running pre-action listener: _resource_record_pre_action 18:57:04 INFO - Running main action method: read_buildbot_config 18:57:04 INFO - Using buildbot properties: 18:57:04 INFO - { 18:57:04 INFO - "project": "", 18:57:04 INFO - "product": "firefox", 18:57:04 INFO - "script_repo_revision": "production", 18:57:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:57:04 INFO - "repository": "", 18:57:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:57:04 INFO - "buildid": "20160225171127", 18:57:04 INFO - "pgo_build": "False", 18:57:04 INFO - "basedir": "/builds/slave/test", 18:57:04 INFO - "buildnumber": 414, 18:57:04 INFO - "slavename": "t-yosemite-r7-0099", 18:57:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:57:04 INFO - "platform": "yosemite_r7", 18:57:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:57:04 INFO - "branch": "fx-team", 18:57:04 INFO - "repo_path": "integration/fx-team", 18:57:04 INFO - "revision": "89eb5bb84d99324522bad7a707e08ff34932e6e9", 18:57:04 INFO - "stage_platform": "macosx64", 18:57:04 INFO - "builduid": "1840a943ffdd42d3bdf67bf60af14fa6", 18:57:04 INFO - "slavebuilddir": "test" 18:57:04 INFO - } 18:57:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:57:04 INFO - Running post-action listener: _resource_record_post_action 18:57:04 INFO - ##### 18:57:04 INFO - ##### Running download-and-extract step. 18:57:04 INFO - ##### 18:57:04 INFO - Running pre-action listener: _resource_record_pre_action 18:57:04 INFO - Running main action method: download_and_extract 18:57:04 INFO - mkdir: /builds/slave/test/build/tests 18:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:04 INFO - https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/test_packages.json 18:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/test_packages.json 18:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:57:05 INFO - Downloaded 1277 bytes. 18:57:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:57:05 INFO - Using the following test package requirements: 18:57:05 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:57:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:57:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:57:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'jsshell-mac.zip'], 18:57:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:57:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:57:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:57:05 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:57:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:57:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:57:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:57:05 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:57:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:57: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')]} 18:57:05 INFO - https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:06 INFO - Downloaded 17830394 bytes. 18:57:06 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'] 18:57:06 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 18:57:09 INFO - Return code: 0 18:57:09 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 18:57:09 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')]} 18:57:09 INFO - https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:10 INFO - Downloaded 17830394 bytes. 18:57:10 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'] 18:57:10 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 18:57:14 INFO - Return code: 0 18:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:14 INFO - https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:57:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:57:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:57:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:15 INFO - Downloaded 10713410 bytes. 18:57:15 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'] 18:57:15 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 18:57:15 INFO - Return code: 0 18:57:15 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')]} 18:57:15 INFO - https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MD0HfW7mRXSpanCDl2XErw/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 18:57:24 INFO - Downloaded 111442156 bytes. 18:57:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:24 INFO - mkdir: /builds/slave/test/properties 18:57:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:57:24 INFO - Writing to file /builds/slave/test/properties/build_url 18:57:24 INFO - Contents: 18:57:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:25 INFO - Running post-action listener: _resource_record_post_action 18:57:25 INFO - Running post-action listener: set_extra_try_arguments 18:57:25 INFO - ##### 18:57:25 INFO - ##### Running populate-webroot step. 18:57:25 INFO - ##### 18:57:25 INFO - Running pre-action listener: _resource_record_pre_action 18:57:25 INFO - Running main action method: populate_webroot 18:57:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:57:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:57:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:57:25 INFO - '--tppagecycles', 18:57:25 INFO - '7'], 18:57:25 INFO - 'tests': ['tsvgm']}}, 18:57:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:57:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:57:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:57:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:57:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'tests': ['damp', 'tps']}, 18:57:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['damp', 'tps']}, 18:57:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:57:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:25 INFO - 'other': {'tests': ['a11yr', 18:57:25 INFO - 'ts_paint', 18:57:25 INFO - 'tpaint', 18:57:25 INFO - 'sessionrestore', 18:57:25 INFO - 'sessionrestore_no_auto_restore']}, 18:57:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['a11yr', 18:57:25 INFO - 'ts_paint', 18:57:25 INFO - 'tpaint', 18:57:25 INFO - 'sessionrestore', 18:57:25 INFO - 'sessionrestore_no_auto_restore']}, 18:57:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['a11yr', 18:57:25 INFO - 'ts_paint', 18:57:25 INFO - 'tpaint', 18:57:25 INFO - 'sessionrestore', 18:57:25 INFO - 'sessionrestore_no_auto_restore']}, 18:57:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['a11yr', 18:57:25 INFO - 'ts_paint', 18:57:25 INFO - 'tpaint', 18:57:25 INFO - 'sessionrestore', 18:57:25 INFO - 'sessionrestore_no_auto_restore']}, 18:57:25 INFO - 'other_l64': {'tests': ['a11yr', 18:57:25 INFO - 'ts_paint', 18:57:25 INFO - 'tpaint', 18:57:25 INFO - 'sessionrestore', 18:57:25 INFO - 'sessionrestore_no_auto_restore']}, 18:57:25 INFO - 'other_nol64': {'tests': ['a11yr', 18:57:25 INFO - 'ts_paint', 18:57:25 INFO - 'tpaint', 18:57:25 INFO - 'sessionrestore', 18:57:25 INFO - 'sessionrestore_no_auto_restore']}, 18:57:25 INFO - 'svgr': {'tests': ['tsvgx', 18:57:25 INFO - 'tsvgr_opacity', 18:57:25 INFO - 'tart', 18:57:25 INFO - 'tscrollx', 18:57:25 INFO - 'cart']}, 18:57:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['tsvgx', 18:57:25 INFO - 'tsvgr_opacity', 18:57:25 INFO - 'tart', 18:57:25 INFO - 'tscrollx', 18:57:25 INFO - 'cart']}, 18:57:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'tests': ['tp5o']}, 18:57:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'talos_options': ['--e10s'], 18:57:25 INFO - 'tests': ['tp5o']}, 18:57:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'talos_options': ['--xperf_path', 18:57:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:25 INFO - 'tests': ['tp5n']}, 18:57:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:25 INFO - 'talos_options': ['--e10s', 18:57:25 INFO - '--xperf_path', 18:57:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:25 INFO - 'tests': ['tp5n']}}, 18:57:25 INFO - 'talos.zip': {'path': '', 18:57:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:57:25 INFO - Running post-action listener: _resource_record_post_action 18:57:25 INFO - ##### 18:57:25 INFO - ##### Running create-virtualenv step. 18:57:25 INFO - ##### 18:57:25 INFO - Running pre-action listener: _resource_record_pre_action 18:57:25 INFO - Running main action method: create_virtualenv 18:57:25 INFO - Creating virtualenv /builds/slave/test/build/venv 18:57:25 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 18:57:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:57:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:25 INFO - Using real prefix '/tools/python27' 18:57:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:57:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:29 INFO - Installing pip.................done. 18:57:29 INFO - Return code: 0 18:57:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:57:29 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')]} 18:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:29 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')]} 18:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:29 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:29 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 18:57:29 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 18:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:29 INFO - 'HOME': '/Users/cltbld', 18:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:29 INFO - 'LOGNAME': 'cltbld', 18:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:29 INFO - 'MOZ_NO_REMOTE': '1', 18:57:29 INFO - 'NO_EM_RESTART': '1', 18:57:29 INFO - 'PAGER': '/bin/cat', 18:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:29 INFO - 'PWD': '/builds/slave/test', 18:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:29 INFO - 'SHELL': '/bin/bash', 18:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:29 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:29 INFO - 'USER': 'cltbld', 18:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:29 INFO - 'XPC_FLAGS': '0x0', 18:57:29 INFO - 'XPC_SERVICE_NAME': '0', 18:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:29 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 18:57:29 INFO - Cleaning up... 18:57:29 INFO - Return code: 0 18:57:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:57:29 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')]} 18:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:29 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')]} 18:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:29 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:29 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 18:57:29 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 18:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:29 INFO - 'HOME': '/Users/cltbld', 18:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:29 INFO - 'LOGNAME': 'cltbld', 18:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:29 INFO - 'MOZ_NO_REMOTE': '1', 18:57:29 INFO - 'NO_EM_RESTART': '1', 18:57:29 INFO - 'PAGER': '/bin/cat', 18:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:29 INFO - 'PWD': '/builds/slave/test', 18:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:29 INFO - 'SHELL': '/bin/bash', 18:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:29 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:29 INFO - 'USER': 'cltbld', 18:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:29 INFO - 'XPC_FLAGS': '0x0', 18:57:29 INFO - 'XPC_SERVICE_NAME': '0', 18:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:29 INFO - Downloading/unpacking psutil>=0.7.1 18:57:29 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 18:57:29 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 18:57:29 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 18:57:29 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 18:57:29 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 18:57:29 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 18:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:32 INFO - Installing collected packages: psutil 18:57:32 INFO - Running setup.py install for psutil 18:57:32 INFO - building 'psutil._psutil_osx' extension 18:57:32 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 18:57:33 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 18:57:33 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 18:57:33 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 18:57:33 INFO - building 'psutil._psutil_posix' extension 18:57:33 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 18:57:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:57:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:57:33 INFO - ^ 18:57:33 INFO - 1 warning generated. 18:57:33 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 18:57:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:33 INFO - Successfully installed psutil 18:57:33 INFO - Cleaning up... 18:57:33 INFO - Return code: 0 18:57:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:33 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:33 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 18:57:33 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 18:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:33 INFO - 'HOME': '/Users/cltbld', 18:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:33 INFO - 'LOGNAME': 'cltbld', 18:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:33 INFO - 'MOZ_NO_REMOTE': '1', 18:57:33 INFO - 'NO_EM_RESTART': '1', 18:57:33 INFO - 'PAGER': '/bin/cat', 18:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:33 INFO - 'PWD': '/builds/slave/test', 18:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:33 INFO - 'SHELL': '/bin/bash', 18:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:33 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:33 INFO - 'USER': 'cltbld', 18:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:33 INFO - 'XPC_FLAGS': '0x0', 18:57:33 INFO - 'XPC_SERVICE_NAME': '0', 18:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:57:36 INFO - Installing collected packages: mozsystemmonitor 18:57:36 INFO - Running setup.py install for mozsystemmonitor 18:57:36 INFO - Successfully installed mozsystemmonitor 18:57:36 INFO - Cleaning up... 18:57:36 INFO - Return code: 0 18:57:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 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')]} 18:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:37 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 18:57:37 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 18:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:37 INFO - 'HOME': '/Users/cltbld', 18:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:37 INFO - 'LOGNAME': 'cltbld', 18:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:37 INFO - 'MOZ_NO_REMOTE': '1', 18:57:37 INFO - 'NO_EM_RESTART': '1', 18:57:37 INFO - 'PAGER': '/bin/cat', 18:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:37 INFO - 'PWD': '/builds/slave/test', 18:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:37 INFO - 'SHELL': '/bin/bash', 18:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:37 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:37 INFO - 'USER': 'cltbld', 18:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:37 INFO - 'XPC_FLAGS': '0x0', 18:57:37 INFO - 'XPC_SERVICE_NAME': '0', 18:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:37 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:40 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:57:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:41 INFO - Downloading docopt-0.6.1.tar.gz 18:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:41 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:41 INFO - Running setup.py install for blobuploader 18:57:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:57:41 INFO - Running setup.py install for requests 18:57:41 INFO - Running setup.py install for docopt 18:57:42 INFO - Successfully installed blobuploader requests docopt 18:57:42 INFO - Cleaning up... 18:57:42 INFO - Return code: 0 18:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:42 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:42 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 18:57:42 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 18:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:42 INFO - 'HOME': '/Users/cltbld', 18:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:42 INFO - 'LOGNAME': 'cltbld', 18:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:42 INFO - 'MOZ_NO_REMOTE': '1', 18:57:42 INFO - 'NO_EM_RESTART': '1', 18:57:42 INFO - 'PAGER': '/bin/cat', 18:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:42 INFO - 'PWD': '/builds/slave/test', 18:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:42 INFO - 'SHELL': '/bin/bash', 18:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:42 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:42 INFO - 'USER': 'cltbld', 18:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:42 INFO - 'XPC_FLAGS': '0x0', 18:57:42 INFO - 'XPC_SERVICE_NAME': '0', 18:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:42 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-btbIBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:42 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-FQg35H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:42 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-9z14zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:42 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-huvHrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:42 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-tRaP0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:42 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-_2Jxff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-cWMQrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ZeOR9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-wvos8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-3oxmwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-iqTOXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Xs38Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-YlllL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-DV0tJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-7rbiMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-5HNfLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-8eozS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:44 INFO - Running setup.py install for manifestparser 18:57:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:57:44 INFO - Running setup.py install for mozcrash 18:57:44 INFO - Running setup.py install for mozdebug 18:57:44 INFO - Running setup.py install for mozdevice 18:57:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:57:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:57:44 INFO - Running setup.py install for mozfile 18:57:44 INFO - Running setup.py install for mozhttpd 18:57:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Running setup.py install for mozinfo 18:57:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Running setup.py install for mozInstall 18:57:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Running setup.py install for mozleak 18:57:45 INFO - Running setup.py install for mozlog 18:57:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Running setup.py install for moznetwork 18:57:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:45 INFO - Running setup.py install for mozprocess 18:57:45 INFO - Running setup.py install for mozprofile 18:57:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:46 INFO - Running setup.py install for mozrunner 18:57:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:46 INFO - Running setup.py install for mozscreenshot 18:57:46 INFO - Running setup.py install for moztest 18:57:46 INFO - Running setup.py install for mozversion 18:57:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:46 INFO - Cleaning up... 18:57:46 INFO - Return code: 0 18:57:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:46 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')]} 18:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:46 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')]} 18:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:46 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:46 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 18:57:46 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 18:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:46 INFO - 'HOME': '/Users/cltbld', 18:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:46 INFO - 'LOGNAME': 'cltbld', 18:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:46 INFO - 'MOZ_NO_REMOTE': '1', 18:57:46 INFO - 'NO_EM_RESTART': '1', 18:57:46 INFO - 'PAGER': '/bin/cat', 18:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:46 INFO - 'PWD': '/builds/slave/test', 18:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:46 INFO - 'SHELL': '/bin/bash', 18:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:46 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:46 INFO - 'USER': 'cltbld', 18:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:46 INFO - 'XPC_FLAGS': '0x0', 18:57:46 INFO - 'XPC_SERVICE_NAME': '0', 18:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-QYB2CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-20nvZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-OWs5J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-fa6Okx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-iCFJKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-lbDzdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-YFhAJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-EZO7o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-m26xuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:47 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)) 18:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:47 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-26YfDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-JbZFgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-fZZqbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-0glPVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Yh_gSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-C_zk81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Tn6EwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:48 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)) 18:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:48 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ReG0oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:48 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)) 18:57:48 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)) 18:57:48 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)) 18:57:48 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)) 18:57:48 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)) 18:57:48 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)) 18:57:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:51 INFO - Downloading blessings-1.6.tar.gz 18:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:51 INFO - Installing collected packages: blessings 18:57:51 INFO - Running setup.py install for blessings 18:57:51 INFO - Successfully installed blessings 18:57:51 INFO - Cleaning up... 18:57:51 INFO - Return code: 0 18:57:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:51 INFO - Reading from file tmpfile_stdout 18:57:51 INFO - Current package versions: 18:57:51 INFO - blessings == 1.6 18:57:51 INFO - blobuploader == 1.2.4 18:57:51 INFO - docopt == 0.6.1 18:57:51 INFO - manifestparser == 1.1 18:57:51 INFO - mozInstall == 1.12 18:57:51 INFO - mozcrash == 0.16 18:57:51 INFO - mozdebug == 0.1 18:57:51 INFO - mozdevice == 0.48 18:57:51 INFO - mozfile == 1.2 18:57:51 INFO - mozhttpd == 0.7 18:57:51 INFO - mozinfo == 0.9 18:57:51 INFO - mozleak == 0.1 18:57:51 INFO - mozlog == 3.1 18:57:51 INFO - moznetwork == 0.27 18:57:51 INFO - mozprocess == 0.22 18:57:51 INFO - mozprofile == 0.28 18:57:51 INFO - mozrunner == 6.11 18:57:51 INFO - mozscreenshot == 0.1 18:57:51 INFO - mozsystemmonitor == 0.0 18:57:51 INFO - moztest == 0.7 18:57:51 INFO - mozversion == 1.4 18:57:51 INFO - psutil == 3.1.1 18:57:51 INFO - requests == 1.2.3 18:57:51 INFO - wsgiref == 0.1.2 18:57:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57: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')]} 18:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:51 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:51 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 18:57:51 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 18:57:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:51 INFO - 'HOME': '/Users/cltbld', 18:57:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:51 INFO - 'LOGNAME': 'cltbld', 18:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:51 INFO - 'MOZ_NO_REMOTE': '1', 18:57:51 INFO - 'NO_EM_RESTART': '1', 18:57:51 INFO - 'PAGER': '/bin/cat', 18:57:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:51 INFO - 'PWD': '/builds/slave/test', 18:57:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:51 INFO - 'SHELL': '/bin/bash', 18:57:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:51 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:51 INFO - 'USER': 'cltbld', 18:57:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:51 INFO - 'XPC_FLAGS': '0x0', 18:57:51 INFO - 'XPC_SERVICE_NAME': '0', 18:57:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 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)) 18:57:52 INFO - Cleaning up... 18:57:52 INFO - Return code: 0 18:57:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:57:52 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')]} 18:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:52 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')]} 18:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:52 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:52 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 18:57:52 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 18:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:52 INFO - 'HOME': '/Users/cltbld', 18:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:52 INFO - 'LOGNAME': 'cltbld', 18:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:52 INFO - 'MOZ_NO_REMOTE': '1', 18:57:52 INFO - 'NO_EM_RESTART': '1', 18:57:52 INFO - 'PAGER': '/bin/cat', 18:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:52 INFO - 'PWD': '/builds/slave/test', 18:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:52 INFO - 'SHELL': '/bin/bash', 18:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:52 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:52 INFO - 'USER': 'cltbld', 18:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:52 INFO - 'XPC_FLAGS': '0x0', 18:57:52 INFO - 'XPC_SERVICE_NAME': '0', 18:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:52 INFO - Downloading/unpacking jsonschema 18:57:52 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 18:57:52 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 18:57:52 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 18:57:52 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 18:57:52 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 18:57:52 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 18:57:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:54 INFO - Downloading/unpacking functools32 (from jsonschema) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:55 INFO - warning: no files found matching '*.txt' 18:57:55 INFO - no previously-included directories found matching 'build' 18:57:55 INFO - no previously-included directories found matching 'dist' 18:57:55 INFO - no previously-included directories found matching '.git*' 18:57:55 INFO - Installing collected packages: jsonschema, functools32 18:57:55 INFO - Running setup.py install for functools32 18:57:55 INFO - warning: no files found matching '*.txt' 18:57:55 INFO - no previously-included directories found matching 'build' 18:57:55 INFO - no previously-included directories found matching 'dist' 18:57:55 INFO - no previously-included directories found matching '.git*' 18:57:55 INFO - Successfully installed jsonschema functools32 18:57:55 INFO - Cleaning up... 18:57:55 INFO - Return code: 0 18:57:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:57: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')]} 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:55 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 0x109b00a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85bbc83020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, '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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 18:57:55 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 18:57:55 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 18:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:55 INFO - 'HOME': '/Users/cltbld', 18:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:55 INFO - 'LOGNAME': 'cltbld', 18:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:55 INFO - 'MOZ_NO_REMOTE': '1', 18:57:55 INFO - 'NO_EM_RESTART': '1', 18:57:55 INFO - 'PAGER': '/bin/cat', 18:57:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:55 INFO - 'PWD': '/builds/slave/test', 18:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:55 INFO - 'SHELL': '/bin/bash', 18:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:57:55 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:55 INFO - 'USER': 'cltbld', 18:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:55 INFO - 'XPC_FLAGS': '0x0', 18:57:55 INFO - 'XPC_SERVICE_NAME': '0', 18:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:55 INFO - Downloading/unpacking flake8 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:57:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:57:57 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 18:57:57 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 18:57:57 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 18:57:57 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 18:57:57 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 18:57:57 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 18:57:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:57:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:59 INFO - no previously-included directories found matching 'docs/_build' 18:57:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:57:59 INFO - Running setup.py install for pep8 18:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:59 INFO - no previously-included directories found matching 'docs/_build' 18:57:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:57:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:57:59 INFO - Cleaning up... 18:57:59 INFO - Return code: 0 18:57:59 INFO - Running post-action listener: _resource_record_post_action 18:57:59 INFO - Running post-action listener: _start_resource_monitoring 18:57:59 INFO - Starting resource monitoring. 18:57:59 INFO - ##### 18:57:59 INFO - ##### Running install step. 18:57:59 INFO - ##### 18:57:59 INFO - Running pre-action listener: _resource_record_pre_action 18:57:59 INFO - Running main action method: install 18:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:59 INFO - Reading from file tmpfile_stdout 18:57:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:59 INFO - Reading from file tmpfile_stdout 18:57:59 INFO - Output received: 18:57:59 INFO - Usage: mozinstall [options] installer 18:57:59 INFO - Options: 18:57:59 INFO - -h, --help show this help message and exit 18:57:59 INFO - -d DEST, --destination=DEST 18:57:59 INFO - Directory to install application into. [default: 18:57:59 INFO - "/builds/slave/test"] 18:57:59 INFO - --app=APP Application being installed. [default: firefox] 18:57:59 INFO - mkdir: /builds/slave/test/build/application 18:57:59 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'] 18:57:59 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 18:58:33 INFO - Reading from file tmpfile_stdout 18:58:33 INFO - Output received: 18:58:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:58:33 INFO - Running post-action listener: _resource_record_post_action 18:58:33 INFO - ##### 18:58:33 INFO - ##### Running run-tests step. 18:58:33 INFO - ##### 18:58:33 INFO - Running pre-action listener: _resource_record_pre_action 18:58:33 INFO - Running main action method: run_tests 18:58:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:58:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:58:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:58:33 INFO - 2016-02-25 18:58:33.976 screenresolution[1652:7554] starting screenresolution argv=screenresolution get 18:58:33 INFO - 2016-02-25 18:58:33.979 screenresolution[1652:7554] Display 0: 1600x1200x32@60 18:58:33 INFO - 2016-02-25 18:58:33.984 screenresolution[1653:7556] starting screenresolution argv=screenresolution list 18:58:33 INFO - Available Modes on Display 0 18:58:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:58:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:58:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:58:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:58:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:58:34 INFO - Intel Iris: 18:58:34 INFO - Chipset Model: Intel Iris 18:58:34 INFO - Type: GPU 18:58:34 INFO - Bus: Built-In 18:58:34 INFO - VRAM (Dynamic, Max): 1536 MB 18:58:34 INFO - Vendor: Intel (0x8086) 18:58:34 INFO - Device ID: 0x0a2e 18:58:34 INFO - Revision ID: 0x0009 18:58:34 INFO - Displays: 18:58:34 INFO - Display: 18:58:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:58:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:58:34 INFO - Display Serial Number: 1600x1200 60 18:58:34 INFO - Main Display: Yes 18:58:34 INFO - Mirror: Off 18:58:34 INFO - Online: Yes 18:58:34 INFO - Rotation: Supported 18:58:34 INFO - Return code: 0 18:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:58:34 INFO - Python 2.7.3 18:58:34 INFO - Return code: 0 18:58:34 INFO - grabbing minidump binary from tooltool 18:58: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')]} 18:58:34 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 0x1099a4d30>, '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 0x1097c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10999bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:58:34 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 18:58:34 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 18:58:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:34 INFO - Return code: 0 18:58:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:58:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:58:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:58:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:58:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:58:35 INFO - Return code: 0 18:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 18:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 18:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sm3fyzcVCf/Render', 18:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:35 INFO - 'HOME': '/Users/cltbld', 18:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:35 INFO - 'LOGNAME': 'cltbld', 18:58:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:58:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:35 INFO - 'MOZ_NO_REMOTE': '1', 18:58:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:58:35 INFO - 'NO_EM_RESTART': '1', 18:58:35 INFO - 'PAGER': '/bin/cat', 18:58:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:35 INFO - 'PWD': '/builds/slave/test', 18:58:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:35 INFO - 'SHELL': '/bin/bash', 18:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zvFg1obJ2v/Listeners', 18:58:35 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 18:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:35 INFO - 'USER': 'cltbld', 18:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:35 INFO - 'XPC_FLAGS': '0x0', 18:58:35 INFO - 'XPC_SERVICE_NAME': '0', 18:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 18:58:35 INFO - mozversion application_buildid: 20160225171127 18:58:35 INFO - mozversion application_changeset: 89eb5bb84d99324522bad7a707e08ff34932e6e9 18:58:35 INFO - mozversion application_display_name: Nightly 18:58:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:35 INFO - mozversion application_name: Firefox 18:58:35 INFO - mozversion application_remotingname: firefox 18:58:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:58:35 INFO - mozversion application_vendor: Mozilla 18:58:35 INFO - mozversion application_version: 47.0a1 18:58:35 INFO - mozversion platform_buildid: 20160225171127 18:58:35 INFO - mozversion platform_changeset: 89eb5bb84d99324522bad7a707e08ff34932e6e9 18:58:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:58:35 INFO - mozversion platform_version: 47.0a1 18:58:35 INFO - using testdate: 1456455515 18:58:35 INFO - actual date: 1456455515 18:58:36 INFO - starting webserver on 'localhost:49274' 18:58:36 INFO - SUITE-START | Running 2 tests 18:58:36 INFO - TEST-START | dromaeo_css 18:58:36 INFO - operating with platform_type : mac_ 18:58:36 INFO - Initialising browser for dromaeo_css test... 18:58:36 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmp_7ChJH/profile http://localhost:49274/getInfo.html) 18:58:38 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 18:58:38 INFO - PROCESS | 1671 | colorDepth:24 18:58:38 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 18:58:38 INFO - PROCESS | 1671 | __metrics 18:58:38 INFO - PROCESS | 1671 | 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" 18:58:38 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:39 INFO - TEST-INFO | 1671: exit 0 18:58:39 INFO - Browser initialized. 18:58:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:58:39 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmp_7ChJH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:51 INFO - PROCESS | 1674 | RSS: Main: 242925568 18:58:51 INFO - PROCESS | 1674 | 18:59:41 INFO - PROCESS | 1674 | 1456455581802 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:01:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 19:01:53 INFO - PROCESS | 1674 | RSS: Main: 347303936 19:01:53 INFO - PROCESS | 1674 | 19:04:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 19:04:56 INFO - PROCESS | 1674 | RSS: Main: 376786944 19:04:56 INFO - PROCESS | 1674 | 19:07:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 19:07:58 INFO - PROCESS | 1674 | RSS: Main: 379068416 19:07:58 INFO - PROCESS | 1674 | 19:11:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 19:11:01 INFO - PROCESS | 1674 | RSS: Main: 335736832 19:11:01 INFO - PROCESS | 1674 | 19:14:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 19:14:05 INFO - PROCESS | 1674 | RSS: Main: 334876672 19:14:05 INFO - PROCESS | 1674 | 19:17:07 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 19:17:08 INFO - PROCESS | 1674 | RSS: Main: 394022912 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | __start_tp_report 19:17:08 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 19:17:08 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 19:17:08 INFO - PROCESS | 1674 | |i|pagename|runs| 19:17:08 INFO - PROCESS | 1674 | |0;dojo.html;2891.754200892924;3418.3846907556645;3426.8457919393627;3436.656334366562;3546.1843775931534;5553.861153471165;5600.327960644723;5613.775448982041;5642.0126477866415;5644.266245388104;5598;5629.324481062268;5661.3206415230125;5760.135979603062;5788.450097240755;5082.593392528607;5119.488051194879;5129.204973229137;5145.99653067652;5246.5278124968745;5207.7916883324815;5238.397584277819;5271;5285.02227087988;5313.442088580701;5071.239314102896;5130.9743451282875;5166.250893620423;5194.194899790538;5218.660787048868;5158.561522270612;5164.992826398854;5167.4057483389515;5167.7932882684645;5172.818951336722;5103.979204159146;5113.82101626445;5144.305518754958;5164.070467315882;5203.245529398254;5521.171824226358;5524.861878453031;5609.214709940612;5641.464060914206;5645.5483561314995;6186.1648677428875;6207.503399728011;6213.347598502138;6213.720382582795;6214.502839772807;6239.563230573816;6267.247930248353;6276.058591211309;6281.026440901667;6299.212598425197;5604.691741954191;5616.494515493625;5696.715164241813;5699;5699.743511542032;6172.629642221481;6264.123022776815;6296.150019747367;6318;6323.715432805535;6053.031514957674;6133.907991380132;6135.845176233341;6142.140100385949;6142.324344322121;6262.2172228471445;6262.248530176408;6266.373362663789;6269.404406581368;6281.277653069864;6023.578349515579;6122.295935967331;6127.927612667765;6174.845628859224;6185;6052.273727152769;6125.0429919399385;6128.509719222451;6132.447291485866;6174.722137503823;4819.759012049383;4854.441739200037;4872.634552408584;4881.804727810919;4902.558769710743;4245.299525578307;4289.67827412939;4345.456817897762;4348.608625223745;4362.411074504901;4530.864074077783;5008.84973450797;5584.46947539983;5602.411746766531;5620.971895140498;6139.706800529404;6217.160683307696;6227.439530442282;6238;6247.75008999644;5643.1535269709875;5655.519280861091;5668.178114173422;5673.262475878109;5719.971400142973;5266.420693723688;5280.9471905281225;5290.576753859682;5331.44019877915;5360.91958620621;6213.536170127955;6309.3690630936535;6314.084457753692;6316.336784637639;6331.68341582919;6192.349803270592;6202.844928876814;6255.46828519581;6261;6279.120923070683;6256.436920677161;6257.43683068526;6288.654124023223;6326.9683651581445;6327.462165715781;6083.847903802263;6093.268807743099;6100.0849872519475;6105.297890742621;6110.938890611037;4910.45984941649;5115.64190506661;6221.9377806221355;6223.128761973237;6234.719437625227;5941.079132734433;5972;5987.970060149845;6025.87948241024;6058.3335833057445;5980.700964951648;6008.939910600838;6010.188624535632;6037.366076561898;6093.421124993119;5733.283339582552;5828.679422631626;5887.293524776883;5904;5911.349751527243;5861.531077513703;5984.58107932458;6079.787207447718;6081.361457046946;6108.053251745987;5872.941270587239;5900.763969441175;5907.675077870758;5909.793157239476;5911.1428842816695 19:17:08 INFO - PROCESS | 1674 | |1;ext.html;473.7891638220993;547.6905548365173;567.909134538474;568.8168609292671;570.1704020649955;28691.139265822032;29903;37191.62808371919;37216;37311.06722331943;41419.37870931938;42089.57910420895;42103;42139.57860421395;42158.789206054;9468.28987825914;9705.010472853084;9719;9719.659811906584;9750.9512452438;9526.333156679035;9530.094641009127;9538.761530961712;9583.802024746907;9686.564104615274;9627.422354658707;9733.902660973406;9744.366616169926;9751.902480975206;9772.609095636166;9640.228781697482;9682.90317096834;9699.127078562893;9708.17480514157;9730.270229732763;9485.762855928657;9629.422234665872;9637.18083962864;9645.614175432975;9650.469224192666;38984;39333;39333.213335733126;39341.21317573661;39447;3106.316610345743;3149.826759528225;3155.668654791237;3165.683431656816;3526.2242306692488;27387.04145354903;27599.862000690067;27678.723212767814;28178.859105704545;28893.133206003855;2739.397332586828;2745.052956729925;2759.0343379817105;2783.1650504848667;2815.000674760451;355789;355876;355894;357021;357188;60318.69840650768;60621;61062.69468652628;61067;61086;65002.02496962549;65030;65036;65091;65480;15751.68496630061;15934.840651593568;15979.201039947957;15997.840021599868;15998.840011599968;12048.03615710741;12233.510659573696;12269.07981901361;12283.447244874002;12302.876971230353;18926.90536547336;18941.62116757657;19321.90339048296;19419.223231070882;20115.899420503098;7464.589447580435;8613.526256055977;8930.419522731001;8934.749135121088;8953.731388058368;910.854263317866;967.02330646048;972.0959507657946;1031.664708969588;1045.4459136657583;22621.660675089886;23408.414789630395;28208.43583128367;29153.708462915525;29291.707082929322;1054.5254635414094;1070.4861666400172;1079.1259080145107;1095.9616413425492;1141.5947338694643;14567.927160364343;14622.26888655563;14805.481808136663;14822.62943426423;14892.478763243234;509234;511692;515183;516062;518200.4089979526;55058.17412738812;55364;55425.722871385384;55510.444895551336;55579.44420555823;1115.754534002518;1366.2827015816777;1407.8521755215554;1455.221456520735;1456.4538298138198;27766;27847;28170.85914570414;28686;28900.710992889803;44900.77549612231;45523.317150243434;45530.861728455726;45557.77221114006;45574.31638525359;348867;360453;361090;361288;361889;27260.863695681393;27610.723892760816;27630.894764209206;31169.68830311668;32296.031119066465;38875.63935262252;38927;39370.803145984086;40239.79880100581;40246.39630405488;33133.17167070843;36148.638513614525;36752.26495470129;37272.62727372692;39066.60933390629;34964.47553286754;35421.82289088538;35470.290594187456;36122;36158.638413615525;36133.277334452636;36379.63620363762;36937.70718024856;36961.63038369582;37728.245435091696;24706;28952.986645467307;30696.386072278878;30855.537166942962;31543.68456315499;23827.166049188196;24317;24501.019959201432;24571.262862114167;24646.753532464445 19:17:08 INFO - PROCESS | 1674 | |2;jquery.html;355.7029880050158;358.3728475168455;363.6545281982116;364.89235675475726;366.948627192193;19044.90477547612;19273.421797346065;19335.419937401883;19711.211551537923;19719.5070123247;18372.17325220365;19249.326273580427;19746.815191088546;19764.70352944707;19777.60444791103;5608.803691870775;5762.135679648065;5821.50517206038;5824.679642619654;5829;4184.916301673965;4377.606015458608;5177.844664660066;5781.913271300913;6412.5190610704385;6339.683015849212;6356.237251529823;6360.618362898241;6365.52258580606;6423.64669943153;6053.606515576474;6307.306196318401;6312.179416675825;6313.305536390993;6329.303776584572;3675.2098298865603;5223.2165175223645;5421.105517589593;5427.891442171174;5437.592180586433;23603;24112.794360282092;24343.391415214763;24524.386890327707;24568.877155614286;2029.7462817147857;2104.168853302937;2175.9020844062056;2276.089564174327;2276.760940101282;13435;13764.380602872894;13950.23273719945;13984.86015139856;14192.92903535486;1697.7979056866875;1743.250402326999;1754.4385796545112;1764.4265613675607;1773.733939909024;101260;105628.47185764022;105851;106313;106777;10041.397516149054;10159.847602285972;10190.337628054152;10396.532156052996;10550.050495455445;12628.936855315664;12712.42794074269;12741.55404560836;12759.170653907466;12775.23348599087;7194.46041546886;7989.360851131895;8072.717454889051;8264.752057438287;8323.66705331792;8415.915840841635;8430.957845210858;8439.282660973886;8492;8529.14708529142;5995.640261584319;6110.29731580865;6110.602810817282;6112.724927378279;6206.410391012847;1656.5008667156244;1702.838230368113;1742.3901634427848;1752.229019231534;1796.9550761231073;847.9194476524843;931.2224292715523;984.015984015984;1030.9690709278734;1047.994760026195;18838;19562.21751129939;19646.41060768179;19682.409527714193;19718.70421943672;931.3945935142076;937.0863408176973;977.6578197630772;983.095552092077;1064.893510648929;10848.62029828968;10878.40168790724;10906.890931090746;10920.563177472972;10922.726931826768;587378;608001;635177;649136;654738.4526154677;101089.49455252677;102055;102788;103357.96642033484;104395;989.9208063354914;996.850472429127;1003.6487229469627;1057.603398725478;1073.7476692977143;17641.82358176402;17870.98019228777;17872.642547149244;17917.641647167246;17989.820101798814;49461.75269123631;49525.25712114249;50072.49927500678;50448.747756260986;50603.24095138502;62999.6850015747;63129;63233.500744139325;64360;64363.67818160879;7730.497517661334;7744.728934487266;7814.960925195338;7821.569813660076;8128.796780080545;12541.122121451412;12845.807312890502;12996;13246.271455070064;13282;11029.062529685067;11370.123929551863;11430.314181149157;11439.256448330832;11565.710857228636;10876.945615271872;11025.83461248098;11211.55153793839;11284.943575282072;11473.483693233991;6684.997250412477;8740.60667269987;9056.864147037668;11475.13936454786;11544.653660390202;7654.961725191339;7750.379969602531;7790.727324543614;7828.647710852912;7984.321332686786;11307.208495405243;11313;11538.711532211426;11614.12894032934;11658.242214256046 19:17:08 INFO - PROCESS | 1674 | |3;mootools.html;1294.8122522234275;1368.3500337339758;1469.5517867050553;1497.9813726665866;1877.1928070929503;7797.610119494024;8397.664093436262;8552.786180345494;8552.828943421127;8567.700130495434;8173.509589424639;8433.367497437686;8440.620172092255;8455.661773529067;8460.407771456;2173.152470536492;2396.544656515265;2430.3195105370523;2431.1004928176553;2441.7802397784194;2357.9410514737096;2420.9031638734427;2421.6609674645474;2428.4657375377387;2431.4407686232175;2007.7791442941266;2310.145246258878;2385.3917251100943;2445.987770061156;2450.5098980203943;2056.331692200041;2389.976100238993;2439.426734717349;2446.3639453742157;2448.0574978633354;2409.7590240975937;2443.2059580636187;2451.6935383077116;2454.8649824259837;2467.2721547143638;8589.613467393981;8684.131586841266;8692.391532592721;8700.56497175145;8707.434016788888;5360.758765855546;5511.255980442629;5517.337919449692;5519.475649813261;5526.088195447786;3612.747107702462;3613.313470440608;3690.7970061646597;3694.8891533253777;3721;1052.0899421999916;1067.7544164842052;1078.2182917384912;1080.0333701337338;1087.12486448409;11728.765424691544;11758.17692761507;11791.823122653168;11803.11476639247;11868.88131118695;4247.830086796555;4815.30178124177;4836.443808961944;4854.106898309662;4858.222684370484;10102.949485252526;10111.72486190616;10116.747081323027;10122.39265644049;10144.949275253577;5435.891282174334;5447.428020057916;5449.782008719607;5450.618456707993;5454.727263636882;4024.8188831502653;4386.539413361551;4554.612857907115;4845.6608037437045;4851.708897466164;3818.694504439694;3908.4528166056775;3909.198614284065;3929.0766669832565;3966;1287.4657017337888;1302.856685764565;1303.4199781097511;1311.9540816071392;1320.1419077599446;1036.4921188617675;1037.86507753993;1049.7533079726259;1082.6751974407646;1093.8031154392127;8000.159983201796;8044.758657240292;8075.394345424117;8119.79700507492;8130.471519351223;505.919052951526;510.52521155325906;515.6081378152631;516.302990962198;519.3482179864246;5987.311459182162;5989.520838332923;6029.366916473795;6031.24609423822;6042.546808989343;10091.798164036825;10582.417967011734;10665.253432259822;10672.626458074086;10679.359238445719;10159.796804063877;10288;10427.322224055411;10487.318324308895;10528.789424211473;8142.796430089176;8143.144969778206;8158;8213.219744124299;8229.423940324119;7576.659050342638;7717.2282771722375;7731.7680469586;7742.922570774445;7830.256125668053;9087.363884528284;9366.531673416439;9415.57629906642;9493.240540756584;9609.519524023632;9443.858342125011;9693.369930954465;9736.46449445259;9863.506824658882;9877.753056173653;6660.533762636763;6828.965855170891;7055.435565154673;7345.155307139534;7424.925750742639;7977.2022797719765;7999.640016199169;8042.155573664915;8044.034715834137;8063;7098.3256590623805;7221.711131554679;7242.456815738946;7354.595497247703;7406.44451666138;7033.9296607033275;7128.501004929813;7188.676509556978;7206.423486121203;7241.782746517613;7418.258174182539;7523.3981281498445;7525.774226773206;7530.134034586093;7540.057492813398;6769.458443324424;6848.931510685029;6859.3140685933;6861.142357205349;6885.586864787929;6801.1158549388265;6937.89593156093;6938.791836244921;6949.687264073028;6953.096097507291 19:17:08 INFO - PROCESS | 1674 | |4;prototype.html;317.06940130716345;319.9744020478362;326.9798229523886;329.4415964939427;329.4498188025998;6551.21385433748;6599.637019963906;6599.769008084718;6651.866962660744;6689.732410703578;6518.185226846645;6557.508186885979;6563.7046332915015;6577.34226577342;6585.4402375798;4632.884177895546;4715.622750179995;4718.221493453576;4718.363020992174;4882.487338829434;3794.753341032838;4724.622030237572;4732.739699316537;4798.232282834747;4805.423349198101;4740.76296185191;4746.549077837617;4753.762311884392;4768.451628062765;4771.165046116933;4754.928676069827;4767.332573439739;4770.880727981794;4831.323614693945;4832.275158726184;3936.8425262989444;4005.7396269242404;4087.3460246360737;4088.407180958774;4091.8158682859344;6230.688465576748;6270.31026587075;6346.333634968308;6349;6358.395952384516;4838.637102217348;4922.9261561076255;5128.205128205134;5659.151127330892;5659.915101273484;6935.861282774316;6952.791416257521;6965.407940325078;6969.47728920333;6995.440364770857;4594.081183763261;4596;4597.7011494252765;4617.30740388941;4620.075984803019;7031.8945215821805;7277.781666550012;7304.96347518259;7313.963430182868;7332.376747976428;4453.376527286183;4529.252673308933;4531.342955271467;4534.79593418297;4543.68194226401;3860.1507668312925;4572.657050721209;4611.930821037688;4626.86119416418;4640.187967105743;4451.621612163002;5481.671099734029;5485.518909894386;5492.038893193675;5555.30558680165;6778.661066946633;7005.754798582026;7022.227554968949;7035.226125126232;7060.929390706027;1575.866051385645;1619.1580378203269;1620.2141961148834;1620.6596614710807;1622.261870848761;1006.808706345792;1023.2530252915265;1039.0907955538903;1045.9738506537244;1047.9476026198658;5553.250311207935;6261.655608941461;6497.382748638872;6592.86814263712;6600.240972288152;5848.4151584841175;7271.418286537064;7280.563166210044;7282.4902256841515;7301.926980730231;6620.404163625297;6659.966700166468;6661.367170118831;6663.000549917551;6664.433523150489;3404.4382676858536;3808.6572208501366;3851.5378154621626;3858.2090671412293;3858.344081506151;6119.663418512025;6535.313792051861;6694.966525167343;7308.634568271672;7561.508501947355;6011.248593925759;7499.812504687427;7512.21121782216;7636.31273185416;7752.844943101107;7622.123455802543;7637.236276372319;7637.961810191136;7639.656215470317;7662.8084297893;7303.342699156889;7313.378362839218;7318.268173182639;7331.4867959244475;7332.30343117403;6991.056207411934;7165.104361954755;7180.389666878374;7237.963810180915;7256;7629.351505121905;7666.853281081306;7676.117246516722;7680.270374314431;7699.807504812425;4592.931106033346;4650.255959046536;4651.7441540714235;4656.41794775653;4665.930011049769;7264.418846492374;7289.125304963438;7289.343959043499;7301.671424785791;7307.086614173229;6745.865082698417;6984.615846128511;7013.684384202825;7024.648767561499;7029.929700702927;5575.77696892136;6957.582545047313;6962.860742785218;6973.232944376216;6982.511224214256;6831.726730930906;6849.589024658537;6858.588484690935;6872.587644741331;6872.965635171792;7039.788806335818;7058.6470676467;7063.223045465097;7065.258147894397;7068.29317068289;6559.4752419805345;6624.9337506624315;6835.555688880207;6887.414569761627;6902.8619427610165 19:17:08 INFO - PROCESS | 1674 | |5;yui.html;680.8502129531503;739.1389031777979;754.3814072460577;756.59900252866;768.3507436216397;14632.414703411863;14928.850711492882;15049.54851354461;15054.924725376371;15066.246687665627;13557.25435101069;13737.725245495109;13765.31173441329;13771.517996870112;13781.517646882336;703.6130128429369;711.2176605733678;831.604987630875;865.3855762408666;868.5266529741306;713.6503113474386;713.9714411423537;714.6212507371101;855.2901092093579;867.1891781184613;893.2228960804109;902.8781114549517;903.615963215634;903.9231665308457;905.4567259644226;886.0386480668483;894.414158726029;894.7136916186823;896.1083721696954;897.5557099235888;545.2448359022742;545.6371512943888;549.209138840069;660.5904339309611;663.7212370804274;14780.70438591233;14822.629434264121;14852.554423367315;14859.331330090065;14888;12419.31693756843;12477;12563.874361256454;12564.43460044291;12707.682307942283;9866.26003049767;9939.701808945743;10181.592736290539;10231.976802319783;10495.475226238734;3500.789952602852;3548.1661809474754;3575.8390872410805;3674.8346324415465;3680.5031320771623;79703.6014819928;80375.5981220096;80439.19560804375;80441.59779201067;80459;9336.626534938663;9478.952605237067;9597.952010239904;9666.565004574812;10011.048950349705;20130.597388052156;20215.797842021686;20428.693569596468;21680.566388672138;21715;7429;7488.138864030706;7540.585267810323;7573.962130189314;7695.576743279062;4100.774457404871;4128.236276288896;4147.4815648044;4157.251694694924;4214.494260688737;3513.4905438711244;3519.9120021999656;3557.2351944332095;3557.7331700122595;3564.4475106358555;639.9104125422444;646.1277275677892;646.1470858466872;655.0959675647671;662.0631805994464;541.2665837789817;543.1337017457149;596.6509591888707;619.956603037783;627.9529035322369;8101.878471822927;8206.138355472709;8311.625976831057;8330.880922571921;8361.205685459872;539.0162952611421;570.3725901508308;576.4293349583882;594.9940500595026;595.487880422836;3805.7526260793516;3847.6921846252235;3886.4947556817433;3896.0844201613163;3907.3357529219534;93642.59536106965;93715.53142234382;97197;97724.02275977291;97875;80108.59945700235;81170.18829811744;81314;82202.58898705468;82341.58829205815;70787.64606176937;71403.2859671407;72756.99673035962;73334;73850.2614973854;7567.470277080772;7682.923170768444;7737.226277372218;7910.327622152182;7965.721199757981;49254.50745492499;49448;50388;50405.24392134194;51087.48912510827;60037;66792.6660366695;67011;67657.30856728424;68292;9430.528473576156;9446.622135114518;9676.661316853877;9777.951110244403;9855.901440985499;10695.94652026766;10876.564937402733;10885.238033337908;10974.067204287725;11151.83272250933;10161.745956351151;10249;10393.012663796928;10441.060304572626;10458.843117353093;10217.693469195936;10422.270441069053;10458.790824183627;10470.947645261725;10503;8121.5533145677555;9980.800383992135;9982.60069597208;9993.00069992995;10319.638812641522;8617.138286171332;8685.044645089161;8690.391672582859;8738;8965.955170224108;8592.535185378243;8684.826303474021;8742.475451472932;8876.289896808368;8919.152680495343 19:17:08 INFO - PROCESS | 1674 | __end_tp_report 19:17:08 INFO - PROCESS | 1674 | __start_cc_report 19:17:08 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,964 19:17:08 INFO - PROCESS | 1674 | __end_cc_report 19:17:08 INFO - PROCESS | 1674 | __startTimestamp1456456628243__endTimestamp 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | ------- Summary: start ------- 19:17:08 INFO - PROCESS | 1674 | Number of tests: 6 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5675.04 Median:5900.76 stddev:655.66 (11.1%) stddev-sans-first:620.25 19:17:08 INFO - PROCESS | 1674 | Values: 2891.8 3418.4 3426.8 3436.7 3546.2 5553.9 5600.3 5613.8 5642.0 5644.3 5598.0 5629.3 5661.3 5760.1 5788.5 5082.6 5119.5 5129.2 5146.0 5246.5 5207.8 5238.4 5271.0 5285.0 5313.4 5071.2 5131.0 5166.3 5194.2 5218.7 5158.6 5165.0 5167.4 5167.8 5172.8 5104.0 5113.8 5144.3 5164.1 5203.2 5521.2 5524.9 5609.2 5641.5 5645.5 6186.2 6207.5 6213.3 6213.7 6214.5 6239.6 6267.2 6276.1 6281.0 6299.2 5604.7 5616.5 5696.7 5699.0 5699.7 6172.6 6264.1 6296.2 6318.0 6323.7 6053.0 6133.9 6135.8 6142.1 6142.3 6262.2 6262.2 6266.4 6269.4 6281.3 6023.6 6122.3 6127.9 6174.8 6185.0 6052.3 6125.0 6128.5 6132.4 6174.7 4819.8 4854.4 4872.6 4881.8 4902.6 4245.3 4289.7 4345.5 4348.6 4362.4 4530.9 5008.8 5584.5 5602.4 5621.0 6139.7 6217.2 6227.4 6238.0 6247.8 5643.2 5655.5 5668.2 5673.3 5720.0 5266.4 5280.9 5290.6 5331.4 5360.9 6213.5 6309.4 6314.1 6316.3 6331.7 6192.3 6202.8 6255.5 6261.0 6279.1 6256.4 6257.4 6288.7 6327.0 6327.5 6083.8 6093.3 6100.1 6105.3 6110.9 4910.5 5115.6 6221.9 6223.1 6234.7 5941.1 5972.0 5988.0 6025.9 6058.3 5980.7 6008.9 6010.2 6037.4 6093.4 5733.3 5828.7 5887.3 5904.0 5911.3 5861.5 5984.6 6079.8 6081.4 6108.1 5872.9 5900.8 5907.7 5909.8 5911.1 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:55956.89 Median:199023.82 stddev:110420.58 (55.5%) stddev-sans-first:110651.76 19:17:08 INFO - PROCESS | 1674 | Values: 473.8 547.7 567.9 568.8 570.2 28691.1 29903.0 37191.6 37216.0 37311.1 41419.4 42089.6 42103.0 42139.6 42158.8 9468.3 9705.0 9719.0 9719.7 9751.0 9526.3 9530.1 9538.8 9583.8 9686.6 9627.4 9733.9 9744.4 9751.9 9772.6 9640.2 9682.9 9699.1 9708.2 9730.3 9485.8 9629.4 9637.2 9645.6 9650.5 38984.0 39333.0 39333.2 39341.2 39447.0 3106.3 3149.8 3155.7 3165.7 3526.2 27387.0 27599.9 27678.7 28178.9 28893.1 2739.4 2745.1 2759.0 2783.2 2815.0 355789.0 355876.0 355894.0 357021.0 357188.0 60318.7 60621.0 61062.7 61067.0 61086.0 65002.0 65030.0 65036.0 65091.0 65480.0 15751.7 15934.8 15979.2 15997.8 15998.8 12048.0 12233.5 12269.1 12283.4 12302.9 18926.9 18941.6 19321.9 19419.2 20115.9 7464.6 8613.5 8930.4 8934.7 8953.7 910.9 967.0 972.1 1031.7 1045.4 22621.7 23408.4 28208.4 29153.7 29291.7 1054.5 1070.5 1079.1 1096.0 1141.6 14567.9 14622.3 14805.5 14822.6 14892.5 509234.0 511692.0 515183.0 516062.0 518200.4 55058.2 55364.0 55425.7 55510.4 55579.4 1115.8 1366.3 1407.9 1455.2 1456.5 27766.0 27847.0 28170.9 28686.0 28900.7 44900.8 45523.3 45530.9 45557.8 45574.3 348867.0 360453.0 361090.0 361288.0 361889.0 27260.9 27610.7 27630.9 31169.7 32296.0 38875.6 38927.0 39370.8 40239.8 40246.4 33133.2 36148.6 36752.3 37272.6 39066.6 34964.5 35421.8 35470.3 36122.0 36158.6 36133.3 36379.6 36937.7 36961.6 37728.2 24706.0 28953.0 30696.4 30855.5 31543.7 23827.2 24317.0 24501.0 24571.3 24646.8 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:34135.13 Median:2226.00 stddev:103513.89 (4650.2%) stddev-sans-first:103773.20 19:17:08 INFO - PROCESS | 1674 | Values: 355.7 358.4 363.7 364.9 366.9 19044.9 19273.4 19335.4 19711.2 19719.5 18372.2 19249.3 19746.8 19764.7 19777.6 5608.8 5762.1 5821.5 5824.7 5829.0 4184.9 4377.6 5177.8 5781.9 6412.5 6339.7 6356.2 6360.6 6365.5 6423.6 6053.6 6307.3 6312.2 6313.3 6329.3 3675.2 5223.2 5421.1 5427.9 5437.6 23603.0 24112.8 24343.4 24524.4 24568.9 2029.7 2104.2 2175.9 2276.1 2276.8 13435.0 13764.4 13950.2 13984.9 14192.9 1697.8 1743.3 1754.4 1764.4 1773.7 101260.0 105628.5 105851.0 106313.0 106777.0 10041.4 10159.8 10190.3 10396.5 10550.1 12628.9 12712.4 12741.6 12759.2 12775.2 7194.5 7989.4 8072.7 8264.8 8323.7 8415.9 8431.0 8439.3 8492.0 8529.1 5995.6 6110.3 6110.6 6112.7 6206.4 1656.5 1702.8 1742.4 1752.2 1797.0 847.9 931.2 984.0 1031.0 1048.0 18838.0 19562.2 19646.4 19682.4 19718.7 931.4 937.1 977.7 983.1 1064.9 10848.6 10878.4 10906.9 10920.6 10922.7 587378.0 608001.0 635177.0 649136.0 654738.5 101089.5 102055.0 102788.0 103358.0 104395.0 989.9 996.9 1003.6 1057.6 1073.7 17641.8 17871.0 17872.6 17917.6 17989.8 49461.8 49525.3 50072.5 50448.7 50603.2 62999.7 63129.0 63233.5 64360.0 64363.7 7730.5 7744.7 7815.0 7821.6 8128.8 12541.1 12845.8 12996.0 13246.3 13282.0 11029.1 11370.1 11430.3 11439.3 11565.7 10876.9 11025.8 11211.6 11284.9 11473.5 6685.0 8740.6 9056.9 11475.1 11544.7 7655.0 7750.4 7790.7 7828.6 7984.3 11307.2 11313.0 11538.7 11614.1 11658.2 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5924.38 Median:5398.33 stddev:3167.93 (58.7%) stddev-sans-first:3157.70 19:17:08 INFO - PROCESS | 1674 | Values: 1294.8 1368.4 1469.6 1498.0 1877.2 7797.6 8397.7 8552.8 8552.8 8567.7 8173.5 8433.4 8440.6 8455.7 8460.4 2173.2 2396.5 2430.3 2431.1 2441.8 2357.9 2420.9 2421.7 2428.5 2431.4 2007.8 2310.1 2385.4 2446.0 2450.5 2056.3 2390.0 2439.4 2446.4 2448.1 2409.8 2443.2 2451.7 2454.9 2467.3 8589.6 8684.1 8692.4 8700.6 8707.4 5360.8 5511.3 5517.3 5519.5 5526.1 3612.7 3613.3 3690.8 3694.9 3721.0 1052.1 1067.8 1078.2 1080.0 1087.1 11728.8 11758.2 11791.8 11803.1 11868.9 4247.8 4815.3 4836.4 4854.1 4858.2 10102.9 10111.7 10116.7 10122.4 10144.9 5435.9 5447.4 5449.8 5450.6 5454.7 4024.8 4386.5 4554.6 4845.7 4851.7 3818.7 3908.5 3909.2 3929.1 3966.0 1287.5 1302.9 1303.4 1312.0 1320.1 1036.5 1037.9 1049.8 1082.7 1093.8 8000.2 8044.8 8075.4 8119.8 8130.5 505.9 510.5 515.6 516.3 519.3 5987.3 5989.5 6029.4 6031.2 6042.5 10091.8 10582.4 10665.3 10672.6 10679.4 10159.8 10288.0 10427.3 10487.3 10528.8 8142.8 8143.1 8158.0 8213.2 8229.4 7576.7 7717.2 7731.8 7742.9 7830.3 9087.4 9366.5 9415.6 9493.2 9609.5 9443.9 9693.4 9736.5 9863.5 9877.8 6660.5 6829.0 7055.4 7345.2 7424.9 7977.2 7999.6 8042.2 8044.0 8063.0 7098.3 7221.7 7242.5 7354.6 7406.4 7033.9 7128.5 7188.7 7206.4 7241.8 7418.3 7523.4 7525.8 7530.1 7540.1 6769.5 6848.9 6859.3 6861.1 6885.6 6801.1 6937.9 6938.8 6949.7 6953.1 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5682.31 Median:6558.49 stddev:1844.50 (28.1%) stddev-sans-first:1805.18 19:17:08 INFO - PROCESS | 1674 | Values: 317.1 320.0 327.0 329.4 329.4 6551.2 6599.6 6599.8 6651.9 6689.7 6518.2 6557.5 6563.7 6577.3 6585.4 4632.9 4715.6 4718.2 4718.4 4882.5 3794.8 4724.6 4732.7 4798.2 4805.4 4740.8 4746.5 4753.8 4768.5 4771.2 4754.9 4767.3 4770.9 4831.3 4832.3 3936.8 4005.7 4087.3 4088.4 4091.8 6230.7 6270.3 6346.3 6349.0 6358.4 4838.6 4922.9 5128.2 5659.2 5659.9 6935.9 6952.8 6965.4 6969.5 6995.4 4594.1 4596.0 4597.7 4617.3 4620.1 7031.9 7277.8 7305.0 7314.0 7332.4 4453.4 4529.3 4531.3 4534.8 4543.7 3860.2 4572.7 4611.9 4626.9 4640.2 4451.6 5481.7 5485.5 5492.0 5555.3 6778.7 7005.8 7022.2 7035.2 7060.9 1575.9 1619.2 1620.2 1620.7 1622.3 1006.8 1023.3 1039.1 1046.0 1047.9 5553.3 6261.7 6497.4 6592.9 6600.2 5848.4 7271.4 7280.6 7282.5 7301.9 6620.4 6660.0 6661.4 6663.0 6664.4 3404.4 3808.7 3851.5 3858.2 3858.3 6119.7 6535.3 6695.0 7308.6 7561.5 6011.2 7499.8 7512.2 7636.3 7752.8 7622.1 7637.2 7638.0 7639.7 7662.8 7303.3 7313.4 7318.3 7331.5 7332.3 6991.1 7165.1 7180.4 7238.0 7256.0 7629.4 7666.9 7676.1 7680.3 7699.8 4592.9 4650.3 4651.7 4656.4 4665.9 7264.4 7289.1 7289.3 7301.7 7307.1 6745.9 6984.6 7013.7 7024.6 7029.9 5575.8 6957.6 6962.9 6973.2 6982.5 6831.7 6849.6 6858.6 6872.6 6873.0 7039.8 7058.6 7063.2 7065.3 7068.3 6559.5 6624.9 6835.6 6887.4 6902.9 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18239.77 Median:33728.19 stddev:26312.87 (78.0%) stddev-sans-first:26353.65 19:17:08 INFO - PROCESS | 1674 | Values: 680.9 739.1 754.4 756.6 768.4 14632.4 14928.9 15049.5 15054.9 15066.2 13557.3 13737.7 13765.3 13771.5 13781.5 703.6 711.2 831.6 865.4 868.5 713.7 714.0 714.6 855.3 867.2 893.2 902.9 903.6 903.9 905.5 886.0 894.4 894.7 896.1 897.6 545.2 545.6 549.2 660.6 663.7 14780.7 14822.6 14852.6 14859.3 14888.0 12419.3 12477.0 12563.9 12564.4 12707.7 9866.3 9939.7 10181.6 10232.0 10495.5 3500.8 3548.2 3575.8 3674.8 3680.5 79703.6 80375.6 80439.2 80441.6 80459.0 9336.6 9479.0 9598.0 9666.6 10011.0 20130.6 20215.8 20428.7 21680.6 21715.0 7429.0 7488.1 7540.6 7574.0 7695.6 4100.8 4128.2 4147.5 4157.3 4214.5 3513.5 3519.9 3557.2 3557.7 3564.4 639.9 646.1 646.1 655.1 662.1 541.3 543.1 596.7 620.0 628.0 8101.9 8206.1 8311.6 8330.9 8361.2 539.0 570.4 576.4 595.0 595.5 3805.8 3847.7 3886.5 3896.1 3907.3 93642.6 93715.5 97197.0 97724.0 97875.0 80108.6 81170.2 81314.0 82202.6 82341.6 70787.6 71403.3 72757.0 73334.0 73850.3 7567.5 7682.9 7737.2 7910.3 7965.7 49254.5 49448.0 50388.0 50405.2 51087.5 60037.0 66792.7 67011.0 67657.3 68292.0 9430.5 9446.6 9676.7 9778.0 9855.9 10695.9 10876.6 10885.2 10974.1 11151.8 10161.7 10249.0 10393.0 10441.1 10458.8 10217.7 10422.3 10458.8 10470.9 10503.0 8121.6 9980.8 9982.6 9993.0 10319.6 8617.1 8685.0 8690.4 8738.0 8966.0 8592.5 8684.8 8742.5 8876.3 8919.2 19:17:08 INFO - PROCESS | 1674 | -------- Summary: end -------- 19:17:08 INFO - PROCESS | 1674 | 19:17:08 INFO - TEST-INFO | 1674: exit 0 19:17:08 INFO - TEST-OK | dromaeo_css | took 1112588ms 19:17:08 INFO - TEST-START | kraken 19:17:08 INFO - operating with platform_type : mac_ 19:17:08 INFO - Initialising browser for kraken test... 19:17:08 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpIjJRIl/profile http://localhost:49274/getInfo.html) 19:17:11 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 19:17:11 INFO - PROCESS | 1680 | colorDepth:24 19:17:11 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 19:17:11 INFO - PROCESS | 1680 | __metrics 19:17:11 INFO - PROCESS | 1680 | 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" 19:17:11 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:17:11 INFO - TEST-INFO | 1680: exit 0 19:17:11 INFO - Browser initialized. 19:17:11 INFO - Running cycle 1/1 for kraken test... 19:17:11 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpIjJRIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:23 INFO - PROCESS | 1682 | RSS: Main: 243683328 19:17:23 INFO - PROCESS | 1682 | 19:17:26 INFO - PROCESS | 1682 | 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) 19:17:27 INFO - PROCESS | 1682 | RSS: Main: 292327424 19:17:27 INFO - PROCESS | 1682 | 19:17:29 INFO - PROCESS | 1682 | 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) 19:17:30 INFO - PROCESS | 1682 | RSS: Main: 301502464 19:17:30 INFO - PROCESS | 1682 | 19:17:33 INFO - PROCESS | 1682 | 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) 19:17:34 INFO - PROCESS | 1682 | RSS: Main: 286842880 19:17:34 INFO - PROCESS | 1682 | 19:17:36 INFO - PROCESS | 1682 | 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) 19:17:36 INFO - PROCESS | 1682 | RSS: Main: 288030720 19:17:36 INFO - PROCESS | 1682 | 19:17:39 INFO - PROCESS | 1682 | 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) 19:17:39 INFO - PROCESS | 1682 | RSS: Main: 290603008 19:17:39 INFO - PROCESS | 1682 | 19:17:42 INFO - PROCESS | 1682 | 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) 19:17:42 INFO - PROCESS | 1682 | RSS: Main: 289116160 19:17:42 INFO - PROCESS | 1682 | 19:17:45 INFO - PROCESS | 1682 | 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) 19:17:46 INFO - PROCESS | 1682 | RSS: Main: 290643968 19:17:46 INFO - PROCESS | 1682 | 19:17:49 INFO - PROCESS | 1682 | 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) 19:17:49 INFO - PROCESS | 1682 | RSS: Main: 289357824 19:17:49 INFO - PROCESS | 1682 | 19:17:51 INFO - PROCESS | 1682 | 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) 19:17:52 INFO - PROCESS | 1682 | RSS: Main: 326492160 19:17:52 INFO - PROCESS | 1682 | 19:17:53 INFO - PROCESS | 1682 | 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) 19:17:54 INFO - PROCESS | 1682 | RSS: Main: 325058560 19:17:54 INFO - PROCESS | 1682 | 19:17:56 INFO - PROCESS | 1682 | 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) 19:17:57 INFO - PROCESS | 1682 | RSS: Main: 333312000 19:17:57 INFO - PROCESS | 1682 | 19:17:59 INFO - PROCESS | 1682 | 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) 19:18:00 INFO - PROCESS | 1682 | RSS: Main: 333123584 19:18:00 INFO - PROCESS | 1682 | 19:18:02 INFO - PROCESS | 1682 | 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) 19:18:03 INFO - PROCESS | 1682 | RSS: Main: 334327808 19:18:03 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | 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) 19:18:05 INFO - PROCESS | 1682 | RSS: Main: 394330112 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | __start_tp_report 19:18:05 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 19:18:05 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 19:18:05 INFO - PROCESS | 1682 | |i|pagename|runs| 19:18:05 INFO - PROCESS | 1682 | |0;ai-astar;113;108;110;112;109;111;123;166;155;111 19:18:05 INFO - PROCESS | 1682 | |1;audio-beat-detection;156;121;144;154;140;168;164;141;157;123 19:18:05 INFO - PROCESS | 1682 | |2;audio-dft;185;186;186;184;183;185;183;183;181;200 19:18:05 INFO - PROCESS | 1682 | |3;audio-fft;74;76;87;78;56;57;58;83;77;57 19:18:05 INFO - PROCESS | 1682 | |4;audio-oscillator;94;92;132;79;80;84;113;79;78;115 19:18:05 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;85;92;85;91;85;90;84;90;85;90 19:18:05 INFO - PROCESS | 1682 | |6;imaging-darkroom;97;95;94;94;93;94;94;94;107;149 19:18:05 INFO - PROCESS | 1682 | |7;imaging-desaturate;127;143;87;86;84;80;85;84;112;137 19:18:05 INFO - PROCESS | 1682 | |8;json-parse-financial;57;56;56;53;56;56;56;65;56;53 19:18:05 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;66;71;70;73;73;68;68;68;68;68 19:18:05 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;82;83;83;81;83;83;83;83;84;84 19:18:05 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;126;121;124;124;115;119;125;123;125;122 19:18:05 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;135;126;137;138;138;130;134;124;139;171 19:18:05 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;68;67;66;66;68;68;67;67;66;70 19:18:05 INFO - PROCESS | 1682 | __end_tp_report 19:18:05 INFO - PROCESS | 1682 | __start_cc_report 19:18:05 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1248 19:18:05 INFO - PROCESS | 1682 | __end_cc_report 19:18:05 INFO - PROCESS | 1682 | __startTimestamp1456456685258__endTimestamp 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | ------- Summary: start ------- 19:18:05 INFO - PROCESS | 1682 | Number of tests: 14 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:121.80 Median:112.50 stddev:20.97 (18.6%) stddev-sans-first:22.00 19:18:05 INFO - PROCESS | 1682 | Values: 113.0 108.0 110.0 112.0 109.0 111.0 123.0 166.0 155.0 111.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:155.00 stddev:16.01 (10.3%) stddev-sans-first:16.63 19:18:05 INFO - PROCESS | 1682 | Values: 156.0 121.0 144.0 154.0 140.0 168.0 164.0 141.0 157.0 123.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:185.60 Median:185.00 stddev:5.30 (2.9%) stddev-sans-first:5.61 19:18:05 INFO - PROCESS | 1682 | Values: 185.0 186.0 186.0 184.0 183.0 185.0 183.0 183.0 181.0 200.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:70.30 Median:76.50 stddev:12.02 (15.7%) stddev-sans-first:12.67 19:18:05 INFO - PROCESS | 1682 | Values: 74.0 76.0 87.0 78.0 56.0 57.0 58.0 83.0 77.0 57.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.50 stddev:19.00 (23.9%) stddev-sans-first:20.15 19:18:05 INFO - PROCESS | 1682 | Values: 94.0 92.0 132.0 79.0 80.0 84.0 113.0 79.0 78.0 115.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:90.00 stddev:3.13 (3.5%) stddev-sans-first:3.16 19:18:05 INFO - PROCESS | 1682 | Values: 85.0 92.0 85.0 91.0 85.0 90.0 84.0 90.0 85.0 90.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:94.00 stddev:17.32 (18.4%) stddev-sans-first:18.31 19:18:05 INFO - PROCESS | 1682 | Values: 97.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 107.0 149.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:102.50 Median:84.00 stddev:24.79 (29.5%) stddev-sans-first:24.66 19:18:05 INFO - PROCESS | 1682 | Values: 127.0 143.0 87.0 86.0 84.0 80.0 85.0 84.0 112.0 137.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.31 (5.9%) stddev-sans-first:3.50 19:18:05 INFO - PROCESS | 1682 | Values: 57.0 56.0 56.0 53.0 56.0 56.0 56.0 65.0 56.0 53.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:2.36 (3.4%) stddev-sans-first:2.18 19:18:05 INFO - PROCESS | 1682 | Values: 66.0 71.0 70.0 73.0 73.0 68.0 68.0 68.0 68.0 68.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 19:18:05 INFO - PROCESS | 1682 | Values: 82.0 83.0 83.0 81.0 83.0 83.0 83.0 83.0 84.0 84.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:124.00 stddev:3.34 (2.7%) stddev-sans-first:3.28 19:18:05 INFO - PROCESS | 1682 | Values: 126.0 121.0 124.0 124.0 115.0 119.0 125.0 123.0 125.0 122.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:137.50 stddev:12.97 (9.4%) stddev-sans-first:13.73 19:18:05 INFO - PROCESS | 1682 | Values: 135.0 126.0 137.0 138.0 138.0 130.0 134.0 124.0 139.0 171.0 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 19:18:05 INFO - PROCESS | 1682 | Values: 68.0 67.0 66.0 66.0 68.0 68.0 67.0 67.0 66.0 70.0 19:18:05 INFO - PROCESS | 1682 | -------- Summary: end -------- 19:18:05 INFO - PROCESS | 1682 | 19:18:05 INFO - TEST-INFO | 1682: exit 0 19:18:06 INFO - TEST-OK | kraken | took 57288ms 19:18:06 INFO - SUITE-END | took 1169s 19:18:06 INFO - Completed test suite (00:19:30) 19:18:06 INFO - Working with test: dromaeo_css 19:18:06 INFO - Generating results file: dromaeo_css 19:18:06 INFO - Working with test: kraken 19:18:06 INFO - Generating results file: kraken 19:18:06 INFO - javascript benchmark 19:18:06 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:18:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 19:18:06 INFO - process_Request line: dromaeo_css 7357.36 graph.html#tests=[[72,64,59]] 19:18:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:18:06 INFO - process_Request line: kraken 1445.90 graph.html#tests=[[232,64,59]] 19:18:06 INFO - RETURN: dromaeo_css: 7357.36 19:18:06 INFO - RETURN: kraken: 1445.90 19:18:06 INFO - javascript benchmark 19:18:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2891.754200892924, 3418.3846907556645, 3426.8457919393627, 3436.656334366562, 3546.1843775931534, 5553.861153471165, 5600.327960644723, 5613.775448982041, 5642.0126477866415, 5644.266245388104, 5598.0, 5629.324481062268, 5661.3206415230125, 5760.135979603062, 5788.450097240755, 5082.593392528607, 5119.488051194879, 5129.204973229137, 5145.99653067652, 5246.5278124968745, 5207.7916883324815, 5238.397584277819, 5271.0, 5285.02227087988, 5313.442088580701, 5071.239314102896, 5130.9743451282875, 5166.250893620423, 5194.194899790538, 5218.660787048868, 5158.561522270612, 5164.992826398854, 5167.4057483389515, 5167.7932882684645, 5172.818951336722, 5103.979204159146, 5113.82101626445, 5144.305518754958, 5164.070467315882, 5203.245529398254, 5521.171824226358, 5524.861878453031, 5609.214709940612, 5641.464060914206, 5645.5483561314995, 6186.1648677428875, 6207.503399728011, 6213.347598502138, 6213.720382582795, 6214.502839772807, 6239.563230573816, 6267.247930248353, 6276.058591211309, 6281.026440901667, 6299.212598425197, 5604.691741954191, 5616.494515493625, 5696.715164241813, 5699.0, 5699.743511542032, 6172.629642221481, 6264.123022776815, 6296.150019747367, 6318.0, 6323.715432805535, 6053.031514957674, 6133.907991380132, 6135.845176233341, 6142.140100385949, 6142.324344322121, 6262.2172228471445, 6262.248530176408, 6266.373362663789, 6269.404406581368, 6281.277653069864, 6023.578349515579, 6122.295935967331, 6127.927612667765, 6174.845628859224, 6185.0, 6052.273727152769, 6125.0429919399385, 6128.509719222451, 6132.447291485866, 6174.722137503823, 4819.759012049383, 4854.441739200037, 4872.634552408584, 4881.804727810919, 4902.558769710743, 4245.299525578307, 4289.67827412939, 4345.456817897762, 4348.608625223745, 4362.411074504901, 4530.864074077783, 5008.84973450797, 5584.46947539983, 5602.411746766531, 5620.971895140498, 6139.706800529404, 6217.160683307696, 6227.439530442282, 6238.0, 6247.75008999644, 5643.1535269709875, 5655.519280861091, 5668.178114173422, 5673.262475878109, 5719.971400142973, 5266.420693723688, 5280.9471905281225, 5290.576753859682, 5331.44019877915, 5360.91958620621, 6213.536170127955, 6309.3690630936535, 6314.084457753692, 6316.336784637639, 6331.68341582919, 6192.349803270592, 6202.844928876814, 6255.46828519581, 6261.0, 6279.120923070683, 6256.436920677161, 6257.43683068526, 6288.654124023223, 6326.9683651581445, 6327.462165715781, 6083.847903802263, 6093.268807743099, 6100.0849872519475, 6105.297890742621, 6110.938890611037, 4910.45984941649, 5115.64190506661, 6221.9377806221355, 6223.128761973237, 6234.719437625227, 5941.079132734433, 5972.0, 5987.970060149845, 6025.87948241024, 6058.3335833057445, 5980.700964951648, 6008.939910600838, 6010.188624535632, 6037.366076561898, 6093.421124993119, 5733.283339582552, 5828.679422631626, 5887.293524776883, 5904.0, 5911.349751527243, 5861.531077513703, 5984.58107932458, 6079.787207447718, 6081.361457046946, 6108.053251745987, 5872.941270587239, 5900.763969441175, 5907.675077870758, 5909.793157239476, 5911.1428842816695], "unit": "score", "name": "dojo.html", "value": 5632.710426770748}, {"lowerIsBetter": false, "replicates": [473.7891638220993, 547.6905548365173, 567.909134538474, 568.8168609292671, 570.1704020649955, 28691.139265822032, 29903.0, 37191.62808371919, 37216.0, 37311.06722331943, 41419.37870931938, 42089.57910420895, 42103.0, 42139.57860421395, 42158.789206054, 9468.28987825914, 9705.010472853084, 9719.0, 9719.659811906584, 9750.9512452438, 9526.333156679035, 9530.094641009127, 9538.761530961712, 9583.802024746907, 9686.564104615274, 9627.422354658707, 9733.902660973406, 9744.366616169926, 9751.902480975206, 9772.609095636166, 9640.228781697482, 9682.90317096834, 9699.127078562893, 9708.17480514157, 9730.270229732763, 9485.762855928657, 9629.422234665872, 9637.18083962864, 9645.614175432975, 9650.469224192666, 38984.0, 39333.0, 39333.213335733126, 39341.21317573661, 39447.0, 3106.316610345743, 3149.826759528225, 3155.668654791237, 3165.683431656816, 3526.2242306692488, 27387.04145354903, 27599.862000690067, 27678.723212767814, 28178.859105704545, 28893.133206003855, 2739.397332586828, 2745.052956729925, 2759.0343379817105, 2783.1650504848667, 2815.000674760451, 355789.0, 355876.0, 355894.0, 357021.0, 357188.0, 60318.69840650768, 60621.0, 61062.69468652628, 61067.0, 61086.0, 65002.02496962549, 65030.0, 65036.0, 65091.0, 65480.0, 15751.68496630061, 15934.840651593568, 15979.201039947957, 15997.840021599868, 15998.840011599968, 12048.03615710741, 12233.510659573696, 12269.07981901361, 12283.447244874002, 12302.876971230353, 18926.90536547336, 18941.62116757657, 19321.90339048296, 19419.223231070882, 20115.899420503098, 7464.589447580435, 8613.526256055977, 8930.419522731001, 8934.749135121088, 8953.731388058368, 910.854263317866, 967.02330646048, 972.0959507657946, 1031.664708969588, 1045.4459136657583, 22621.660675089886, 23408.414789630395, 28208.43583128367, 29153.708462915525, 29291.707082929322, 1054.5254635414094, 1070.4861666400172, 1079.1259080145107, 1095.9616413425492, 1141.5947338694643, 14567.927160364343, 14622.26888655563, 14805.481808136663, 14822.62943426423, 14892.478763243234, 509234.0, 511692.0, 515183.0, 516062.0, 518200.4089979526, 55058.17412738812, 55364.0, 55425.722871385384, 55510.444895551336, 55579.44420555823, 1115.754534002518, 1366.2827015816777, 1407.8521755215554, 1455.221456520735, 1456.4538298138198, 27766.0, 27847.0, 28170.85914570414, 28686.0, 28900.710992889803, 44900.77549612231, 45523.317150243434, 45530.861728455726, 45557.77221114006, 45574.31638525359, 348867.0, 360453.0, 361090.0, 361288.0, 361889.0, 27260.863695681393, 27610.723892760816, 27630.894764209206, 31169.68830311668, 32296.031119066465, 38875.63935262252, 38927.0, 39370.803145984086, 40239.79880100581, 40246.39630405488, 33133.17167070843, 36148.638513614525, 36752.26495470129, 37272.62727372692, 39066.60933390629, 34964.47553286754, 35421.82289088538, 35470.290594187456, 36122.0, 36158.638413615525, 36133.277334452636, 36379.63620363762, 36937.70718024856, 36961.63038369582, 37728.245435091696, 24706.0, 28952.986645467307, 30696.386072278878, 30855.537166942962, 31543.68456315499, 23827.166049188196, 24317.0, 24501.019959201432, 24571.262862114167, 24646.753532464445], "unit": "score", "name": "ext.html", "value": 18883.6529477508}, {"lowerIsBetter": false, "replicates": [355.7029880050158, 358.3728475168455, 363.6545281982116, 364.89235675475726, 366.948627192193, 19044.90477547612, 19273.421797346065, 19335.419937401883, 19711.211551537923, 19719.5070123247, 18372.17325220365, 19249.326273580427, 19746.815191088546, 19764.70352944707, 19777.60444791103, 5608.803691870775, 5762.135679648065, 5821.50517206038, 5824.679642619654, 5829.0, 4184.916301673965, 4377.606015458608, 5177.844664660066, 5781.913271300913, 6412.5190610704385, 6339.683015849212, 6356.237251529823, 6360.618362898241, 6365.52258580606, 6423.64669943153, 6053.606515576474, 6307.306196318401, 6312.179416675825, 6313.305536390993, 6329.303776584572, 3675.2098298865603, 5223.2165175223645, 5421.105517589593, 5427.891442171174, 5437.592180586433, 23603.0, 24112.794360282092, 24343.391415214763, 24524.386890327707, 24568.877155614286, 2029.7462817147857, 2104.168853302937, 2175.9020844062056, 2276.089564174327, 2276.760940101282, 13435.0, 13764.380602872894, 13950.23273719945, 13984.86015139856, 14192.92903535486, 1697.7979056866875, 1743.250402326999, 1754.4385796545112, 1764.4265613675607, 1773.733939909024, 101260.0, 105628.47185764022, 105851.0, 106313.0, 106777.0, 10041.397516149054, 10159.847602285972, 10190.337628054152, 10396.532156052996, 10550.050495455445, 12628.936855315664, 12712.42794074269, 12741.55404560836, 12759.170653907466, 12775.23348599087, 7194.46041546886, 7989.360851131895, 8072.717454889051, 8264.752057438287, 8323.66705331792, 8415.915840841635, 8430.957845210858, 8439.282660973886, 8492.0, 8529.14708529142, 5995.640261584319, 6110.29731580865, 6110.602810817282, 6112.724927378279, 6206.410391012847, 1656.5008667156244, 1702.838230368113, 1742.3901634427848, 1752.229019231534, 1796.9550761231073, 847.9194476524843, 931.2224292715523, 984.015984015984, 1030.9690709278734, 1047.994760026195, 18838.0, 19562.21751129939, 19646.41060768179, 19682.409527714193, 19718.70421943672, 931.3945935142076, 937.0863408176973, 977.6578197630772, 983.095552092077, 1064.893510648929, 10848.62029828968, 10878.40168790724, 10906.890931090746, 10920.563177472972, 10922.726931826768, 587378.0, 608001.0, 635177.0, 649136.0, 654738.4526154677, 101089.49455252677, 102055.0, 102788.0, 103357.96642033484, 104395.0, 989.9208063354914, 996.850472429127, 1003.6487229469627, 1057.603398725478, 1073.7476692977143, 17641.82358176402, 17870.98019228777, 17872.642547149244, 17917.641647167246, 17989.820101798814, 49461.75269123631, 49525.25712114249, 50072.49927500678, 50448.747756260986, 50603.24095138502, 62999.6850015747, 63129.0, 63233.500744139325, 64360.0, 64363.67818160879, 7730.497517661334, 7744.728934487266, 7814.960925195338, 7821.569813660076, 8128.796780080545, 12541.122121451412, 12845.807312890502, 12996.0, 13246.271455070064, 13282.0, 11029.062529685067, 11370.123929551863, 11430.314181149157, 11439.256448330832, 11565.710857228636, 10876.945615271872, 11025.83461248098, 11211.55153793839, 11284.943575282072, 11473.483693233991, 6684.997250412477, 8740.60667269987, 9056.864147037668, 11475.13936454786, 11544.653660390202, 7654.961725191339, 7750.379969602531, 7790.727324543614, 7828.647710852912, 7984.321332686786, 11307.208495405243, 11313.0, 11538.711532211426, 11614.12894032934, 11658.242214256046], "unit": "score", "name": "jquery.html", "value": 9339.732227857621}, {"lowerIsBetter": false, "replicates": [1294.8122522234275, 1368.3500337339758, 1469.5517867050553, 1497.9813726665866, 1877.1928070929503, 7797.610119494024, 8397.664093436262, 8552.786180345494, 8552.828943421127, 8567.700130495434, 8173.509589424639, 8433.367497437686, 8440.620172092255, 8455.661773529067, 8460.407771456, 2173.152470536492, 2396.544656515265, 2430.3195105370523, 2431.1004928176553, 2441.7802397784194, 2357.9410514737096, 2420.9031638734427, 2421.6609674645474, 2428.4657375377387, 2431.4407686232175, 2007.7791442941266, 2310.145246258878, 2385.3917251100943, 2445.987770061156, 2450.5098980203943, 2056.331692200041, 2389.976100238993, 2439.426734717349, 2446.3639453742157, 2448.0574978633354, 2409.7590240975937, 2443.2059580636187, 2451.6935383077116, 2454.8649824259837, 2467.2721547143638, 8589.613467393981, 8684.131586841266, 8692.391532592721, 8700.56497175145, 8707.434016788888, 5360.758765855546, 5511.255980442629, 5517.337919449692, 5519.475649813261, 5526.088195447786, 3612.747107702462, 3613.313470440608, 3690.7970061646597, 3694.8891533253777, 3721.0, 1052.0899421999916, 1067.7544164842052, 1078.2182917384912, 1080.0333701337338, 1087.12486448409, 11728.765424691544, 11758.17692761507, 11791.823122653168, 11803.11476639247, 11868.88131118695, 4247.830086796555, 4815.30178124177, 4836.443808961944, 4854.106898309662, 4858.222684370484, 10102.949485252526, 10111.72486190616, 10116.747081323027, 10122.39265644049, 10144.949275253577, 5435.891282174334, 5447.428020057916, 5449.782008719607, 5450.618456707993, 5454.727263636882, 4024.8188831502653, 4386.539413361551, 4554.612857907115, 4845.6608037437045, 4851.708897466164, 3818.694504439694, 3908.4528166056775, 3909.198614284065, 3929.0766669832565, 3966.0, 1287.4657017337888, 1302.856685764565, 1303.4199781097511, 1311.9540816071392, 1320.1419077599446, 1036.4921188617675, 1037.86507753993, 1049.7533079726259, 1082.6751974407646, 1093.8031154392127, 8000.159983201796, 8044.758657240292, 8075.394345424117, 8119.79700507492, 8130.471519351223, 505.919052951526, 510.52521155325906, 515.6081378152631, 516.302990962198, 519.3482179864246, 5987.311459182162, 5989.520838332923, 6029.366916473795, 6031.24609423822, 6042.546808989343, 10091.798164036825, 10582.417967011734, 10665.253432259822, 10672.626458074086, 10679.359238445719, 10159.796804063877, 10288.0, 10427.322224055411, 10487.318324308895, 10528.789424211473, 8142.796430089176, 8143.144969778206, 8158.0, 8213.219744124299, 8229.423940324119, 7576.659050342638, 7717.2282771722375, 7731.7680469586, 7742.922570774445, 7830.256125668053, 9087.363884528284, 9366.531673416439, 9415.57629906642, 9493.240540756584, 9609.519524023632, 9443.858342125011, 9693.369930954465, 9736.46449445259, 9863.506824658882, 9877.753056173653, 6660.533762636763, 6828.965855170891, 7055.435565154673, 7345.155307139534, 7424.925750742639, 7977.2022797719765, 7999.640016199169, 8042.155573664915, 8044.034715834137, 8063.0, 7098.3256590623805, 7221.711131554679, 7242.456815738946, 7354.595497247703, 7406.44451666138, 7033.9296607033275, 7128.501004929813, 7188.676509556978, 7206.423486121203, 7241.782746517613, 7418.258174182539, 7523.3981281498445, 7525.774226773206, 7530.134034586093, 7540.057492813398, 6769.458443324424, 6848.931510685029, 6859.3140685933, 6861.142357205349, 6885.586864787929, 6801.1158549388265, 6937.89593156093, 6938.791836244921, 6949.687264073028, 6953.096097507291], "unit": "score", "name": "mootools.html", "value": 4723.830876420089}, {"lowerIsBetter": false, "replicates": [317.06940130716345, 319.9744020478362, 326.9798229523886, 329.4415964939427, 329.4498188025998, 6551.21385433748, 6599.637019963906, 6599.769008084718, 6651.866962660744, 6689.732410703578, 6518.185226846645, 6557.508186885979, 6563.7046332915015, 6577.34226577342, 6585.4402375798, 4632.884177895546, 4715.622750179995, 4718.221493453576, 4718.363020992174, 4882.487338829434, 3794.753341032838, 4724.622030237572, 4732.739699316537, 4798.232282834747, 4805.423349198101, 4740.76296185191, 4746.549077837617, 4753.762311884392, 4768.451628062765, 4771.165046116933, 4754.928676069827, 4767.332573439739, 4770.880727981794, 4831.323614693945, 4832.275158726184, 3936.8425262989444, 4005.7396269242404, 4087.3460246360737, 4088.407180958774, 4091.8158682859344, 6230.688465576748, 6270.31026587075, 6346.333634968308, 6349.0, 6358.395952384516, 4838.637102217348, 4922.9261561076255, 5128.205128205134, 5659.151127330892, 5659.915101273484, 6935.861282774316, 6952.791416257521, 6965.407940325078, 6969.47728920333, 6995.440364770857, 4594.081183763261, 4596.0, 4597.7011494252765, 4617.30740388941, 4620.075984803019, 7031.8945215821805, 7277.781666550012, 7304.96347518259, 7313.963430182868, 7332.376747976428, 4453.376527286183, 4529.252673308933, 4531.342955271467, 4534.79593418297, 4543.68194226401, 3860.1507668312925, 4572.657050721209, 4611.930821037688, 4626.86119416418, 4640.187967105743, 4451.621612163002, 5481.671099734029, 5485.518909894386, 5492.038893193675, 5555.30558680165, 6778.661066946633, 7005.754798582026, 7022.227554968949, 7035.226125126232, 7060.929390706027, 1575.866051385645, 1619.1580378203269, 1620.2141961148834, 1620.6596614710807, 1622.261870848761, 1006.808706345792, 1023.2530252915265, 1039.0907955538903, 1045.9738506537244, 1047.9476026198658, 5553.250311207935, 6261.655608941461, 6497.382748638872, 6592.86814263712, 6600.240972288152, 5848.4151584841175, 7271.418286537064, 7280.563166210044, 7282.4902256841515, 7301.926980730231, 6620.404163625297, 6659.966700166468, 6661.367170118831, 6663.000549917551, 6664.433523150489, 3404.4382676858536, 3808.6572208501366, 3851.5378154621626, 3858.2090671412293, 3858.344081506151, 6119.663418512025, 6535.313792051861, 6694.966525167343, 7308.634568271672, 7561.508501947355, 6011.248593925759, 7499.812504687427, 7512.21121782216, 7636.31273185416, 7752.844943101107, 7622.123455802543, 7637.236276372319, 7637.961810191136, 7639.656215470317, 7662.8084297893, 7303.342699156889, 7313.378362839218, 7318.268173182639, 7331.4867959244475, 7332.30343117403, 6991.056207411934, 7165.104361954755, 7180.389666878374, 7237.963810180915, 7256.0, 7629.351505121905, 7666.853281081306, 7676.117246516722, 7680.270374314431, 7699.807504812425, 4592.931106033346, 4650.255959046536, 4651.7441540714235, 4656.41794775653, 4665.930011049769, 7264.418846492374, 7289.125304963438, 7289.343959043499, 7301.671424785791, 7307.086614173229, 6745.865082698417, 6984.615846128511, 7013.684384202825, 7024.648767561499, 7029.929700702927, 5575.77696892136, 6957.582545047313, 6962.860742785218, 6973.232944376216, 6982.511224214256, 6831.726730930906, 6849.589024658537, 6858.588484690935, 6872.587644741331, 6872.965635171792, 7039.788806335818, 7058.6470676467, 7063.223045465097, 7065.258147894397, 7068.29317068289, 6559.4752419805345, 6624.9337506624315, 6835.555688880207, 6887.414569761627, 6902.8619427610165], "unit": "score", "name": "prototype.html", "value": 5066.487790672994}, {"lowerIsBetter": false, "replicates": [680.8502129531503, 739.1389031777979, 754.3814072460577, 756.59900252866, 768.3507436216397, 14632.414703411863, 14928.850711492882, 15049.54851354461, 15054.924725376371, 15066.246687665627, 13557.25435101069, 13737.725245495109, 13765.31173441329, 13771.517996870112, 13781.517646882336, 703.6130128429369, 711.2176605733678, 831.604987630875, 865.3855762408666, 868.5266529741306, 713.6503113474386, 713.9714411423537, 714.6212507371101, 855.2901092093579, 867.1891781184613, 893.2228960804109, 902.8781114549517, 903.615963215634, 903.9231665308457, 905.4567259644226, 886.0386480668483, 894.414158726029, 894.7136916186823, 896.1083721696954, 897.5557099235888, 545.2448359022742, 545.6371512943888, 549.209138840069, 660.5904339309611, 663.7212370804274, 14780.70438591233, 14822.629434264121, 14852.554423367315, 14859.331330090065, 14888.0, 12419.31693756843, 12477.0, 12563.874361256454, 12564.43460044291, 12707.682307942283, 9866.26003049767, 9939.701808945743, 10181.592736290539, 10231.976802319783, 10495.475226238734, 3500.789952602852, 3548.1661809474754, 3575.8390872410805, 3674.8346324415465, 3680.5031320771623, 79703.6014819928, 80375.5981220096, 80439.19560804375, 80441.59779201067, 80459.0, 9336.626534938663, 9478.952605237067, 9597.952010239904, 9666.565004574812, 10011.048950349705, 20130.597388052156, 20215.797842021686, 20428.693569596468, 21680.566388672138, 21715.0, 7429.0, 7488.138864030706, 7540.585267810323, 7573.962130189314, 7695.576743279062, 4100.774457404871, 4128.236276288896, 4147.4815648044, 4157.251694694924, 4214.494260688737, 3513.4905438711244, 3519.9120021999656, 3557.2351944332095, 3557.7331700122595, 3564.4475106358555, 639.9104125422444, 646.1277275677892, 646.1470858466872, 655.0959675647671, 662.0631805994464, 541.2665837789817, 543.1337017457149, 596.6509591888707, 619.956603037783, 627.9529035322369, 8101.878471822927, 8206.138355472709, 8311.625976831057, 8330.880922571921, 8361.205685459872, 539.0162952611421, 570.3725901508308, 576.4293349583882, 594.9940500595026, 595.487880422836, 3805.7526260793516, 3847.6921846252235, 3886.4947556817433, 3896.0844201613163, 3907.3357529219534, 93642.59536106965, 93715.53142234382, 97197.0, 97724.02275977291, 97875.0, 80108.59945700235, 81170.18829811744, 81314.0, 82202.58898705468, 82341.58829205815, 70787.64606176937, 71403.2859671407, 72756.99673035962, 73334.0, 73850.2614973854, 7567.470277080772, 7682.923170768444, 7737.226277372218, 7910.327622152182, 7965.721199757981, 49254.50745492499, 49448.0, 50388.0, 50405.24392134194, 51087.48912510827, 60037.0, 66792.6660366695, 67011.0, 67657.30856728424, 68292.0, 9430.528473576156, 9446.622135114518, 9676.661316853877, 9777.951110244403, 9855.901440985499, 10695.94652026766, 10876.564937402733, 10885.238033337908, 10974.067204287725, 11151.83272250933, 10161.745956351151, 10249.0, 10393.012663796928, 10441.060304572626, 10458.843117353093, 10217.693469195936, 10422.270441069053, 10458.790824183627, 10470.947645261725, 10503.0, 8121.5533145677555, 9980.800383992135, 9982.60069597208, 9993.00069992995, 10319.638812641522, 8617.138286171332, 8685.044645089161, 8690.391672582859, 8738.0, 8965.955170224108, 8592.535185378243, 8684.826303474021, 8742.475451472932, 8876.289896808368, 8919.152680495343], "unit": "score", "name": "yui.html", "value": 6670.486108373123}], "name": "dromaeo_css", "value": 7357.359511491265}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 110.0, 112.0, 109.0, 111.0, 123.0, 166.0, 155.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.8}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 144.0, 154.0, 140.0, 168.0, 164.0, 141.0, 157.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 186.0, 184.0, 183.0, 185.0, 183.0, 183.0, 181.0, 200.0], "unit": "score", "name": "audio-dft", "value": 185.6}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 87.0, 78.0, 56.0, 57.0, 58.0, 83.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 132.0, 79.0, 80.0, 84.0, 113.0, 79.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.6}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 85.0, 91.0, 85.0, 90.0, 84.0, 90.0, 85.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.7}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 107.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 101.1}, {"lowerIsBetter": true, "replicates": [127.0, 143.0, 87.0, 86.0, 84.0, 80.0, 85.0, 84.0, 112.0, 137.0], "unit": "score", "name": "imaging-desaturate", "value": 102.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 53.0, 56.0, 56.0, 56.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 70.0, 73.0, 73.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 81.0, 83.0, 83.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [126.0, 121.0, 124.0, 124.0, 115.0, 119.0, 125.0, 123.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [135.0, 126.0, 137.0, 138.0, 138.0, 130.0, 134.0, 124.0, 139.0, 171.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 66.0, 68.0, 68.0, 67.0, 67.0, 66.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1445.9000000000003}]} 19:18:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1445.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7357.36"}}} 19:18:06 INFO - Return code: 0 19:18:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:18:06 INFO - # TBPL SUCCESS # 19:18:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:18:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:18:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:18:06 INFO - 2016-02-25 19:18:06.703 screenresolution[1686:9674] starting screenresolution argv=screenresolution get 19:18:06 INFO - 2016-02-25 19:18:06.706 screenresolution[1686:9674] Display 0: 1600x1200x32@60 19:18:06 INFO - 2016-02-25 19:18:06.712 screenresolution[1687:9677] starting screenresolution argv=screenresolution list 19:18:06 INFO - Available Modes on Display 0 19:18:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:18:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:18:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:18:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:18:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:18:06 INFO - Intel Iris: 19:18:06 INFO - Chipset Model: Intel Iris 19:18:06 INFO - Type: GPU 19:18:06 INFO - Bus: Built-In 19:18:06 INFO - VRAM (Dynamic, Max): 1536 MB 19:18:06 INFO - Vendor: Intel (0x8086) 19:18:06 INFO - Device ID: 0x0a2e 19:18:06 INFO - Revision ID: 0x0009 19:18:06 INFO - Displays: 19:18:06 INFO - Display: 19:18:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:18:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:18:06 INFO - Display Serial Number: 1600x1200 60 19:18:06 INFO - Main Display: Yes 19:18:06 INFO - Mirror: Off 19:18:06 INFO - Online: Yes 19:18:06 INFO - Rotation: Supported 19:18:06 INFO - Return code: 0 19:18:06 INFO - Running post-action listener: _resource_record_post_action 19:18:06 INFO - Running post-run listener: _resource_record_post_run 19:18:07 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 43852288; Write bytes: 708151808; Read time: 568; Write time: 2209 19:18:07 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 405115392; Write bytes: 394377216; Read time: 29971; Write time: 748 19:18:08 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 36723200; Write bytes: 300122624; Read time: 475; Write time: 1415 19:18:08 INFO - Running post-run listener: _upload_blobber_files 19:18:08 INFO - Blob upload gear active. 19:18:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:18:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:18:08 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:18:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:09 INFO - (blobuploader) - INFO - Done attempting. 19:18:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:18:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:18:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:10 INFO - (blobuploader) - INFO - Done attempting. 19:18:10 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:10 INFO - Return code: 0 19:18:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:18:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f5b4ae14e2da402048e4ac1db21bb5c58e831ecf200a06f4ec26d2b6d16a21f588c781d31416d73b2f8a2a236c4002a60c6e2c0d0820e7d13e223d2fab29ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caefa430b82659775bf85d30eaa1e12becdaab00e3a52206e0a6b28f42d5182302c12371ff4bf83e7d48f6ed06519c20d59de2a5e7cb150a2ed8878532718ff"} 19:18:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:18:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:18:10 INFO - Contents: 19:18:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f5b4ae14e2da402048e4ac1db21bb5c58e831ecf200a06f4ec26d2b6d16a21f588c781d31416d73b2f8a2a236c4002a60c6e2c0d0820e7d13e223d2fab29ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caefa430b82659775bf85d30eaa1e12becdaab00e3a52206e0a6b28f42d5182302c12371ff4bf83e7d48f6ed06519c20d59de2a5e7cb150a2ed8878532718ff"} 19:18:10 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:10 INFO - Copying logs to upload dir... 19:18:10 INFO - mkdir: /builds/slave/test/build/upload/logs 19:18:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.738497 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-25 19:18:10.589064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 19:18:10.592299) ========= 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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f5b4ae14e2da402048e4ac1db21bb5c58e831ecf200a06f4ec26d2b6d16a21f588c781d31416d73b2f8a2a236c4002a60c6e2c0d0820e7d13e223d2fab29ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caefa430b82659775bf85d30eaa1e12becdaab00e3a52206e0a6b28f42d5182302c12371ff4bf83e7d48f6ed06519c20d59de2a5e7cb150a2ed8878532718ff"} build_url:https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011043 build_url: 'https://queue.taskcluster.net/v1/task/MD0HfW7mRXSpanCDl2XErw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f5b4ae14e2da402048e4ac1db21bb5c58e831ecf200a06f4ec26d2b6d16a21f588c781d31416d73b2f8a2a236c4002a60c6e2c0d0820e7d13e223d2fab29ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4caefa430b82659775bf85d30eaa1e12becdaab00e3a52206e0a6b28f42d5182302c12371ff4bf83e7d48f6ed06519c20d59de2a5e7cb150a2ed8878532718ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 19:18:10.618985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 19:18:10.619331) ========= 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.sm3fyzcVCf/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.zvFg1obJ2v/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005098 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 19:18:10.667554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 19:18:10.667855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 19:18:10.668226) ========= ========= Total master_lag: 0.42 =========