builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1454110067.99 results: success (0) buildid: 20160129134528 builduid: 1b34bb7d44604db68fe6d0c291ce3c5a revision: bff6cfc7e67b46b55431ccbdbedf025272f54220 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:47.987698) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:47.988160) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:47.988629) ========= 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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005632 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.049519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.049830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.117175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.117470) ========= 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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005931 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.200634) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.200931) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.201301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.201625) ========= 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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-01-29 15:27:48-- 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% 15.3M=0.001s 2016-01-29 15:27:48 (15.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.559881 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.867413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.867742) ========= 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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.025623 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.986025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:48.986377) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bff6cfc7e67b46b55431ccbdbedf025272f54220 --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 bff6cfc7e67b46b55431ccbdbedf025272f54220 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-01-29 15:27:49,086 truncating revision to first 12 chars 2016-01-29 15:27:49,086 Setting DEBUG logging. 2016-01-29 15:27:49,086 attempt 1/10 2016-01-29 15:27:49,086 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bff6cfc7e67b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 15:27:49,731 unpacking tar archive at: fx-team-bff6cfc7e67b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889412 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:49.922577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:49.923128) ========= echo bff6cfc7e67b46b55431ccbdbedf025272f54220 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bff6cfc7e67b46b55431ccbdbedf025272f54220'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 bff6cfc7e67b46b55431ccbdbedf025272f54220 program finished with exit code 0 elapsedTime=0.005887 script_repo_revision: 'bff6cfc7e67b46b55431ccbdbedf025272f54220' ========= master_lag: 0.12 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:50.050569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:50.050884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 15:27:50.072794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-29 15:27:50.073081) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:27:50 INFO - MultiFileLogger online at 20160129 15:27:50 in /builds/slave/test 15:27:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:27:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:27:50 INFO - {'append_to_log': False, 15:27:50 INFO - 'base_work_dir': '/builds/slave/test', 15:27:50 INFO - 'blob_upload_branch': 'Fx-Team', 15:27:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:27:50 INFO - 'branch': 'Fx-Team', 15:27:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:27:50 INFO - 'config_files': ('talos/mac_config.py',), 15:27:50 INFO - 'default_actions': ('clobber', 15:27:50 INFO - 'read-buildbot-config', 15:27:50 INFO - 'download-and-extract', 15:27:50 INFO - 'populate-webroot', 15:27:50 INFO - 'create-virtualenv', 15:27:50 INFO - 'install', 15:27:50 INFO - 'run-tests'), 15:27:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:27:50 INFO - 'download_minidump_stackwalk': True, 15:27:50 INFO - 'download_symbols': 'ondemand', 15:27:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:27:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:27:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:27:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:27:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:27:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:27:50 INFO - 'installer_path': 'installer.exe', 15:27:50 INFO - 'log_level': 'info', 15:27:50 INFO - 'log_name': 'talos', 15:27:50 INFO - 'log_to_console': True, 15:27:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:27:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:27:50 INFO - 'opt_config_files': (), 15:27:50 INFO - 'pip_index': False, 15:27:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:27:50 INFO - 'cmd': ('bash', 15:27:50 INFO - '-c', 15:27:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:27:50 INFO - 'enabled': True, 15:27:50 INFO - 'halt_on_failure': False, 15:27:50 INFO - 'name': 'check_screen_resolution'},), 15:27:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:27:50 INFO - 'cmd': ('bash', 15:27:50 INFO - '-c', 15:27:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:27:50 INFO - 'enabled': True, 15:27:50 INFO - 'halt_on_failure': False, 15:27:50 INFO - 'name': 'check_screen_resolution'},), 15:27:50 INFO - 'run_cmd_checks_enabled': True, 15:27:50 INFO - 'sps_profile': False, 15:27:50 INFO - 'sps_profile_interval': 0, 15:27:50 INFO - 'suite': 'dromaeojs-e10s', 15:27:50 INFO - 'system_bits': '32', 15:27:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:27:50 INFO - 'title': 't-yosemite-r7-0083', 15:27:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:27:50 INFO - 'use_talos_json': True, 15:27:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:27:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:27:50 INFO - 'work_dir': 'build'} 15:27:50 INFO - ##### 15:27:50 INFO - ##### Running clobber step. 15:27:50 INFO - ##### 15:27:50 INFO - Running pre-action listener: _resource_record_pre_action 15:27:50 INFO - Running main action method: clobber 15:27:50 INFO - rmtree: /builds/slave/test/build 15:27:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:27:51 INFO - Running post-action listener: _resource_record_post_action 15:27:51 INFO - ##### 15:27:51 INFO - ##### Running read-buildbot-config step. 15:27:51 INFO - ##### 15:27:51 INFO - Running pre-action listener: _resource_record_pre_action 15:27:51 INFO - Running main action method: read_buildbot_config 15:27:51 INFO - Using buildbot properties: 15:27:51 INFO - { 15:27:51 INFO - "project": "", 15:27:51 INFO - "product": "firefox", 15:27:51 INFO - "script_repo_revision": "production", 15:27:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:27:51 INFO - "repository": "", 15:27:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:27:51 INFO - "buildid": "20160129134528", 15:27:51 INFO - "pgo_build": "False", 15:27:51 INFO - "basedir": "/builds/slave/test", 15:27:51 INFO - "buildnumber": 270, 15:27:51 INFO - "slavename": "t-yosemite-r7-0083", 15:27:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:27:51 INFO - "platform": "yosemite_r7", 15:27:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:27:51 INFO - "branch": "fx-team", 15:27:51 INFO - "repo_path": "integration/fx-team", 15:27:51 INFO - "revision": "bff6cfc7e67b46b55431ccbdbedf025272f54220", 15:27:51 INFO - "stage_platform": "macosx64", 15:27:51 INFO - "builduid": "1b34bb7d44604db68fe6d0c291ce3c5a", 15:27:51 INFO - "slavebuilddir": "test" 15:27:51 INFO - } 15:27:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:27:51 INFO - Running post-action listener: _resource_record_post_action 15:27:51 INFO - ##### 15:27:51 INFO - ##### Running download-and-extract step. 15:27:51 INFO - ##### 15:27:51 INFO - Running pre-action listener: _resource_record_pre_action 15:27:51 INFO - Running main action method: download_and_extract 15:27:51 INFO - mkdir: /builds/slave/test/build/tests 15:27: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')]} 15:27:51 INFO - https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:27:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/test_packages.json 15:27:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/test_packages.json 15:27:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:27:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:28:05 INFO - Downloaded 1277 bytes. 15:28:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:28:05 INFO - Using the following test package requirements: 15:28:05 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:28:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:28:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:28:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'jsshell-mac.zip'], 15:28:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:28:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:28:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:28:05 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:28:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:28:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:28:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:28:05 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:28:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:28: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')]} 15:28:05 INFO - https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:28:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:28:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:28:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:09 INFO - Downloaded 17116783 bytes. 15:28:09 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'] 15:28:09 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 15:28:12 INFO - Return code: 0 15:28:12 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 15:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:12 INFO - https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:28:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:28:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:28:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:14 INFO - Downloaded 17116783 bytes. 15:28:14 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'] 15:28:14 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 15:28:18 INFO - Return code: 0 15:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:18 INFO - https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:28:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:28:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:28:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:19 INFO - Downloaded 10706582 bytes. 15:28:19 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'] 15:28:19 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 15:28:19 INFO - Return code: 0 15:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:19 INFO - https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UkWFoGspSmaNS8Qa3v31PQ/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 15:28:22 INFO - Downloaded 111088047 bytes. 15:28:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:28:22 INFO - mkdir: /builds/slave/test/properties 15:28:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:28:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:28:22 INFO - Contents: 15:28:22 INFO - build_url:https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:28:22 INFO - Running post-action listener: _resource_record_post_action 15:28:22 INFO - Running post-action listener: set_extra_try_arguments 15:28:22 INFO - ##### 15:28:22 INFO - ##### Running populate-webroot step. 15:28:22 INFO - ##### 15:28:22 INFO - Running pre-action listener: _resource_record_pre_action 15:28:22 INFO - Running main action method: populate_webroot 15:28:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:22 INFO - '--tppagecycles', 15:28:22 INFO - '7'], 15:28:22 INFO - 'tests': ['tsvgm']}}, 15:28:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:28:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:28:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:28:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'tests': ['damp', 'tps']}, 15:28:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['damp', 'tps']}, 15:28:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:28:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:22 INFO - 'other': {'tests': ['a11yr', 15:28:22 INFO - 'ts_paint', 15:28:22 INFO - 'tpaint', 15:28:22 INFO - 'sessionrestore', 15:28:22 INFO - 'sessionrestore_no_auto_restore']}, 15:28:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['a11yr', 15:28:22 INFO - 'ts_paint', 15:28:22 INFO - 'tpaint', 15:28:22 INFO - 'sessionrestore', 15:28:22 INFO - 'sessionrestore_no_auto_restore']}, 15:28:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['a11yr', 15:28:22 INFO - 'ts_paint', 15:28:22 INFO - 'tpaint', 15:28:22 INFO - 'sessionrestore', 15:28:22 INFO - 'sessionrestore_no_auto_restore']}, 15:28:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['a11yr', 15:28:22 INFO - 'ts_paint', 15:28:22 INFO - 'tpaint', 15:28:22 INFO - 'sessionrestore', 15:28:22 INFO - 'sessionrestore_no_auto_restore']}, 15:28:22 INFO - 'other_l64': {'tests': ['a11yr', 15:28:22 INFO - 'ts_paint', 15:28:22 INFO - 'tpaint', 15:28:22 INFO - 'sessionrestore', 15:28:22 INFO - 'sessionrestore_no_auto_restore']}, 15:28:22 INFO - 'other_nol64': {'tests': ['a11yr', 15:28:22 INFO - 'ts_paint', 15:28:22 INFO - 'tpaint', 15:28:22 INFO - 'sessionrestore', 15:28:22 INFO - 'sessionrestore_no_auto_restore']}, 15:28:22 INFO - 'svgr': {'tests': ['tsvgx', 15:28:22 INFO - 'tsvgr_opacity', 15:28:22 INFO - 'tart', 15:28:22 INFO - 'tscrollx', 15:28:22 INFO - 'cart']}, 15:28:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['tsvgx', 15:28:22 INFO - 'tsvgr_opacity', 15:28:22 INFO - 'tart', 15:28:22 INFO - 'tscrollx', 15:28:22 INFO - 'cart']}, 15:28:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'tests': ['tp5o']}, 15:28:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'talos_options': ['--e10s'], 15:28:22 INFO - 'tests': ['tp5o']}, 15:28:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'talos_options': ['--xperf_path', 15:28:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:22 INFO - 'tests': ['tp5n']}, 15:28:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:28:22 INFO - 'talos_options': ['--e10s', 15:28:22 INFO - '--xperf_path', 15:28:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:22 INFO - 'tests': ['tp5n']}}, 15:28:22 INFO - 'talos.zip': {'path': '', 15:28:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:22 INFO - Running post-action listener: _resource_record_post_action 15:28:22 INFO - ##### 15:28:22 INFO - ##### Running create-virtualenv step. 15:28:22 INFO - ##### 15:28:22 INFO - Running pre-action listener: _resource_record_pre_action 15:28:22 INFO - Running main action method: create_virtualenv 15:28:22 INFO - Creating virtualenv /builds/slave/test/build/venv 15:28:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:28:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:28:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:22 INFO - Using real prefix '/tools/python27' 15:28:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:28:23 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:26 INFO - Installing pip.................done. 15:28:26 INFO - Return code: 0 15:28:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:26 INFO - 'HOME': '/Users/cltbld', 15:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:26 INFO - 'LOGNAME': 'cltbld', 15:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:26 INFO - 'MOZ_NO_REMOTE': '1', 15:28:26 INFO - 'NO_EM_RESTART': '1', 15:28:26 INFO - 'PAGER': '/bin/cat', 15:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:26 INFO - 'PWD': '/builds/slave/test', 15:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:26 INFO - 'SHELL': '/bin/bash', 15:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:26 INFO - 'USER': 'cltbld', 15:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:26 INFO - 'XPC_FLAGS': '0x0', 15:28:26 INFO - 'XPC_SERVICE_NAME': '0', 15:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:28:26 INFO - Cleaning up... 15:28:26 INFO - Return code: 0 15:28:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:26 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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:26 INFO - 'HOME': '/Users/cltbld', 15:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:26 INFO - 'LOGNAME': 'cltbld', 15:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:26 INFO - 'MOZ_NO_REMOTE': '1', 15:28:26 INFO - 'NO_EM_RESTART': '1', 15:28:26 INFO - 'PAGER': '/bin/cat', 15:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:26 INFO - 'PWD': '/builds/slave/test', 15:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:26 INFO - 'SHELL': '/bin/bash', 15:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:26 INFO - 'USER': 'cltbld', 15:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:26 INFO - 'XPC_FLAGS': '0x0', 15:28:26 INFO - 'XPC_SERVICE_NAME': '0', 15:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:26 INFO - Downloading/unpacking psutil>=0.7.1 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:29 INFO - Installing collected packages: psutil 15:28:29 INFO - Running setup.py install for psutil 15:28:29 INFO - building 'psutil._psutil_osx' extension 15:28:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:28:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:28:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:28:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:28:30 INFO - building 'psutil._psutil_posix' extension 15:28:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:28:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:28:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:28:30 INFO - ^ 15:28:30 INFO - 1 warning generated. 15:28:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:28:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:31 INFO - Successfully installed psutil 15:28:31 INFO - Cleaning up... 15:28:31 INFO - Return code: 0 15:28:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:31 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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:31 INFO - 'HOME': '/Users/cltbld', 15:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:31 INFO - 'LOGNAME': 'cltbld', 15:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:31 INFO - 'MOZ_NO_REMOTE': '1', 15:28:31 INFO - 'NO_EM_RESTART': '1', 15:28:31 INFO - 'PAGER': '/bin/cat', 15:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:31 INFO - 'PWD': '/builds/slave/test', 15:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:31 INFO - 'SHELL': '/bin/bash', 15:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:31 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:31 INFO - 'USER': 'cltbld', 15:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:31 INFO - 'XPC_FLAGS': '0x0', 15:28:31 INFO - 'XPC_SERVICE_NAME': '0', 15:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:28:33 INFO - Installing collected packages: mozsystemmonitor 15:28:33 INFO - Running setup.py install for mozsystemmonitor 15:28:33 INFO - Successfully installed mozsystemmonitor 15:28:33 INFO - Cleaning up... 15:28:33 INFO - Return code: 0 15:28:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:28: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')]} 15:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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')]} 15:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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', '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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:28: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 blobuploader==1.2.4 15:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:33 INFO - 'HOME': '/Users/cltbld', 15:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:33 INFO - 'LOGNAME': 'cltbld', 15:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:33 INFO - 'MOZ_NO_REMOTE': '1', 15:28:33 INFO - 'NO_EM_RESTART': '1', 15:28:33 INFO - 'PAGER': '/bin/cat', 15:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:33 INFO - 'PWD': '/builds/slave/test', 15:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:33 INFO - 'SHELL': '/bin/bash', 15:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:33 INFO - 'USER': 'cltbld', 15:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:33 INFO - 'XPC_FLAGS': '0x0', 15:28:33 INFO - 'XPC_SERVICE_NAME': '0', 15:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:36 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:28:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:37 INFO - Downloading docopt-0.6.1.tar.gz 15:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:37 INFO - Running setup.py install for blobuploader 15:28:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:28:37 INFO - Running setup.py install for requests 15:28:38 INFO - Running setup.py install for docopt 15:28:38 INFO - Successfully installed blobuploader requests docopt 15:28:38 INFO - Cleaning up... 15:28:38 INFO - Return code: 0 15:28:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:38 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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:38 INFO - 'HOME': '/Users/cltbld', 15:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:38 INFO - 'LOGNAME': 'cltbld', 15:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:38 INFO - 'MOZ_NO_REMOTE': '1', 15:28:38 INFO - 'NO_EM_RESTART': '1', 15:28:38 INFO - 'PAGER': '/bin/cat', 15:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:38 INFO - 'PWD': '/builds/slave/test', 15:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:38 INFO - 'SHELL': '/bin/bash', 15:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:38 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:38 INFO - 'USER': 'cltbld', 15:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:38 INFO - 'XPC_FLAGS': '0x0', 15:28:38 INFO - 'XPC_SERVICE_NAME': '0', 15:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-5TC6GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-KjNJkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-5C9MBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-b6X0OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Nk5G_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-zCNjdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QFuNEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EwQYXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oyPRh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-M0r9Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-J8v982-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-xE0w3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-vVYBFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-KadwD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-vliZg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-nZV1tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QEQTBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:40 INFO - Running setup.py install for manifestparser 15:28:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:28:40 INFO - Running setup.py install for mozcrash 15:28:40 INFO - Running setup.py install for mozdebug 15:28:41 INFO - Running setup.py install for mozdevice 15:28:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Running setup.py install for mozfile 15:28:41 INFO - Running setup.py install for mozhttpd 15:28:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Running setup.py install for mozinfo 15:28:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Running setup.py install for mozInstall 15:28:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:28:41 INFO - Running setup.py install for mozleak 15:28:41 INFO - Running setup.py install for mozlog 15:28:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:28:42 INFO - Running setup.py install for moznetwork 15:28:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:28:42 INFO - Running setup.py install for mozprocess 15:28:42 INFO - Running setup.py install for mozprofile 15:28:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:28:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:28:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:28:42 INFO - Running setup.py install for mozrunner 15:28:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:28:42 INFO - Running setup.py install for mozscreenshot 15:28:42 INFO - Running setup.py install for moztest 15:28:42 INFO - Running setup.py install for mozversion 15:28:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:28:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:28:43 INFO - Cleaning up... 15:28:43 INFO - Return code: 0 15:28:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:43 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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:28:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:43 INFO - 'HOME': '/Users/cltbld', 15:28:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:43 INFO - 'LOGNAME': 'cltbld', 15:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:43 INFO - 'MOZ_NO_REMOTE': '1', 15:28:43 INFO - 'NO_EM_RESTART': '1', 15:28:43 INFO - 'PAGER': '/bin/cat', 15:28:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:43 INFO - 'PWD': '/builds/slave/test', 15:28:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:43 INFO - 'SHELL': '/bin/bash', 15:28:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:43 INFO - 'USER': 'cltbld', 15:28:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:43 INFO - 'XPC_FLAGS': '0x0', 15:28:43 INFO - 'XPC_SERVICE_NAME': '0', 15:28:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-931T_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VXr0Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:43 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)) 15:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-b_iL2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-iQn6Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-nzPqyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-io7bdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-SEUsb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-lCVBW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ODEAwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-qwH_WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-8iNndH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-NBj7l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RHj2Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-grrJ87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Q9B7Uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:45 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-2AkWTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:45 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-il7pAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:28:45 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)) 15:28:45 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)) 15:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:28:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:47 INFO - Downloading blessings-1.6.tar.gz 15:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:28:47 INFO - Installing collected packages: blessings 15:28:47 INFO - Running setup.py install for blessings 15:28:47 INFO - Successfully installed blessings 15:28:47 INFO - Cleaning up... 15:28:47 INFO - Return code: 0 15:28:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:28:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:48 INFO - Reading from file tmpfile_stdout 15:28:48 INFO - Current package versions: 15:28:48 INFO - blessings == 1.6 15:28:48 INFO - blobuploader == 1.2.4 15:28:48 INFO - docopt == 0.6.1 15:28:48 INFO - manifestparser == 1.1 15:28:48 INFO - mozInstall == 1.12 15:28:48 INFO - mozcrash == 0.16 15:28:48 INFO - mozdebug == 0.1 15:28:48 INFO - mozdevice == 0.48 15:28:48 INFO - mozfile == 1.2 15:28:48 INFO - mozhttpd == 0.7 15:28:48 INFO - mozinfo == 0.9 15:28:48 INFO - mozleak == 0.1 15:28:48 INFO - mozlog == 3.1 15:28:48 INFO - moznetwork == 0.27 15:28:48 INFO - mozprocess == 0.22 15:28:48 INFO - mozprofile == 0.28 15:28:48 INFO - mozrunner == 6.11 15:28:48 INFO - mozscreenshot == 0.1 15:28:48 INFO - mozsystemmonitor == 0.0 15:28:48 INFO - moztest == 0.7 15:28:48 INFO - mozversion == 1.4 15:28:48 INFO - psutil == 3.1.1 15:28:48 INFO - requests == 1.2.3 15:28:48 INFO - wsgiref == 0.1.2 15:28:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:48 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 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:48 INFO - 'HOME': '/Users/cltbld', 15:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:48 INFO - 'LOGNAME': 'cltbld', 15:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:48 INFO - 'MOZ_NO_REMOTE': '1', 15:28:48 INFO - 'NO_EM_RESTART': '1', 15:28:48 INFO - 'PAGER': '/bin/cat', 15:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:48 INFO - 'PWD': '/builds/slave/test', 15:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:48 INFO - 'SHELL': '/bin/bash', 15:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:48 INFO - 'USER': 'cltbld', 15:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:48 INFO - 'XPC_FLAGS': '0x0', 15:28:48 INFO - 'XPC_SERVICE_NAME': '0', 15:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:28:48 INFO - Cleaning up... 15:28:48 INFO - Return code: 0 15:28:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:48 INFO - 'HOME': '/Users/cltbld', 15:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:48 INFO - 'LOGNAME': 'cltbld', 15:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:48 INFO - 'MOZ_NO_REMOTE': '1', 15:28:48 INFO - 'NO_EM_RESTART': '1', 15:28:48 INFO - 'PAGER': '/bin/cat', 15:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:48 INFO - 'PWD': '/builds/slave/test', 15:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:48 INFO - 'SHELL': '/bin/bash', 15:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:48 INFO - 'USER': 'cltbld', 15:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:48 INFO - 'XPC_FLAGS': '0x0', 15:28:48 INFO - 'XPC_SERVICE_NAME': '0', 15:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:48 INFO - Downloading/unpacking jsonschema 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:28:50 INFO - Downloading/unpacking functools32 (from jsonschema) 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:28:51 INFO - warning: no files found matching '*.txt' 15:28:51 INFO - no previously-included directories found matching 'build' 15:28:51 INFO - no previously-included directories found matching 'dist' 15:28:51 INFO - no previously-included directories found matching '.git*' 15:28:51 INFO - Installing collected packages: jsonschema, functools32 15:28:51 INFO - Running setup.py install for functools32 15:28:51 INFO - warning: no files found matching '*.txt' 15:28:51 INFO - no previously-included directories found matching 'build' 15:28:51 INFO - no previously-included directories found matching 'dist' 15:28:51 INFO - no previously-included directories found matching '.git*' 15:28:51 INFO - Successfully installed jsonschema functools32 15:28:51 INFO - Cleaning up... 15:28:51 INFO - Return code: 0 15:28:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:28: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')]} 15:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28: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')]} 15:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e2da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f885bc61e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, '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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:51 INFO - 'HOME': '/Users/cltbld', 15:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:51 INFO - 'LOGNAME': 'cltbld', 15:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:51 INFO - 'MOZ_NO_REMOTE': '1', 15:28:51 INFO - 'NO_EM_RESTART': '1', 15:28:51 INFO - 'PAGER': '/bin/cat', 15:28:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:51 INFO - 'PWD': '/builds/slave/test', 15:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:51 INFO - 'SHELL': '/bin/bash', 15:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:28:51 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:51 INFO - 'USER': 'cltbld', 15:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:51 INFO - 'XPC_FLAGS': '0x0', 15:28:51 INFO - 'XPC_SERVICE_NAME': '0', 15:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:51 INFO - Downloading/unpacking flake8 15:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:28:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:28:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28: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 15:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:28:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:28:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:28:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:28:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:28:55 INFO - no previously-included directories found matching 'docs/_build' 15:28:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:28:55 INFO - Running setup.py install for pep8 15:28:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:28:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:28:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:28:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:28:55 INFO - no previously-included directories found matching 'docs/_build' 15:28:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:28:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:28:55 INFO - Cleaning up... 15:28:55 INFO - Return code: 0 15:28:55 INFO - Running post-action listener: _resource_record_post_action 15:28:55 INFO - Running post-action listener: _start_resource_monitoring 15:28:55 INFO - Starting resource monitoring. 15:28:55 INFO - ##### 15:28:55 INFO - ##### Running install step. 15:28:55 INFO - ##### 15:28:55 INFO - Running pre-action listener: _resource_record_pre_action 15:28:55 INFO - Running main action method: install 15:28:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:56 INFO - Reading from file tmpfile_stdout 15:28:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:28:56 INFO - Reading from file tmpfile_stdout 15:28:56 INFO - Output received: 15:28:56 INFO - Usage: mozinstall [options] installer 15:28:56 INFO - Options: 15:28:56 INFO - -h, --help show this help message and exit 15:28:56 INFO - -d DEST, --destination=DEST 15:28:56 INFO - Directory to install application into. [default: 15:28:56 INFO - "/builds/slave/test"] 15:28:56 INFO - --app=APP Application being installed. [default: firefox] 15:28:56 INFO - mkdir: /builds/slave/test/build/application 15:28:56 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'] 15:28:56 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 15:29:29 INFO - Reading from file tmpfile_stdout 15:29:29 INFO - Output received: 15:29:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:29:29 INFO - Running post-action listener: _resource_record_post_action 15:29:29 INFO - ##### 15:29:29 INFO - ##### Running run-tests step. 15:29:29 INFO - ##### 15:29:29 INFO - Running pre-action listener: _resource_record_pre_action 15:29:29 INFO - Running main action method: run_tests 15:29:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:29:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:29:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:29:29 INFO - 2016-01-29 15:29:29.590 screenresolution[1658:7828] starting screenresolution argv=screenresolution get 15:29:29 INFO - 2016-01-29 15:29:29.593 screenresolution[1658:7828] Display 0: 1600x1200x32@60 15:29:29 INFO - 2016-01-29 15:29:29.598 screenresolution[1659:7830] starting screenresolution argv=screenresolution list 15:29:29 INFO - Available Modes on Display 0 15:29:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:29:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:29:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:29:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:29:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:29:29 INFO - Intel Iris: 15:29:29 INFO - Chipset Model: Intel Iris 15:29:29 INFO - Type: GPU 15:29:29 INFO - Bus: Built-In 15:29:29 INFO - VRAM (Dynamic, Max): 1536 MB 15:29:29 INFO - Vendor: Intel (0x8086) 15:29:29 INFO - Device ID: 0x0a2e 15:29:29 INFO - Revision ID: 0x0009 15:29:29 INFO - Displays: 15:29:29 INFO - Display: 15:29:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:29:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:29:29 INFO - Display Serial Number: 1600x1200 60 15:29:29 INFO - Main Display: Yes 15:29:29 INFO - Mirror: Off 15:29:29 INFO - Online: Yes 15:29:29 INFO - Rotation: Supported 15:29:29 INFO - Return code: 0 15:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:29:29 INFO - Python 2.7.3 15:29:29 INFO - Return code: 0 15:29:29 INFO - grabbing minidump binary from tooltool 15:29: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')]} 15:29:29 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 0x101cd2d30>, '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 0x101b35db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:29:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:29:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:29:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:29 INFO - Return code: 0 15:29:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:29:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:29:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:29:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:29:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:29:31 INFO - Return code: 0 15:29:31 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:29:31 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.io1WdXCczJ/Render', 15:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:31 INFO - 'HOME': '/Users/cltbld', 15:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:31 INFO - 'LOGNAME': 'cltbld', 15:29:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:31 INFO - 'MOZ_NO_REMOTE': '1', 15:29:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:31 INFO - 'NO_EM_RESTART': '1', 15:29:31 INFO - 'PAGER': '/bin/cat', 15:29:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:31 INFO - 'PWD': '/builds/slave/test', 15:29:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:31 INFO - 'SHELL': '/bin/bash', 15:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vnd08Y7SAm/Listeners', 15:29:31 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 15:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:31 INFO - 'USER': 'cltbld', 15:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:31 INFO - 'XPC_FLAGS': '0x0', 15:29:31 INFO - 'XPC_SERVICE_NAME': '0', 15:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:29:31 INFO - mozversion application_buildid: 20160129134528 15:29:31 INFO - mozversion application_changeset: bff6cfc7e67b46b55431ccbdbedf025272f54220 15:29:31 INFO - mozversion application_display_name: Nightly 15:29:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:31 INFO - mozversion application_name: Firefox 15:29:31 INFO - mozversion application_remotingname: firefox 15:29:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:29:31 INFO - mozversion application_vendor: Mozilla 15:29:31 INFO - mozversion application_version: 47.0a1 15:29:31 INFO - mozversion platform_buildid: 20160129134528 15:29:31 INFO - mozversion platform_changeset: OZ_SOURCE_CHANGESET 15:29:31 INFO - mozversion platform_version: 47.0a1 15:29:31 INFO - using testdate: 1454110171 15:29:31 INFO - actual date: 1454110171 15:29:31 INFO - starting webserver on 'localhost:49286' 15:29:31 INFO - SUITE-START | Running 2 tests 15:29:31 INFO - TEST-START | dromaeo_css 15:29:31 INFO - operating with platform_type : mac_ 15:29:31 INFO - Initialising browser for dromaeo_css test... 15:29:31 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpH8OaHM/profile http://localhost:49286/getInfo.html) 15:29:34 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 15:29:34 INFO - PROCESS | 1677 | colorDepth:24 15:29:34 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 15:29:34 INFO - PROCESS | 1677 | __metrics 15:29:34 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:29:35 INFO - TEST-INFO | 1677: exit 0 15:29:35 INFO - Browser initialized. 15:29:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:29:35 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpH8OaHM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:47 INFO - PROCESS | 1681 | RSS: Main: 256139264 15:29:47 INFO - PROCESS | 1681 | 15:30:37 INFO - PROCESS | 1681 | 1454110237322 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:32:47 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49286/tests/dromaeo/cssquery-ext.html) 15:32:49 INFO - PROCESS | 1681 | RSS: Main: 271740928 15:32:49 INFO - PROCESS | 1681 | 15:35:51 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-ext.html (next: http://localhost:49286/tests/dromaeo/cssquery-jquery.html) 15:35:52 INFO - PROCESS | 1681 | RSS: Main: 281681920 15:35:52 INFO - PROCESS | 1681 | 15:38:53 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49286/tests/dromaeo/cssquery-mootools.html) 15:38:54 INFO - PROCESS | 1681 | RSS: Main: 282763264 15:38:54 INFO - PROCESS | 1681 | 15:41:56 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49286/tests/dromaeo/cssquery-prototype.html) 15:41:56 INFO - PROCESS | 1681 | RSS: Main: 285126656 15:41:56 INFO - PROCESS | 1681 | 15:44:59 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49286/tests/dromaeo/cssquery-yui.html) 15:44:59 INFO - PROCESS | 1681 | RSS: Main: 288337920 15:44:59 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-yui.html (next: http://localhost:49286/tests/dromaeo/cssquery-dojo.html) 15:48:02 INFO - PROCESS | 1681 | RSS: Main: 290185216 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | __start_tp_report 15:48:02 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 15:48:02 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 15:48:02 INFO - PROCESS | 1681 | |i|pagename|runs| 15:48:02 INFO - PROCESS | 1681 | |0;dojo.html;3474.91312717182;3487.9476807847886;3544.2202715402605;3556.9288614227717;3565.269119830435;5403.054465468547;5552.222688823563;5565.359983601887;5602.551795856332;5653.462921022501;5514.283143191379;5637.9718101409535;5640.323161220659;5641.12562552804;5647.237622920905;5055.418626857903;5082.221222572098;5136.922946155811;5158.200478925773;5201.063808514466;5205.635605507616;5207.583393328544;5220.373555173384;5282.656627319231;5301.761420736057;5172.09488339541;5197.662151960129;5210.895782084356;5214.791408343662;5253.711045892474;4982.90034199314;5132.512411320956;5150.716710580917;5163.7418129093585;5169.638125331228;5071.757419432226;5088.363954505687;5099.923501147486;5150.716710580917;5152.793888244466;4497.595216430537;5151.8196863109615;5447.754851031674;5458.153986132156;5479.75341109651;6030.33666296707;6108.51062771414;6129.417705317987;6135.386461353829;6148.415900489446;6102.298235702862;6109;6130.428711073867;6197.938020619781;6218.347073557302;5698.4871361576825;5781.913271300976;5787.536997040227;5793.478586927196;5822.970885145547;6115.938840611537;6128.908066379008;6150.876982460415;6154.046122850965;6162.506999440034;4436.46762388509;6032.788852390146;6039.849003774941;6056.182415373868;6077.301110372276;6051.576389652682;6098.176746139215;6140.232470941132;6170.691465426711;6176.042713379434;6060.636361818305;6124.530112772903;6131.346082861964;6154.753809847645;6164.7842325518395;6111.96944015277;6122.591176939007;6137.478314343241;6153.907691384633;6154.569180157346;3968.761874287552;4824.927626085611;4845.2732090186755;4853.344798452164;4860.465348811628;4265.680073994463;4318.179545886272;4330.069035157457;4386.846460373871;4402.0755641315045;5729;5762.74067666956;5795.362510123883;5818.912716309259;5819.447152520504;6009.248843894513;6119.685352982159;6150.692465376714;6222.408871157233;6253.937460625427;5816.476517113396;5824.970875145597;5834.24154859874;5846.035404158351;5868.09044598088;5353.250544923714;5358.6248962572245;5367.114426119724;5372.382176049726;5378.731063446812;6156.322804491502;6187.81436556904;6231.345708700521;6242.563020588606;6295.685215739286;5596.720163991703;5896.8206358729285;6193.752249910133;6202.069689546604;6263.060540918898;6230.196945277317;6286.277078136073;6291.213598300213;6314.905276420949;6324.3991820776955;5963.940360596339;6057.9701450754355;6083.330833608211;6112.351504965139;6128.472568454128;5695.45893140151;6158.815235542941;6162.291336496361;6200.968995154995;6234.470070043915;4709.929351059668;5884.382139875423;6044.274687037584;6047.304559975659;6083.6349819011;5032.471590483093;5833.912491312549;5974.984252676968;6016.338202797776;6142.385761423822;4852.80588776445;4938.75306234694;5790.015697331548;5826.242588463472;5837.270341207349;5038.521340472649;5945.197398351167;5987.491063259672;5999.760009599741;6105.45050945417;4907.558319751097;5846.707664616837;5852.297724273115;5913.881722365614;6004.729787159501 15:48:02 INFO - PROCESS | 1681 | |1;ext.html;433.9956600433995;484.5566306829251;540.926974858394;544.2733950176514;570.8867707969459;37709.05727356818;38173.85478435651;38385.424218636705;38403.80798096005;38721.22557548851;40837;40906;41220.38169427453;41374;41513.79243103788;9424.29317801166;9549.474778887194;9583.089606487407;9613;9684.418934863896;9486.9525652372;9612.56743446543;9625;9707.320487565874;9744.512774361288;9710;9785.951070244639;9796.951015244913;9797.755056123618;9802.509874506282;9672.951635241814;9696.612135514571;9725.367851089657;9770.9511452443;9783.608655653765;9651.613935442574;9670.613175472972;9781.41311521304;9822.459764712938;9919.454430006346;39549.60450395488;39894.800525997474;39988.60011399907;40003.59996400057;40006.799966000275;3305.818180000099;3623.438367053111;3628.38317486028;3637.1270894985278;3884.747491413049;27623.03319383832;28857.711422885714;29011.984580539578;29044.854775725988;29190.27024324388;2814.226087825844;2820.3936153727045;2851.957220641692;3002.279452931281;3022.607061082045;452543;453438;453494;454360;455929.72035139945;54335.72832135893;55279;60641;61196.69401653052;61590.384096158465;60400.39599603948;60510;60601.39398605958;60663.786724265265;60703.69648151819;15738.134402607737;15845.286962086733;15861.365545378287;15964.521064368088;16022.278997445143;12462.065345099154;12547.560835370718;12628.747425051448;12654.746905062031;12668.683282917817;18689;18909.90545047266;19228.807711922982;19327.420177394702;19435.22259109648;7738.806529836686;7848.646810893523;7891.790298716369;7909.180888395701;7911.406644501685;927.3554879358916;978.6281213139104;993.2401712689798;1019.0777346501428;1020.2042406922612;26059.869700651376;28566;29072.27319317034;29959.101226963227;30037.399252015275;1023.6110278094426;1031.1694398875136;1077.8090210317644;1089.727568107973;1138.4706111658118;12581.182223155465;14807.777883331759;14906.850931490762;15257.008294460824;15276.770848437282;539657;543703;546839;548675;549317;57601;58030.70984645134;58497.415025850045;58646.41353586495;58736.11895821566;1406.7397531456713;1421.722764060998;1423.9715205696036;1426.5934208750457;1439.5825210688993;24274;29300.706992929798;30086.69913300839;30180.396392071598;30391;51400.48599513957;51575.226371605204;51637.22544161916;51796;51852.96294074022;434455;435694;437920;438097;440440.37137585954;28430.573541396483;28937.69780359931;31213;32713.672863272015;33801.83099084489;34855;39117;39936.4009539863;41748.58251417447;42002.369964451165;33965.15087122743;35650.8217458911;36703.632963670025;36991;37693.81153094217;29872.25319367033;36066;36091;36123;36935.63064369322;27838.86080569665;34407.65592344045;34573;34870;34891;28923.276918077216;30366;30509.389812204077;30576.694233057384;30736.846315768278;20652.141307282418;20885.37343879686;23830.523389531765;24163.033478660658;24838.50322993494 15:48:02 INFO - PROCESS | 1681 | |2;jquery.html;324.44843765598483;362.0839276630125;364.7847769815809;367.4103064581345;367.67277123360213;14598;15634.687306253869;17088.829111708877;18237.635247295046;21115.944202789855;15902.363905443797;19180.945048022353;19204.615907681837;19220.615587688237;19227.230910763552;5641.915371269424;5926.614770039955;5953.136795164699;5967.970160149215;5978.52171826255;4133.070059236663;4317.352397140423;5500.202470641754;6314.905276420857;6558.737650493975;5241;6430.228372595295;6501.4798816094835;6510.934890651104;6513.413792758651;6371;6375.815459004804;6421;6429.517786166033;6446.9355306446805;5370.409254981949;5459.590530710173;5506.1190209566275;5508.862278443031;5509.338879334466;24431.389215269584;24711;24763.88562514691;24928.750712493005;25082.996680132772;2118.099807581787;2349.7650234976536;2484.2174714964726;2546.032507647101;2901.3181902252954;13753.656158596015;13979;14092.718145637133;14450.71098578033;14746.483873064391;1425.6578421178947;1718.3384397007117;1752.97370539442;1777.2180240694054;1791.9606628155639;94603.56766633858;95681.08637827204;96332;97110.51444742872;98919.50540247325;10353.689389318333;10575.629852955264;10711.94644026775;10732.692471118748;10794.514246858753;12575.685607859694;12711;12806.719328067118;12812.295323757096;13014.609561713163;7620.733274335483;8006;8392.657174852116;8481.406301558955;8591.44155629882;8785.472871627722;8793.340499462565;8798.516081615444;8837.60230789616;8878.511681857432;5568.6658800472105;6064.545159112996;6166.907496387557;6189.876202476015;6208.255009398901;1738.478456463056;1766.2758269109604;1835.5319393554826;1854.3046357615895;1886.669832779258;860.7116615933733;957.7031120352713;997.7605374710163;1014.8883622801486;1052.1687866585312;16773.7483937741;17813.821861781216;20910.11808937203;21260.149594016377;21452.24917127893;871.3227037951917;934.7336009237334;974.2352253481125;987.8221920054459;1050.7005503431485;9945.502724863727;10183;10186.337888037255;10193.286469947181;10223.386596804216;630317.5452368219;693157;699920;713601;718375;94133.52933235427;95943;107377;109249.45375273231;112307;1000.5847573257017;1188.2098404561043;1204.8313236146946;1205.1624121235657;1209.2986068080668;17187;17273.65452690914;17407.651846963243;17545.43728705146;17576.296948121933;42501.78749106234;45367.31949020701;45485.772571136935;46467;47923;54660.45339546713;57239.71380143073;59077;60273.09590356236;61931.690341548005;7162.104736907887;7326.780196594111;7457.7389791357045;7490.625468726433;7576.886346704694;9453.810923781348;11520.596779112691;11588.826167607323;11703.015730988544;11993.34036627994;10060.39637621745;10399.428031458343;10488.05607495329;10508.737281568023;10715;10187.235957303084;10248.487575621339;10275.691729248134;10361.948190259;10643.521041552995;10397.896021039693;10549.419781912069;10553.314034587727;10604.661378645815;10696.62561810364;7429.8142546436775;7592.8481430369975;7594.772156835304;7615.5430674159725;7617.085949686073;8865.911340886509;9969.950150249202;10297.9485102574;10385.48072596352;10644.8935510647 15:48:02 INFO - PROCESS | 1681 | |3;mootools.html;1491.8955673102885;1535.7082154390662;1686.5614940115565;1786.7677201963743;1876.5590086329719;7901.881471777928;8046.5976701165;8707.869381959275;8811.955940220298;8929.732108036762;8381;8508.78728031798;8623.482591044542;8627.482351058941;8635.52504612246;2460.200434858674;2483.081259933827;2486.17956074495;2486.428121532049;2494.762997515233;2429.9878500607474;2478.8140889433275;2493.763092506218;2496.276079936816;2497.7876880465183;2074.7033104309808;2396.724376696685;2438.3782135555407;2484.1057219401;2495.950080998379;2457.401875963045;2465.494573612423;2465.556199884029;2469.493753780471;2482.615194644833;2315.2822624986306;2335.9182428615086;2341.461463863321;2342.4729435876793;2344.39045848079;8811.515366654832;8865.46807191564;8877.06790786971;8882.955585222033;8893.955530222373;4963.975180124113;5355.7857685692525;5476.780928762844;5511.889762204773;5534.889302213974;3025.8184508929535;3075.5847960525266;3673.5959044505084;3704.49989251453;3716.8141592920247;989.8020395920845;1039.459481069847;1067.7010437077631;1091.858058452404;1110.3615421132881;9177.449353038839;10228.744281393025;12073.517059317617;12078.879211207952;12145.210561313486;4904.558589726942;4909.263610458388;4944.233643785219;4945.629077819178;4970.304157417964;10334.431606261727;10357.119644830274;10362.430066346273;10387.94806025965;10388.272820902615;5434.483724046209;5501.9174712379345;5502.2296878437055;5563.972180139073;5568.470995255444;4449.57729015743;4593.379893714373;4837.346958160673;4961.677490963076;5003.074431230234;3996.18078293949;4009.258287216816;4014.6587540059422;4053.432519447221;4080.5511393746665;1273.3951373097705;1293.1336004876755;1304.3347892574666;1308.5289295853486;1313.8029295605545;1063.3566692151292;1072.372661992743;1363.352407606379;1387.5074348606302;1395.762720337545;8114.959425202955;8171;8196.098429172785;8208.343332533383;8228.8354232915;506.35638870932786;517.647999360431;517.6557589203138;523.2256260734135;524.3655177235512;6128.233970753656;6144.5084393248435;6158;6214.192155019909;6260.499160067184;10689.946550267354;10915.853835347332;11040.447977601088;11080.944595277133;11123.332600043861;10411.687649370531;10778.892211077946;10808.081313088318;10878.891211087946;10950.616728414627;8323;8358.874616880752;8366.24703776663;8419;8462.19609137131;7844.80387990282;7892.329152021913;7913.287804097658;7923.247291507298;7969.1632378601735;9528.761780955532;9667.9033209667;9698.75753106178;9723.173530250007;9771.657991970247;9803.852942205729;10052.246081543768;10122.291439599452;10180.389176649129;10180.643677471253;6679.699413526306;7445.702171913063;7500.887486687813;7588.506747061644;7678.347340475899;8146.022477302525;8152.388570857091;8165.265126138676;8201.179882011751;8204.958975205085;7509.51188172767;7637.923620763943;7664.463487555818;7692.615369231404;7773.92226077732;7472.962635186789;7523.360514356341;7536.434767392358;7567.848643027219;7616.162222155669;7769.922300777146;7787.29914307715;7824.452288339761;7838.294553490213;7859.449838511249;7024.473164512579;7040.225575186828;7068.929310706827;7081.362677358857;7104.254053324533;7194.532355396883;7205.063341765537;7239;7260.092488438945;7293.234210407831 15:48:02 INFO - PROCESS | 1681 | |4;prototype.html;307.6784759925877;307.8337697643274;319.95360672702475;327.7607346636955;337.77706713569034;6439.549231553793;6445.581037232577;6561.376669216429;6663.300353462883;6741.966290168542;6445.935540644592;6635.23694775101;6646.401823835854;6649.601023938555;6666.866662666744;3618.9866837285604;3865.9613403866024;4454.53227411122;4964.751762411874;5016.122178618745;4142.958570414287;4964.15609346412;4968.031233909389;4985.401751789772;5016.072026675059;4715.434147902257;4919.43426505951;4928.901421971558;4947.604191664676;4973.179425394806;4934.963657631865;4943.085529177114;4950.801967921278;4954.133026720309;4962.379702537183;3995.3807159889975;4094.160697057126;4236.894077648052;4248.235317642823;4274.850380236708;5750.476123827189;5918.733656985403;6233.563650544464;6397.232332120128;6465;4738.976305118453;5819.272590926134;5825.388334224887;5832.62087964281;5861.736221870026;6993.545419547764;7125.7505987290715;7134.571925684476;7166.032585600981;7222.458315626349;4743.667943243974;4746.288056791474;4746.335513028179;4759.690620109682;4772.713637181745;7518.360939320164;7554.169041405496;7555;7589.43079269057;7593.734219302353;4812.25410061441;4814.470408255159;4821.349117869043;4830.2513110467935;4837.4920633332995;4718.268668356411;4906.337644417958;4930.457649658535;4946.159152944008;4953.876153096201;5802.448767367094;5802.970985145132;5804.361520232771;5809.796657116981;5818.738156782955;7130.429565634737;7133.7146514139895;7159.67781449836;7183.712651493882;7188.353048225685;1581.5571639940836;1650.4965985374336;1656.7680524726547;1684.4693921414714;1714.8971061736086;1056.804491169136;1067.8024565455416;1077.0360527327998;1081.9891801082047;1083.5286650307141;6692.564983276072;6712.563683360566;6730.192376914703;6737.258901520829;6770.322967703289;7327;7334.559926404433;7344.522606030591;7345.926540734631;7392.593407362539;6463.256725476536;6716.361945615159;6745.797626071226;6752.729890804411;6755.459563235027;3777.187904600469;3834.8657796976972;3866.8646597368956;3875.612438756158;3899;7663.19536448676;7813.921860781433;7938.404619653549;7962.163972782891;7989.560574168477;7729.188435214334;7751.4573979822;7759.030121234846;7770.766876993699;7781.572013539309;6451.935480645134;7302.452316076316;7675;7925.564093974772;7930.968974033454;7455.776326710207;7462.925370746223;7485.70057197706;7508.511946723445;7525.88711169322;6091;6096.908546371719;6695.531312808057;7179.138503379628;7333.4499912507845;7661.578613176329;7915.643796029308;7930.9603451982375;7941.960290198743;7963.522188668699;4729.5034021427255;4734.053189362073;4748.810047598057;4752.453467851103;4755.405574303212;7211.134663840373;7417.480776345604;7420.925790742023;7431.182569917197;7437.442191835742;5863.912041319299;7150.713971441084;7151.249118842655;7151.8569628608175;7196.856062878818;7138.678759455733;7142.964285178541;7159.997600336062;7164.498485105993;7168.390686791681;6834.692438840363;6967.442604591722;6987.96506017487;7000.509964302653;7003.26465721092;7128.429725622042;7165.3551180394015;7181.245969173162;7186.928130718626;7207.459440541876;5780.739866705924;6899.586024838526;7021.648917554;7030.753923612649;7073.434125269863 15:48:02 INFO - PROCESS | 1681 | |5;yui.html;673.9157605299338;687.7695971849433;696.3454352908266;727;737.3290305821703;14659.267036648165;14704.264786760647;14749.262536873153;14787.778183327231;14842.40630374785;13434.261115638636;13472.595822125351;13482.191068535894;13495.190288582691;13501.797473037888;686.7287421468517;694.5381321421249;831.771262902702;841.7054031089131;844.3582877013483;850.4939560961249;858.0089996054567;859.4070091636781;859.5745106172453;860.0668274921718;903.3586153830788;907.8638204269347;908.9000209976897;909.0999910088997;913.5888850017519;896.0322851320558;896.5427631907709;899.9415038022507;902.0438335364502;904.2088172848757;655.3642966322659;665.8468552233013;672.2537982839045;673.7507122364707;673.8349104469436;14006.299685015709;14119.435222591186;14121.223332716696;14128.22294773787;14179.36192871313;12779.105462617621;12794.48822047117;12895.968322534174;13199.86800131996;13318.533851315158;9992.300538962276;10087.798244035152;10165.11867905062;10174.898251017468;10217.489125543692;3530.6645868642436;3593.7664051836546;3598.226381328027;3629.981850090759;3707.5550933887835;78677;79557.60221198914;79585.20414795894;80140.59929700372;81103.18896811016;9455.858162127573;9506.191973682176;9549.809003819884;9561.760955976157;9876.160526355197;20711;20823.79176208249;20836;20836.47908802292;20931.37205883826;7418;7539.660715267826;7546.735864244725;7657.617119144021;7938.444308898437;3660.2679464107287;4136.607022332873;4158.6673066154635;4191.811368488426;4353.151135528541;3520.753547251719;3538.310029544214;3573.19603089308;3577.767445116111;3577.94633080504;634.9841253968596;643.433778275115;645.6319897658384;667.9833004174934;668.6523008035795;562.7130163616503;596.4184919703341;611.2786911444538;621.3755176048043;628.8019273928697;8265.917340826514;8268.793280167924;8625.654973800978;8629.956850215709;8692.130786921258;487.9121758083508;503.29036059156414;519.0371860199351;556.9053260945649;627.2754968011953;3970.841166353371;3980.144268982183;3992.920141597152;4032.7983600819844;4103.4460347852655;92346;93066.53466732622;94465;95300;96459.51770241244;81346;81420.37159256781;83014.75477867837;83494;85828.28343433222;69658.65170674115;70663.64668176626;73208.63395683093;73419.5316093675;74271.99999999892;8270.338372930031;8313.41806073569;8338.583070846555;8565.143485651384;8627.309815214643;48923.51076489189;49192;49746.005079898925;49925.50074499209;50185;59770.701146493986;60319.68241746746;61375.85184518521;61845.38154618396;62922.426939326884;9608.711738647851;10643.840342394715;10776.407297598707;10936.562537498728;11207.775844483227;11715.589954351557;11824.822627660764;12280.508779649072;12503.937480312541;12649.430775614936;11438.313701177956;11708.004819590431;11783.175177737476;11852.466639001093;12330.938345308576;11756;11771.999380052792;11828.34944078084;11872.990795782454;11909.583164589198;8637.82724345497;11646.35945022998;11646.417679116179;11677.824832627348;12266.202696824677;9161.587728552364;9179.219766319937;9583.856242156513;9668.129868311886;10243.180545556486;7818.491798033109;7902.170272121574;8360.414770966217;8682.779994653154;9181.449113053239 15:48:02 INFO - PROCESS | 1681 | __end_tp_report 15:48:02 INFO - PROCESS | 1681 | __start_cc_report 15:48:02 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,354 15:48:02 INFO - PROCESS | 1681 | __end_cc_report 15:48:02 INFO - PROCESS | 1681 | __startTimestamp1454111282529__endTimestamp 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | ------- Summary: start ------- 15:48:02 INFO - PROCESS | 1681 | Number of tests: 6 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5618.02 Median:5826.24 stddev:641.82 (11.0%) stddev-sans-first:621.37 15:48:02 INFO - PROCESS | 1681 | Values: 3474.9 3487.9 3544.2 3556.9 3565.3 5403.1 5552.2 5565.4 5602.6 5653.5 5514.3 5638.0 5640.3 5641.1 5647.2 5055.4 5082.2 5136.9 5158.2 5201.1 5205.6 5207.6 5220.4 5282.7 5301.8 5172.1 5197.7 5210.9 5214.8 5253.7 4982.9 5132.5 5150.7 5163.7 5169.6 5071.8 5088.4 5099.9 5150.7 5152.8 4497.6 5151.8 5447.8 5458.2 5479.8 6030.3 6108.5 6129.4 6135.4 6148.4 6102.3 6109.0 6130.4 6197.9 6218.3 5698.5 5781.9 5787.5 5793.5 5823.0 6115.9 6128.9 6150.9 6154.0 6162.5 4436.5 6032.8 6039.8 6056.2 6077.3 6051.6 6098.2 6140.2 6170.7 6176.0 6060.6 6124.5 6131.3 6154.8 6164.8 6112.0 6122.6 6137.5 6153.9 6154.6 3968.8 4824.9 4845.3 4853.3 4860.5 4265.7 4318.2 4330.1 4386.8 4402.1 5729.0 5762.7 5795.4 5818.9 5819.4 6009.2 6119.7 6150.7 6222.4 6253.9 5816.5 5825.0 5834.2 5846.0 5868.1 5353.3 5358.6 5367.1 5372.4 5378.7 6156.3 6187.8 6231.3 6242.6 6295.7 5596.7 5896.8 6193.8 6202.1 6263.1 6230.2 6286.3 6291.2 6314.9 6324.4 5963.9 6058.0 6083.3 6112.4 6128.5 5695.5 6158.8 6162.3 6201.0 6234.5 4709.9 5884.4 6044.3 6047.3 6083.6 5032.5 5833.9 5975.0 6016.3 6142.4 4852.8 4938.8 5790.0 5826.2 5837.3 5038.5 5945.2 5987.5 5999.8 6105.5 4907.6 5846.7 5852.3 5913.9 6004.7 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:61914.60 Median:38562.52 stddev:128013.53 (332.0%) stddev-sans-first:128289.42 15:48:02 INFO - PROCESS | 1681 | Values: 434.0 484.6 540.9 544.3 570.9 37709.1 38173.9 38385.4 38403.8 38721.2 40837.0 40906.0 41220.4 41374.0 41513.8 9424.3 9549.5 9583.1 9613.0 9684.4 9487.0 9612.6 9625.0 9707.3 9744.5 9710.0 9786.0 9797.0 9797.8 9802.5 9673.0 9696.6 9725.4 9771.0 9783.6 9651.6 9670.6 9781.4 9822.5 9919.5 39549.6 39894.8 39988.6 40003.6 40006.8 3305.8 3623.4 3628.4 3637.1 3884.7 27623.0 28857.7 29012.0 29044.9 29190.3 2814.2 2820.4 2852.0 3002.3 3022.6 452543.0 453438.0 453494.0 454360.0 455929.7 54335.7 55279.0 60641.0 61196.7 61590.4 60400.4 60510.0 60601.4 60663.8 60703.7 15738.1 15845.3 15861.4 15964.5 16022.3 12462.1 12547.6 12628.7 12654.7 12668.7 18689.0 18909.9 19228.8 19327.4 19435.2 7738.8 7848.6 7891.8 7909.2 7911.4 927.4 978.6 993.2 1019.1 1020.2 26059.9 28566.0 29072.3 29959.1 30037.4 1023.6 1031.2 1077.8 1089.7 1138.5 12581.2 14807.8 14906.9 15257.0 15276.8 539657.0 543703.0 546839.0 548675.0 549317.0 57601.0 58030.7 58497.4 58646.4 58736.1 1406.7 1421.7 1424.0 1426.6 1439.6 24274.0 29300.7 30086.7 30180.4 30391.0 51400.5 51575.2 51637.2 51796.0 51853.0 434455.0 435694.0 437920.0 438097.0 440440.4 28430.6 28937.7 31213.0 32713.7 33801.8 34855.0 39117.0 39936.4 41748.6 42002.4 33965.2 35650.8 36703.6 36991.0 37693.8 29872.3 36066.0 36091.0 36123.0 36935.6 27838.9 34407.7 34573.0 34870.0 34891.0 28923.3 30366.0 30509.4 30576.7 30736.8 20652.1 20885.4 23830.5 24163.0 24838.5 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:35293.44 Median:2723.68 stddev:113722.86 (4175.3%) stddev-sans-first:114011.56 15:48:02 INFO - PROCESS | 1681 | Values: 324.4 362.1 364.8 367.4 367.7 14598.0 15634.7 17088.8 18237.6 21115.9 15902.4 19180.9 19204.6 19220.6 19227.2 5641.9 5926.6 5953.1 5968.0 5978.5 4133.1 4317.4 5500.2 6314.9 6558.7 5241.0 6430.2 6501.5 6510.9 6513.4 6371.0 6375.8 6421.0 6429.5 6446.9 5370.4 5459.6 5506.1 5508.9 5509.3 24431.4 24711.0 24763.9 24928.8 25083.0 2118.1 2349.8 2484.2 2546.0 2901.3 13753.7 13979.0 14092.7 14450.7 14746.5 1425.7 1718.3 1753.0 1777.2 1792.0 94603.6 95681.1 96332.0 97110.5 98919.5 10353.7 10575.6 10711.9 10732.7 10794.5 12575.7 12711.0 12806.7 12812.3 13014.6 7620.7 8006.0 8392.7 8481.4 8591.4 8785.5 8793.3 8798.5 8837.6 8878.5 5568.7 6064.5 6166.9 6189.9 6208.3 1738.5 1766.3 1835.5 1854.3 1886.7 860.7 957.7 997.8 1014.9 1052.2 16773.7 17813.8 20910.1 21260.1 21452.2 871.3 934.7 974.2 987.8 1050.7 9945.5 10183.0 10186.3 10193.3 10223.4 630317.5 693157.0 699920.0 713601.0 718375.0 94133.5 95943.0 107377.0 109249.5 112307.0 1000.6 1188.2 1204.8 1205.2 1209.3 17187.0 17273.7 17407.7 17545.4 17576.3 42501.8 45367.3 45485.8 46467.0 47923.0 54660.5 57239.7 59077.0 60273.1 61931.7 7162.1 7326.8 7457.7 7490.6 7576.9 9453.8 11520.6 11588.8 11703.0 11993.3 10060.4 10399.4 10488.1 10508.7 10715.0 10187.2 10248.5 10275.7 10361.9 10643.5 10397.9 10549.4 10553.3 10604.7 10696.6 7429.8 7592.8 7594.8 7615.5 7617.1 8865.9 9970.0 10297.9 10385.5 10644.9 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:6067.42 Median:520.44 stddev:3227.90 (620.2%) stddev-sans-first:3218.63 15:48:02 INFO - PROCESS | 1681 | Values: 1491.9 1535.7 1686.6 1786.8 1876.6 7901.9 8046.6 8707.9 8812.0 8929.7 8381.0 8508.8 8623.5 8627.5 8635.5 2460.2 2483.1 2486.2 2486.4 2494.8 2430.0 2478.8 2493.8 2496.3 2497.8 2074.7 2396.7 2438.4 2484.1 2496.0 2457.4 2465.5 2465.6 2469.5 2482.6 2315.3 2335.9 2341.5 2342.5 2344.4 8811.5 8865.5 8877.1 8883.0 8894.0 4964.0 5355.8 5476.8 5511.9 5534.9 3025.8 3075.6 3673.6 3704.5 3716.8 989.8 1039.5 1067.7 1091.9 1110.4 9177.4 10228.7 12073.5 12078.9 12145.2 4904.6 4909.3 4944.2 4945.6 4970.3 10334.4 10357.1 10362.4 10387.9 10388.3 5434.5 5501.9 5502.2 5564.0 5568.5 4449.6 4593.4 4837.3 4961.7 5003.1 3996.2 4009.3 4014.7 4053.4 4080.6 1273.4 1293.1 1304.3 1308.5 1313.8 1063.4 1072.4 1363.4 1387.5 1395.8 8115.0 8171.0 8196.1 8208.3 8228.8 506.4 517.6 517.7 523.2 524.4 6128.2 6144.5 6158.0 6214.2 6260.5 10689.9 10915.9 11040.4 11080.9 11123.3 10411.7 10778.9 10808.1 10878.9 10950.6 8323.0 8358.9 8366.2 8419.0 8462.2 7844.8 7892.3 7913.3 7923.2 7969.2 9528.8 9667.9 9698.8 9723.2 9771.7 9803.9 10052.2 10122.3 10180.4 10180.6 6679.7 7445.7 7500.9 7588.5 7678.3 8146.0 8152.4 8165.3 8201.2 8205.0 7509.5 7637.9 7664.5 7692.6 7773.9 7473.0 7523.4 7536.4 7567.8 7616.2 7769.9 7787.3 7824.5 7838.3 7859.4 7024.5 7040.2 7068.9 7081.4 7104.3 7194.5 7205.1 7239.0 7260.1 7293.2 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5838.13 Median:6640.82 stddev:1883.99 (28.4%) stddev-sans-first:1842.98 15:48:02 INFO - PROCESS | 1681 | Values: 307.7 307.8 320.0 327.8 337.8 6439.5 6445.6 6561.4 6663.3 6742.0 6445.9 6635.2 6646.4 6649.6 6666.9 3619.0 3866.0 4454.5 4964.8 5016.1 4143.0 4964.2 4968.0 4985.4 5016.1 4715.4 4919.4 4928.9 4947.6 4973.2 4935.0 4943.1 4950.8 4954.1 4962.4 3995.4 4094.2 4236.9 4248.2 4274.9 5750.5 5918.7 6233.6 6397.2 6465.0 4739.0 5819.3 5825.4 5832.6 5861.7 6993.5 7125.8 7134.6 7166.0 7222.5 4743.7 4746.3 4746.3 4759.7 4772.7 7518.4 7554.2 7555.0 7589.4 7593.7 4812.3 4814.5 4821.3 4830.3 4837.5 4718.3 4906.3 4930.5 4946.2 4953.9 5802.4 5803.0 5804.4 5809.8 5818.7 7130.4 7133.7 7159.7 7183.7 7188.4 1581.6 1650.5 1656.8 1684.5 1714.9 1056.8 1067.8 1077.0 1082.0 1083.5 6692.6 6712.6 6730.2 6737.3 6770.3 7327.0 7334.6 7344.5 7345.9 7392.6 6463.3 6716.4 6745.8 6752.7 6755.5 3777.2 3834.9 3866.9 3875.6 3899.0 7663.2 7813.9 7938.4 7962.2 7989.6 7729.2 7751.5 7759.0 7770.8 7781.6 6451.9 7302.5 7675.0 7925.6 7931.0 7455.8 7462.9 7485.7 7508.5 7525.9 6091.0 6096.9 6695.5 7179.1 7333.4 7661.6 7915.6 7931.0 7942.0 7963.5 4729.5 4734.1 4748.8 4752.5 4755.4 7211.1 7417.5 7420.9 7431.2 7437.4 5863.9 7150.7 7151.2 7151.9 7196.9 7138.7 7143.0 7160.0 7164.5 7168.4 6834.7 6967.4 6988.0 7000.5 7003.3 7128.4 7165.4 7181.2 7186.9 7207.5 5780.7 6899.6 7021.6 7030.8 7073.4 15:48:02 INFO - PROCESS | 1681 | 15:48:02 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:18282.66 Median:628.04 stddev:25923.51 (4127.7%) stddev-sans-first:25962.52 15:48:02 INFO - PROCESS | 1681 | Values: 673.9 687.8 696.3 727.0 737.3 14659.3 14704.3 14749.3 14787.8 14842.4 13434.3 13472.6 13482.2 13495.2 13501.8 686.7 694.5 831.8 841.7 844.4 850.5 858.0 859.4 859.6 860.1 903.4 907.9 908.9 909.1 913.6 896.0 896.5 899.9 902.0 904.2 655.4 665.8 672.3 673.8 673.8 14006.3 14119.4 14121.2 14128.2 14179.4 12779.1 12794.5 12896.0 13199.9 13318.5 9992.3 10087.8 10165.1 10174.9 10217.5 3530.7 3593.8 3598.2 3630.0 3707.6 78677.0 79557.6 79585.2 80140.6 81103.2 9455.9 9506.2 9549.8 9561.8 9876.2 20711.0 20823.8 20836.0 20836.5 20931.4 7418.0 7539.7 7546.7 7657.6 7938.4 3660.3 4136.6 4158.7 4191.8 4353.2 3520.8 3538.3 3573.2 3577.8 3577.9 635.0 643.4 645.6 668.0 668.7 562.7 596.4 611.3 621.4 628.8 8265.9 8268.8 8625.7 8630.0 8692.1 487.9 503.3 519.0 556.9 627.3 3970.8 3980.1 3992.9 4032.8 4103.4 92346.0 93066.5 94465.0 95300.0 96459.5 81346.0 81420.4 83014.8 83494.0 85828.3 69658.7 70663.6 73208.6 73419.5 74272.0 8270.3 8313.4 8338.6 8565.1 8627.3 48923.5 49192.0 49746.0 49925.5 50185.0 59770.7 60319.7 61375.9 61845.4 62922.4 9608.7 10643.8 10776.4 10936.6 11207.8 11715.6 11824.8 12280.5 12503.9 12649.4 11438.3 11708.0 11783.2 11852.5 12330.9 11756.0 11772.0 11828.3 11873.0 11909.6 8637.8 11646.4 11646.4 11677.8 12266.2 9161.6 9179.2 9583.9 9668.1 10243.2 7818.5 7902.2 8360.4 8682.8 9181.4 15:48:02 INFO - PROCESS | 1681 | -------- Summary: end -------- 15:48:02 INFO - PROCESS | 1681 | 15:48:03 INFO - TEST-INFO | 1681: exit 0 15:48:03 INFO - TEST-OK | dromaeo_css | took 1111276ms 15:48:03 INFO - TEST-START | kraken 15:48:03 INFO - operating with platform_type : mac_ 15:48:03 INFO - Initialising browser for kraken test... 15:48:03 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpBAkJGb/profile http://localhost:49286/getInfo.html) 15:48:05 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 15:48:05 INFO - PROCESS | 1691 | colorDepth:24 15:48:05 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 15:48:05 INFO - PROCESS | 1691 | __metrics 15:48:06 INFO - PROCESS | 1691 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:48:06 INFO - PROCESS | 1691 | 15:48:06 INFO - PROCESS | 1691 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 15:48:06 INFO - PROCESS | 1691 | 15:48:06 INFO - TEST-INFO | 1691: exit 0 15:48:06 INFO - Browser initialized. 15:48:06 INFO - Running cycle 1/1 for kraken test... 15:48:06 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpBAkJGb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:18 INFO - PROCESS | 1694 | RSS: Main: 256122880 15:48:18 INFO - PROCESS | 1694 | 15:48:21 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:21 INFO - PROCESS | 1694 | RSS: Main: 269520896 15:48:21 INFO - PROCESS | 1694 | 15:48:24 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-dft) 15:48:25 INFO - PROCESS | 1694 | RSS: Main: 279093248 15:48:25 INFO - PROCESS | 1694 | 15:48:28 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-fft) 15:48:29 INFO - PROCESS | 1694 | RSS: Main: 281153536 15:48:29 INFO - PROCESS | 1694 | 15:48:30 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-oscillator) 15:48:31 INFO - PROCESS | 1694 | RSS: Main: 282353664 15:48:31 INFO - PROCESS | 1694 | 15:48:33 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:34 INFO - PROCESS | 1694 | RSS: Main: 284254208 15:48:34 INFO - PROCESS | 1694 | 15:48:37 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:37 INFO - PROCESS | 1694 | RSS: Main: 283234304 15:48:37 INFO - PROCESS | 1694 | 15:48:40 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:41 INFO - PROCESS | 1694 | RSS: Main: 282984448 15:48:41 INFO - PROCESS | 1694 | 15:48:44 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49286/tests/kraken/driver.html?testName=json-parse-financial) 15:48:44 INFO - PROCESS | 1694 | RSS: Main: 284241920 15:48:44 INFO - PROCESS | 1694 | 15:48:46 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:47 INFO - PROCESS | 1694 | RSS: Main: 284459008 15:48:47 INFO - PROCESS | 1694 | 15:48:48 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:49 INFO - PROCESS | 1694 | RSS: Main: 282763264 15:48:49 INFO - PROCESS | 1694 | 15:48:51 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:52 INFO - PROCESS | 1694 | RSS: Main: 282775552 15:48:52 INFO - PROCESS | 1694 | 15:48:54 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:55 INFO - PROCESS | 1694 | RSS: Main: 283168768 15:48:55 INFO - PROCESS | 1694 | 15:48:58 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:58 INFO - PROCESS | 1694 | RSS: Main: 284577792 15:48:58 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49286/tests/kraken/driver.html?testName=ai-astar) 15:49:00 INFO - PROCESS | 1694 | RSS: Main: 285589504 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | __start_tp_report 15:49:00 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 15:49:00 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 15:49:00 INFO - PROCESS | 1694 | |i|pagename|runs| 15:49:00 INFO - PROCESS | 1694 | |0;ai-astar;115;109;115;114;121;184;161;115;112;114 15:49:00 INFO - PROCESS | 1694 | |1;audio-beat-detection;157;140;150;157;122;171;164;123;156;121 15:49:00 INFO - PROCESS | 1694 | |2;audio-dft;191;195;198;203;205;210;199;198;207;196 15:49:00 INFO - PROCESS | 1694 | |3;audio-fft;57;67;69;68;98;81;79;80;84;113 15:49:00 INFO - PROCESS | 1694 | |4;audio-oscillator;81;87;116;92;116;114;119;81;82;126 15:49:00 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;123;92;84;96;118;91;85;91;86;90 15:49:00 INFO - PROCESS | 1694 | |6;imaging-darkroom;101;103;131;116;91;100;149;90;98;146 15:49:00 INFO - PROCESS | 1694 | |7;imaging-desaturate;94;77;83;139;148;144;91;110;90;90 15:49:00 INFO - PROCESS | 1694 | |8;json-parse-financial;56;60;83;82;80;80;73;64;56;57 15:49:00 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;67;64;73;74;70;71;64;67;66;65 15:49:00 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;85;83;86;85;85;85;85;83;86;83 15:49:00 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;126;127;150;147;127;132;133;123;130;124 15:49:00 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;128;148;130;153;156;167;128;153;174;187 15:49:00 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;67;66;68;67;69;66;68;72;90;94 15:49:00 INFO - PROCESS | 1694 | __end_tp_report 15:49:00 INFO - PROCESS | 1694 | __start_cc_report 15:49:00 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,873 15:49:00 INFO - PROCESS | 1694 | __end_cc_report 15:49:00 INFO - PROCESS | 1694 | __startTimestamp1454111340656__endTimestamp 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | ------- Summary: start ------- 15:49:00 INFO - PROCESS | 1694 | Number of tests: 14 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:126.00 Median:115.00 stddev:25.28 (22.0%) stddev-sans-first:26.49 15:49:00 INFO - PROCESS | 1694 | Values: 115.0 109.0 115.0 114.0 121.0 184.0 161.0 115.0 112.0 114.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:156.50 stddev:18.48 (11.8%) stddev-sans-first:19.17 15:49:00 INFO - PROCESS | 1694 | Values: 157.0 140.0 150.0 157.0 122.0 171.0 164.0 123.0 156.0 121.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:200.20 Median:201.00 stddev:5.90 (2.9%) stddev-sans-first:5.24 15:49:00 INFO - PROCESS | 1694 | Values: 191.0 195.0 198.0 203.0 205.0 210.0 199.0 198.0 207.0 196.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:79.60 Median:79.50 stddev:16.30 (20.5%) stddev-sans-first:15.10 15:49:00 INFO - PROCESS | 1694 | Values: 57.0 67.0 69.0 68.0 98.0 81.0 79.0 80.0 84.0 113.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:81.00 stddev:18.27 (22.6%) stddev-sans-first:17.83 15:49:00 INFO - PROCESS | 1694 | Values: 81.0 87.0 116.0 92.0 116.0 114.0 119.0 81.0 82.0 126.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:90.50 stddev:13.66 (15.1%) stddev-sans-first:10.27 15:49:00 INFO - PROCESS | 1694 | Values: 123.0 92.0 84.0 96.0 118.0 91.0 85.0 91.0 86.0 90.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:147.50 stddev:22.03 (14.9%) stddev-sans-first:22.97 15:49:00 INFO - PROCESS | 1694 | Values: 101.0 103.0 131.0 116.0 91.0 100.0 149.0 90.0 98.0 146.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:106.60 Median:86.50 stddev:27.00 (31.2%) stddev-sans-first:28.25 15:49:00 INFO - PROCESS | 1694 | Values: 94.0 77.0 83.0 139.0 148.0 144.0 91.0 110.0 90.0 90.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:76.50 stddev:11.60 (15.2%) stddev-sans-first:11.29 15:49:00 INFO - PROCESS | 1694 | Values: 56.0 60.0 83.0 82.0 80.0 80.0 73.0 64.0 56.0 57.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.50 stddev:3.67 (5.4%) stddev-sans-first:3.87 15:49:00 INFO - PROCESS | 1694 | Values: 67.0 64.0 73.0 74.0 70.0 71.0 64.0 67.0 66.0 65.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 15:49:00 INFO - PROCESS | 1694 | Values: 85.0 83.0 86.0 85.0 85.0 85.0 85.0 83.0 86.0 83.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:131.00 stddev:9.34 (7.1%) stddev-sans-first:9.66 15:49:00 INFO - PROCESS | 1694 | Values: 126.0 127.0 150.0 147.0 127.0 132.0 133.0 123.0 130.0 124.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:154.50 stddev:20.01 (12.9%) stddev-sans-first:19.17 15:49:00 INFO - PROCESS | 1694 | Values: 128.0 148.0 130.0 153.0 156.0 167.0 128.0 153.0 174.0 187.0 15:49:00 INFO - PROCESS | 1694 | 15:49:00 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:68.50 stddev:10.36 (15.1%) stddev-sans-first:10.78 15:49:00 INFO - PROCESS | 1694 | Values: 67.0 66.0 68.0 67.0 69.0 66.0 68.0 72.0 90.0 94.0 15:49:00 INFO - PROCESS | 1694 | -------- Summary: end -------- 15:49:00 INFO - PROCESS | 1694 | 15:49:01 INFO - TEST-INFO | 1694: exit 0 15:49:01 INFO - TEST-OK | kraken | took 58310ms 15:49:01 INFO - SUITE-END | took 1169s 15:49:01 INFO - Completed test suite (00:19:30) 15:49:01 INFO - Working with test: dromaeo_css 15:49:01 INFO - Generating results file: dromaeo_css 15:49:01 INFO - Working with test: kraken 15:49:01 INFO - Generating results file: kraken 15:49:01 INFO - javascript benchmark 15:49:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:49:02 INFO - process_Request line: dromaeo_css 7456.98 graph.html#tests=[[72,64,61]] 15:49:02 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:49:02 INFO - process_Request line: kraken 1546.80 graph.html#tests=[[232,64,61]] 15:49:02 INFO - RETURN: dromaeo_css: 7456.98 15:49:02 INFO - RETURN: kraken: 1546.80 15:49:02 INFO - javascript benchmark 15:49:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3474.91312717182, 3487.9476807847886, 3544.2202715402605, 3556.9288614227717, 3565.269119830435, 5403.054465468547, 5552.222688823563, 5565.359983601887, 5602.551795856332, 5653.462921022501, 5514.283143191379, 5637.9718101409535, 5640.323161220659, 5641.12562552804, 5647.237622920905, 5055.418626857903, 5082.221222572098, 5136.922946155811, 5158.200478925773, 5201.063808514466, 5205.635605507616, 5207.583393328544, 5220.373555173384, 5282.656627319231, 5301.761420736057, 5172.09488339541, 5197.662151960129, 5210.895782084356, 5214.791408343662, 5253.711045892474, 4982.90034199314, 5132.512411320956, 5150.716710580917, 5163.7418129093585, 5169.638125331228, 5071.757419432226, 5088.363954505687, 5099.923501147486, 5150.716710580917, 5152.793888244466, 4497.595216430537, 5151.8196863109615, 5447.754851031674, 5458.153986132156, 5479.75341109651, 6030.33666296707, 6108.51062771414, 6129.417705317987, 6135.386461353829, 6148.415900489446, 6102.298235702862, 6109.0, 6130.428711073867, 6197.938020619781, 6218.347073557302, 5698.4871361576825, 5781.913271300976, 5787.536997040227, 5793.478586927196, 5822.970885145547, 6115.938840611537, 6128.908066379008, 6150.876982460415, 6154.046122850965, 6162.506999440034, 4436.46762388509, 6032.788852390146, 6039.849003774941, 6056.182415373868, 6077.301110372276, 6051.576389652682, 6098.176746139215, 6140.232470941132, 6170.691465426711, 6176.042713379434, 6060.636361818305, 6124.530112772903, 6131.346082861964, 6154.753809847645, 6164.7842325518395, 6111.96944015277, 6122.591176939007, 6137.478314343241, 6153.907691384633, 6154.569180157346, 3968.761874287552, 4824.927626085611, 4845.2732090186755, 4853.344798452164, 4860.465348811628, 4265.680073994463, 4318.179545886272, 4330.069035157457, 4386.846460373871, 4402.0755641315045, 5729.0, 5762.74067666956, 5795.362510123883, 5818.912716309259, 5819.447152520504, 6009.248843894513, 6119.685352982159, 6150.692465376714, 6222.408871157233, 6253.937460625427, 5816.476517113396, 5824.970875145597, 5834.24154859874, 5846.035404158351, 5868.09044598088, 5353.250544923714, 5358.6248962572245, 5367.114426119724, 5372.382176049726, 5378.731063446812, 6156.322804491502, 6187.81436556904, 6231.345708700521, 6242.563020588606, 6295.685215739286, 5596.720163991703, 5896.8206358729285, 6193.752249910133, 6202.069689546604, 6263.060540918898, 6230.196945277317, 6286.277078136073, 6291.213598300213, 6314.905276420949, 6324.3991820776955, 5963.940360596339, 6057.9701450754355, 6083.330833608211, 6112.351504965139, 6128.472568454128, 5695.45893140151, 6158.815235542941, 6162.291336496361, 6200.968995154995, 6234.470070043915, 4709.929351059668, 5884.382139875423, 6044.274687037584, 6047.304559975659, 6083.6349819011, 5032.471590483093, 5833.912491312549, 5974.984252676968, 6016.338202797776, 6142.385761423822, 4852.80588776445, 4938.75306234694, 5790.015697331548, 5826.242588463472, 5837.270341207349, 5038.521340472649, 5945.197398351167, 5987.491063259672, 5999.760009599741, 6105.45050945417, 4907.558319751097, 5846.707664616837, 5852.297724273115, 5913.881722365614, 6004.729787159501], "unit": "score", "name": "dojo.html", "value": 5581.647018247769}, {"lowerIsBetter": false, "replicates": [433.9956600433995, 484.5566306829251, 540.926974858394, 544.2733950176514, 570.8867707969459, 37709.05727356818, 38173.85478435651, 38385.424218636705, 38403.80798096005, 38721.22557548851, 40837.0, 40906.0, 41220.38169427453, 41374.0, 41513.79243103788, 9424.29317801166, 9549.474778887194, 9583.089606487407, 9613.0, 9684.418934863896, 9486.9525652372, 9612.56743446543, 9625.0, 9707.320487565874, 9744.512774361288, 9710.0, 9785.951070244639, 9796.951015244913, 9797.755056123618, 9802.509874506282, 9672.951635241814, 9696.612135514571, 9725.367851089657, 9770.9511452443, 9783.608655653765, 9651.613935442574, 9670.613175472972, 9781.41311521304, 9822.459764712938, 9919.454430006346, 39549.60450395488, 39894.800525997474, 39988.60011399907, 40003.59996400057, 40006.799966000275, 3305.818180000099, 3623.438367053111, 3628.38317486028, 3637.1270894985278, 3884.747491413049, 27623.03319383832, 28857.711422885714, 29011.984580539578, 29044.854775725988, 29190.27024324388, 2814.226087825844, 2820.3936153727045, 2851.957220641692, 3002.279452931281, 3022.607061082045, 452543.0, 453438.0, 453494.0, 454360.0, 455929.72035139945, 54335.72832135893, 55279.0, 60641.0, 61196.69401653052, 61590.384096158465, 60400.39599603948, 60510.0, 60601.39398605958, 60663.786724265265, 60703.69648151819, 15738.134402607737, 15845.286962086733, 15861.365545378287, 15964.521064368088, 16022.278997445143, 12462.065345099154, 12547.560835370718, 12628.747425051448, 12654.746905062031, 12668.683282917817, 18689.0, 18909.90545047266, 19228.807711922982, 19327.420177394702, 19435.22259109648, 7738.806529836686, 7848.646810893523, 7891.790298716369, 7909.180888395701, 7911.406644501685, 927.3554879358916, 978.6281213139104, 993.2401712689798, 1019.0777346501428, 1020.2042406922612, 26059.869700651376, 28566.0, 29072.27319317034, 29959.101226963227, 30037.399252015275, 1023.6110278094426, 1031.1694398875136, 1077.8090210317644, 1089.727568107973, 1138.4706111658118, 12581.182223155465, 14807.777883331759, 14906.850931490762, 15257.008294460824, 15276.770848437282, 539657.0, 543703.0, 546839.0, 548675.0, 549317.0, 57601.0, 58030.70984645134, 58497.415025850045, 58646.41353586495, 58736.11895821566, 1406.7397531456713, 1421.722764060998, 1423.9715205696036, 1426.5934208750457, 1439.5825210688993, 24274.0, 29300.706992929798, 30086.69913300839, 30180.396392071598, 30391.0, 51400.48599513957, 51575.226371605204, 51637.22544161916, 51796.0, 51852.96294074022, 434455.0, 435694.0, 437920.0, 438097.0, 440440.37137585954, 28430.573541396483, 28937.69780359931, 31213.0, 32713.672863272015, 33801.83099084489, 34855.0, 39117.0, 39936.4009539863, 41748.58251417447, 42002.369964451165, 33965.15087122743, 35650.8217458911, 36703.632963670025, 36991.0, 37693.81153094217, 29872.25319367033, 36066.0, 36091.0, 36123.0, 36935.63064369322, 27838.86080569665, 34407.65592344045, 34573.0, 34870.0, 34891.0, 28923.276918077216, 30366.0, 30509.389812204077, 30576.694233057384, 30736.846315768278, 20652.141307282418, 20885.37343879686, 23830.523389531765, 24163.033478660658, 24838.50322993494], "unit": "score", "name": "ext.html", "value": 19300.71608096427}, {"lowerIsBetter": false, "replicates": [324.44843765598483, 362.0839276630125, 364.7847769815809, 367.4103064581345, 367.67277123360213, 14598.0, 15634.687306253869, 17088.829111708877, 18237.635247295046, 21115.944202789855, 15902.363905443797, 19180.945048022353, 19204.615907681837, 19220.615587688237, 19227.230910763552, 5641.915371269424, 5926.614770039955, 5953.136795164699, 5967.970160149215, 5978.52171826255, 4133.070059236663, 4317.352397140423, 5500.202470641754, 6314.905276420857, 6558.737650493975, 5241.0, 6430.228372595295, 6501.4798816094835, 6510.934890651104, 6513.413792758651, 6371.0, 6375.815459004804, 6421.0, 6429.517786166033, 6446.9355306446805, 5370.409254981949, 5459.590530710173, 5506.1190209566275, 5508.862278443031, 5509.338879334466, 24431.389215269584, 24711.0, 24763.88562514691, 24928.750712493005, 25082.996680132772, 2118.099807581787, 2349.7650234976536, 2484.2174714964726, 2546.032507647101, 2901.3181902252954, 13753.656158596015, 13979.0, 14092.718145637133, 14450.71098578033, 14746.483873064391, 1425.6578421178947, 1718.3384397007117, 1752.97370539442, 1777.2180240694054, 1791.9606628155639, 94603.56766633858, 95681.08637827204, 96332.0, 97110.51444742872, 98919.50540247325, 10353.689389318333, 10575.629852955264, 10711.94644026775, 10732.692471118748, 10794.514246858753, 12575.685607859694, 12711.0, 12806.719328067118, 12812.295323757096, 13014.609561713163, 7620.733274335483, 8006.0, 8392.657174852116, 8481.406301558955, 8591.44155629882, 8785.472871627722, 8793.340499462565, 8798.516081615444, 8837.60230789616, 8878.511681857432, 5568.6658800472105, 6064.545159112996, 6166.907496387557, 6189.876202476015, 6208.255009398901, 1738.478456463056, 1766.2758269109604, 1835.5319393554826, 1854.3046357615895, 1886.669832779258, 860.7116615933733, 957.7031120352713, 997.7605374710163, 1014.8883622801486, 1052.1687866585312, 16773.7483937741, 17813.821861781216, 20910.11808937203, 21260.149594016377, 21452.24917127893, 871.3227037951917, 934.7336009237334, 974.2352253481125, 987.8221920054459, 1050.7005503431485, 9945.502724863727, 10183.0, 10186.337888037255, 10193.286469947181, 10223.386596804216, 630317.5452368219, 693157.0, 699920.0, 713601.0, 718375.0, 94133.52933235427, 95943.0, 107377.0, 109249.45375273231, 112307.0, 1000.5847573257017, 1188.2098404561043, 1204.8313236146946, 1205.1624121235657, 1209.2986068080668, 17187.0, 17273.65452690914, 17407.651846963243, 17545.43728705146, 17576.296948121933, 42501.78749106234, 45367.31949020701, 45485.772571136935, 46467.0, 47923.0, 54660.45339546713, 57239.71380143073, 59077.0, 60273.09590356236, 61931.690341548005, 7162.104736907887, 7326.780196594111, 7457.7389791357045, 7490.625468726433, 7576.886346704694, 9453.810923781348, 11520.596779112691, 11588.826167607323, 11703.015730988544, 11993.34036627994, 10060.39637621745, 10399.428031458343, 10488.05607495329, 10508.737281568023, 10715.0, 10187.235957303084, 10248.487575621339, 10275.691729248134, 10361.948190259, 10643.521041552995, 10397.896021039693, 10549.419781912069, 10553.314034587727, 10604.661378645815, 10696.62561810364, 7429.8142546436775, 7592.8481430369975, 7594.772156835304, 7615.5430674159725, 7617.085949686073, 8865.911340886509, 9969.950150249202, 10297.9485102574, 10385.48072596352, 10644.8935510647], "unit": "score", "name": "jquery.html", "value": 9267.09867925645}, {"lowerIsBetter": false, "replicates": [1491.8955673102885, 1535.7082154390662, 1686.5614940115565, 1786.7677201963743, 1876.5590086329719, 7901.881471777928, 8046.5976701165, 8707.869381959275, 8811.955940220298, 8929.732108036762, 8381.0, 8508.78728031798, 8623.482591044542, 8627.482351058941, 8635.52504612246, 2460.200434858674, 2483.081259933827, 2486.17956074495, 2486.428121532049, 2494.762997515233, 2429.9878500607474, 2478.8140889433275, 2493.763092506218, 2496.276079936816, 2497.7876880465183, 2074.7033104309808, 2396.724376696685, 2438.3782135555407, 2484.1057219401, 2495.950080998379, 2457.401875963045, 2465.494573612423, 2465.556199884029, 2469.493753780471, 2482.615194644833, 2315.2822624986306, 2335.9182428615086, 2341.461463863321, 2342.4729435876793, 2344.39045848079, 8811.515366654832, 8865.46807191564, 8877.06790786971, 8882.955585222033, 8893.955530222373, 4963.975180124113, 5355.7857685692525, 5476.780928762844, 5511.889762204773, 5534.889302213974, 3025.8184508929535, 3075.5847960525266, 3673.5959044505084, 3704.49989251453, 3716.8141592920247, 989.8020395920845, 1039.459481069847, 1067.7010437077631, 1091.858058452404, 1110.3615421132881, 9177.449353038839, 10228.744281393025, 12073.517059317617, 12078.879211207952, 12145.210561313486, 4904.558589726942, 4909.263610458388, 4944.233643785219, 4945.629077819178, 4970.304157417964, 10334.431606261727, 10357.119644830274, 10362.430066346273, 10387.94806025965, 10388.272820902615, 5434.483724046209, 5501.9174712379345, 5502.2296878437055, 5563.972180139073, 5568.470995255444, 4449.57729015743, 4593.379893714373, 4837.346958160673, 4961.677490963076, 5003.074431230234, 3996.18078293949, 4009.258287216816, 4014.6587540059422, 4053.432519447221, 4080.5511393746665, 1273.3951373097705, 1293.1336004876755, 1304.3347892574666, 1308.5289295853486, 1313.8029295605545, 1063.3566692151292, 1072.372661992743, 1363.352407606379, 1387.5074348606302, 1395.762720337545, 8114.959425202955, 8171.0, 8196.098429172785, 8208.343332533383, 8228.8354232915, 506.35638870932786, 517.647999360431, 517.6557589203138, 523.2256260734135, 524.3655177235512, 6128.233970753656, 6144.5084393248435, 6158.0, 6214.192155019909, 6260.499160067184, 10689.946550267354, 10915.853835347332, 11040.447977601088, 11080.944595277133, 11123.332600043861, 10411.687649370531, 10778.892211077946, 10808.081313088318, 10878.891211087946, 10950.616728414627, 8323.0, 8358.874616880752, 8366.24703776663, 8419.0, 8462.19609137131, 7844.80387990282, 7892.329152021913, 7913.287804097658, 7923.247291507298, 7969.1632378601735, 9528.761780955532, 9667.9033209667, 9698.75753106178, 9723.173530250007, 9771.657991970247, 9803.852942205729, 10052.246081543768, 10122.291439599452, 10180.389176649129, 10180.643677471253, 6679.699413526306, 7445.702171913063, 7500.887486687813, 7588.506747061644, 7678.347340475899, 8146.022477302525, 8152.388570857091, 8165.265126138676, 8201.179882011751, 8204.958975205085, 7509.51188172767, 7637.923620763943, 7664.463487555818, 7692.615369231404, 7773.92226077732, 7472.962635186789, 7523.360514356341, 7536.434767392358, 7567.848643027219, 7616.162222155669, 7769.922300777146, 7787.29914307715, 7824.452288339761, 7838.294553490213, 7859.449838511249, 7024.473164512579, 7040.225575186828, 7068.929310706827, 7081.362677358857, 7104.254053324533, 7194.532355396883, 7205.063341765537, 7239.0, 7260.092488438945, 7293.234210407831], "unit": "score", "name": "mootools.html", "value": 4850.997852517704}, {"lowerIsBetter": false, "replicates": [307.6784759925877, 307.8337697643274, 319.95360672702475, 327.7607346636955, 337.77706713569034, 6439.549231553793, 6445.581037232577, 6561.376669216429, 6663.300353462883, 6741.966290168542, 6445.935540644592, 6635.23694775101, 6646.401823835854, 6649.601023938555, 6666.866662666744, 3618.9866837285604, 3865.9613403866024, 4454.53227411122, 4964.751762411874, 5016.122178618745, 4142.958570414287, 4964.15609346412, 4968.031233909389, 4985.401751789772, 5016.072026675059, 4715.434147902257, 4919.43426505951, 4928.901421971558, 4947.604191664676, 4973.179425394806, 4934.963657631865, 4943.085529177114, 4950.801967921278, 4954.133026720309, 4962.379702537183, 3995.3807159889975, 4094.160697057126, 4236.894077648052, 4248.235317642823, 4274.850380236708, 5750.476123827189, 5918.733656985403, 6233.563650544464, 6397.232332120128, 6465.0, 4738.976305118453, 5819.272590926134, 5825.388334224887, 5832.62087964281, 5861.736221870026, 6993.545419547764, 7125.7505987290715, 7134.571925684476, 7166.032585600981, 7222.458315626349, 4743.667943243974, 4746.288056791474, 4746.335513028179, 4759.690620109682, 4772.713637181745, 7518.360939320164, 7554.169041405496, 7555.0, 7589.43079269057, 7593.734219302353, 4812.25410061441, 4814.470408255159, 4821.349117869043, 4830.2513110467935, 4837.4920633332995, 4718.268668356411, 4906.337644417958, 4930.457649658535, 4946.159152944008, 4953.876153096201, 5802.448767367094, 5802.970985145132, 5804.361520232771, 5809.796657116981, 5818.738156782955, 7130.429565634737, 7133.7146514139895, 7159.67781449836, 7183.712651493882, 7188.353048225685, 1581.5571639940836, 1650.4965985374336, 1656.7680524726547, 1684.4693921414714, 1714.8971061736086, 1056.804491169136, 1067.8024565455416, 1077.0360527327998, 1081.9891801082047, 1083.5286650307141, 6692.564983276072, 6712.563683360566, 6730.192376914703, 6737.258901520829, 6770.322967703289, 7327.0, 7334.559926404433, 7344.522606030591, 7345.926540734631, 7392.593407362539, 6463.256725476536, 6716.361945615159, 6745.797626071226, 6752.729890804411, 6755.459563235027, 3777.187904600469, 3834.8657796976972, 3866.8646597368956, 3875.612438756158, 3899.0, 7663.19536448676, 7813.921860781433, 7938.404619653549, 7962.163972782891, 7989.560574168477, 7729.188435214334, 7751.4573979822, 7759.030121234846, 7770.766876993699, 7781.572013539309, 6451.935480645134, 7302.452316076316, 7675.0, 7925.564093974772, 7930.968974033454, 7455.776326710207, 7462.925370746223, 7485.70057197706, 7508.511946723445, 7525.88711169322, 6091.0, 6096.908546371719, 6695.531312808057, 7179.138503379628, 7333.4499912507845, 7661.578613176329, 7915.643796029308, 7930.9603451982375, 7941.960290198743, 7963.522188668699, 4729.5034021427255, 4734.053189362073, 4748.810047598057, 4752.453467851103, 4755.405574303212, 7211.134663840373, 7417.480776345604, 7420.925790742023, 7431.182569917197, 7437.442191835742, 5863.912041319299, 7150.713971441084, 7151.249118842655, 7151.8569628608175, 7196.856062878818, 7138.678759455733, 7142.964285178541, 7159.997600336062, 7164.498485105993, 7168.390686791681, 6834.692438840363, 6967.442604591722, 6987.96506017487, 7000.509964302653, 7003.26465721092, 7128.429725622042, 7165.3551180394015, 7181.245969173162, 7186.928130718626, 7207.459440541876, 5780.739866705924, 6899.586024838526, 7021.648917554, 7030.753923612649, 7073.434125269863], "unit": "score", "name": "prototype.html", "value": 5204.007186143277}, {"lowerIsBetter": false, "replicates": [673.9157605299338, 687.7695971849433, 696.3454352908266, 727.0, 737.3290305821703, 14659.267036648165, 14704.264786760647, 14749.262536873153, 14787.778183327231, 14842.40630374785, 13434.261115638636, 13472.595822125351, 13482.191068535894, 13495.190288582691, 13501.797473037888, 686.7287421468517, 694.5381321421249, 831.771262902702, 841.7054031089131, 844.3582877013483, 850.4939560961249, 858.0089996054567, 859.4070091636781, 859.5745106172453, 860.0668274921718, 903.3586153830788, 907.8638204269347, 908.9000209976897, 909.0999910088997, 913.5888850017519, 896.0322851320558, 896.5427631907709, 899.9415038022507, 902.0438335364502, 904.2088172848757, 655.3642966322659, 665.8468552233013, 672.2537982839045, 673.7507122364707, 673.8349104469436, 14006.299685015709, 14119.435222591186, 14121.223332716696, 14128.22294773787, 14179.36192871313, 12779.105462617621, 12794.48822047117, 12895.968322534174, 13199.86800131996, 13318.533851315158, 9992.300538962276, 10087.798244035152, 10165.11867905062, 10174.898251017468, 10217.489125543692, 3530.6645868642436, 3593.7664051836546, 3598.226381328027, 3629.981850090759, 3707.5550933887835, 78677.0, 79557.60221198914, 79585.20414795894, 80140.59929700372, 81103.18896811016, 9455.858162127573, 9506.191973682176, 9549.809003819884, 9561.760955976157, 9876.160526355197, 20711.0, 20823.79176208249, 20836.0, 20836.47908802292, 20931.37205883826, 7418.0, 7539.660715267826, 7546.735864244725, 7657.617119144021, 7938.444308898437, 3660.2679464107287, 4136.607022332873, 4158.6673066154635, 4191.811368488426, 4353.151135528541, 3520.753547251719, 3538.310029544214, 3573.19603089308, 3577.767445116111, 3577.94633080504, 634.9841253968596, 643.433778275115, 645.6319897658384, 667.9833004174934, 668.6523008035795, 562.7130163616503, 596.4184919703341, 611.2786911444538, 621.3755176048043, 628.8019273928697, 8265.917340826514, 8268.793280167924, 8625.654973800978, 8629.956850215709, 8692.130786921258, 487.9121758083508, 503.29036059156414, 519.0371860199351, 556.9053260945649, 627.2754968011953, 3970.841166353371, 3980.144268982183, 3992.920141597152, 4032.7983600819844, 4103.4460347852655, 92346.0, 93066.53466732622, 94465.0, 95300.0, 96459.51770241244, 81346.0, 81420.37159256781, 83014.75477867837, 83494.0, 85828.28343433222, 69658.65170674115, 70663.64668176626, 73208.63395683093, 73419.5316093675, 74271.99999999892, 8270.338372930031, 8313.41806073569, 8338.583070846555, 8565.143485651384, 8627.309815214643, 48923.51076489189, 49192.0, 49746.005079898925, 49925.50074499209, 50185.0, 59770.701146493986, 60319.68241746746, 61375.85184518521, 61845.38154618396, 62922.426939326884, 9608.711738647851, 10643.840342394715, 10776.407297598707, 10936.562537498728, 11207.775844483227, 11715.589954351557, 11824.822627660764, 12280.508779649072, 12503.937480312541, 12649.430775614936, 11438.313701177956, 11708.004819590431, 11783.175177737476, 11852.466639001093, 12330.938345308576, 11756.0, 11771.999380052792, 11828.34944078084, 11872.990795782454, 11909.583164589198, 8637.82724345497, 11646.35945022998, 11646.417679116179, 11677.824832627348, 12266.202696824677, 9161.587728552364, 9179.219766319937, 9583.856242156513, 9668.129868311886, 10243.180545556486, 7818.491798033109, 7902.170272121574, 8360.414770966217, 8682.779994653154, 9181.449113053239], "unit": "score", "name": "yui.html", "value": 6821.717835506023}], "name": "dromaeo_css", "value": 7456.976562706234}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 115.0, 114.0, 121.0, 184.0, 161.0, 115.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 126.0}, {"lowerIsBetter": true, "replicates": [157.0, 140.0, 150.0, 157.0, 122.0, 171.0, 164.0, 123.0, 156.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [191.0, 195.0, 198.0, 203.0, 205.0, 210.0, 199.0, 198.0, 207.0, 196.0], "unit": "score", "name": "audio-dft", "value": 200.2}, {"lowerIsBetter": true, "replicates": [57.0, 67.0, 69.0, 68.0, 98.0, 81.0, 79.0, 80.0, 84.0, 113.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [81.0, 87.0, 116.0, 92.0, 116.0, 114.0, 119.0, 81.0, 82.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 101.4}, {"lowerIsBetter": true, "replicates": [123.0, 92.0, 84.0, 96.0, 118.0, 91.0, 85.0, 91.0, 86.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.6}, {"lowerIsBetter": true, "replicates": [101.0, 103.0, 131.0, 116.0, 91.0, 100.0, 149.0, 90.0, 98.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 112.5}, {"lowerIsBetter": true, "replicates": [94.0, 77.0, 83.0, 139.0, 148.0, 144.0, 91.0, 110.0, 90.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 106.6}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 83.0, 82.0, 80.0, 80.0, 73.0, 64.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 69.1}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 73.0, 74.0, 70.0, 71.0, 64.0, 67.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 86.0, 85.0, 85.0, 85.0, 85.0, 83.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 150.0, 147.0, 127.0, 132.0, 133.0, 123.0, 130.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.9}, {"lowerIsBetter": true, "replicates": [128.0, 148.0, 130.0, 153.0, 156.0, 167.0, 128.0, 153.0, 174.0, 187.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 67.0, 69.0, 66.0, 68.0, 72.0, 90.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.7}], "name": "kraken", "value": 1546.8}]} 15:49:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1546.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7456.98"}}} 15:49:02 INFO - Return code: 0 15:49:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:49:02 INFO - # TBPL SUCCESS # 15:49:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:49:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:49:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:49:02 INFO - 2016-01-29 15:49:02.477 screenresolution[1699:10845] starting screenresolution argv=screenresolution get 15:49:02 INFO - 2016-01-29 15:49:02.479 screenresolution[1699:10845] Display 0: 1600x1200x32@60 15:49:02 INFO - 2016-01-29 15:49:02.485 screenresolution[1700:10848] starting screenresolution argv=screenresolution list 15:49:02 INFO - Available Modes on Display 0 15:49:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:49:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:49:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:49:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:49:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:49:02 INFO - Intel Iris: 15:49:02 INFO - Chipset Model: Intel Iris 15:49:02 INFO - Type: GPU 15:49:02 INFO - Bus: Built-In 15:49:02 INFO - VRAM (Dynamic, Max): 1536 MB 15:49:02 INFO - Vendor: Intel (0x8086) 15:49:02 INFO - Device ID: 0x0a2e 15:49:02 INFO - Revision ID: 0x0009 15:49:02 INFO - Displays: 15:49:02 INFO - Display: 15:49:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:49:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:49:02 INFO - Display Serial Number: 1600x1200 60 15:49:02 INFO - Main Display: Yes 15:49:02 INFO - Mirror: Off 15:49:02 INFO - Online: Yes 15:49:02 INFO - Rotation: Supported 15:49:02 INFO - Return code: 0 15:49:02 INFO - Running post-action listener: _resource_record_post_action 15:49:02 INFO - Running post-run listener: _resource_record_post_run 15:49:03 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 34012672; Write bytes: 710437376; Read time: 356; Write time: 2053 15:49:03 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386761216; Write bytes: 380986880; Read time: 28775; Write time: 791 15:49:03 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 33091072; Write bytes: 304145408; Read time: 342; Write time: 1210 15:49:03 INFO - Running post-run listener: _upload_blobber_files 15:49:03 INFO - Blob upload gear active. 15:49:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:49:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:49:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:05 INFO - (blobuploader) - INFO - Done attempting. 15:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:06 INFO - (blobuploader) - INFO - Done attempting. 15:49:06 INFO - (blobuploader) - INFO - Iteration through files over. 15:49:06 INFO - Return code: 0 15:49:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:49:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:49:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d35926aa6cfed4d10080f4a092a5b5760bb24548ae6da970dfa5c127ea49ad952a6c498697173f818e03b0b8d875015e646da8debc1f8d322aa8448c5e86e4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21164a13656f7dca46a0453eeb7feae786b68792fc6078723daa7410d22a5d91f8b683e806ca37e3547c9246bfd03f0bfd62bcefbc52b79982c6f872e537efb9"} 15:49:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:49:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:49:06 INFO - Contents: 15:49:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d35926aa6cfed4d10080f4a092a5b5760bb24548ae6da970dfa5c127ea49ad952a6c498697173f818e03b0b8d875015e646da8debc1f8d322aa8448c5e86e4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21164a13656f7dca46a0453eeb7feae786b68792fc6078723daa7410d22a5d91f8b683e806ca37e3547c9246bfd03f0bfd62bcefbc52b79982c6f872e537efb9"} 15:49:06 INFO - Running post-run listener: copy_logs_to_upload_dir 15:49:06 INFO - Copying logs to upload dir... 15:49:06 INFO - mkdir: /builds/slave/test/build/upload/logs 15:49:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.372161 ========= master_lag: 3.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-29 15:49:10.253002) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-01-29 15:49:10.257789) ========= 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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d35926aa6cfed4d10080f4a092a5b5760bb24548ae6da970dfa5c127ea49ad952a6c498697173f818e03b0b8d875015e646da8debc1f8d322aa8448c5e86e4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21164a13656f7dca46a0453eeb7feae786b68792fc6078723daa7410d22a5d91f8b683e806ca37e3547c9246bfd03f0bfd62bcefbc52b79982c6f872e537efb9"} build_url:https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/UkWFoGspSmaNS8Qa3v31PQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d35926aa6cfed4d10080f4a092a5b5760bb24548ae6da970dfa5c127ea49ad952a6c498697173f818e03b0b8d875015e646da8debc1f8d322aa8448c5e86e4e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21164a13656f7dca46a0453eeb7feae786b68792fc6078723daa7410d22a5d91f8b683e806ca37e3547c9246bfd03f0bfd62bcefbc52b79982c6f872e537efb9"}' ========= master_lag: 1.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-01-29 15:49:11.292610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:49:11.292944) ========= 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.io1WdXCczJ/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.Vnd08Y7SAm/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005160 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:49:11.331350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 15:49:11.331639) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 15:49:11.335388) ========= ========= Total master_lag: 5.36 =========