builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0166 starttime: 1455835180.85 results: success (0) buildid: 20160218124425 builduid: 780042d85db04ec8b3728de924f704d9 revision: f9e4a56281d86c553b8cedd9cb86025813946ec0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.846035) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.846392) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.846681) ========= 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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005737 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.880705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.881003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.902946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:40.903217) ========= 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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005420 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.127188) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.127482) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.127853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.128151) ========= 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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-18 14:39:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-02-18 14:39:41 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.262237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.262768) ========= 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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.026772 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:41.313829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 14:39:41.314630) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9e4a56281d86c553b8cedd9cb86025813946ec0 --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 f9e4a56281d86c553b8cedd9cb86025813946ec0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-18 14:39:41,539 truncating revision to first 12 chars 2016-02-18 14:39:41,539 Setting DEBUG logging. 2016-02-18 14:39:41,539 attempt 1/10 2016-02-18 14:39:41,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9e4a56281d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 14:39:42,683 unpacking tar archive at: fx-team-f9e4a56281d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.723622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 14:39:43.060067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:43.060440) ========= echo f9e4a56281d86c553b8cedd9cb86025813946ec0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f9e4a56281d86c553b8cedd9cb86025813946ec0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 f9e4a56281d86c553b8cedd9cb86025813946ec0 program finished with exit code 0 elapsedTime=0.005258 script_repo_revision: 'f9e4a56281d86c553b8cedd9cb86025813946ec0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:43.113591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:43.113939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 14:39:43.126790) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-18 14:39:43.127097) ========= /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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:39:43 INFO - MultiFileLogger online at 20160218 14:39:43 in /builds/slave/test 14:39:43 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 14:39:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:43 INFO - {'append_to_log': False, 14:39:43 INFO - 'base_work_dir': '/builds/slave/test', 14:39:43 INFO - 'blob_upload_branch': 'Fx-Team', 14:39:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:43 INFO - 'branch': 'Fx-Team', 14:39:43 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:43 INFO - 'config_files': ('talos/mac_config.py',), 14:39:43 INFO - 'default_actions': ('clobber', 14:39:43 INFO - 'read-buildbot-config', 14:39:43 INFO - 'download-and-extract', 14:39:43 INFO - 'populate-webroot', 14:39:43 INFO - 'create-virtualenv', 14:39:43 INFO - 'install', 14:39:43 INFO - 'run-tests'), 14:39:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:43 INFO - 'download_minidump_stackwalk': True, 14:39:43 INFO - 'download_symbols': 'ondemand', 14:39:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:43 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:43 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:43 INFO - 'installer_path': 'installer.exe', 14:39:43 INFO - 'log_level': 'info', 14:39:43 INFO - 'log_name': 'talos', 14:39:43 INFO - 'log_to_console': True, 14:39:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:39:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:39:43 INFO - 'opt_config_files': (), 14:39:43 INFO - 'pip_index': False, 14:39:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:39:43 INFO - 'cmd': ('bash', 14:39:43 INFO - '-c', 14:39:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:39:43 INFO - 'enabled': True, 14:39:43 INFO - 'halt_on_failure': False, 14:39:43 INFO - 'name': 'check_screen_resolution'},), 14:39:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:39:43 INFO - 'cmd': ('bash', 14:39:43 INFO - '-c', 14:39:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:39:43 INFO - 'enabled': True, 14:39:43 INFO - 'halt_on_failure': False, 14:39:43 INFO - 'name': 'check_screen_resolution'},), 14:39:43 INFO - 'run_cmd_checks_enabled': True, 14:39:43 INFO - 'sps_profile': False, 14:39:43 INFO - 'sps_profile_interval': 0, 14:39:43 INFO - 'suite': 'dromaeojs-e10s', 14:39:43 INFO - 'system_bits': '32', 14:39:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:43 INFO - 'title': 't-yosemite-r7-0166', 14:39:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:43 INFO - 'use_talos_json': True, 14:39:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:43 INFO - 'work_dir': 'build'} 14:39:43 INFO - ##### 14:39:43 INFO - ##### Running clobber step. 14:39:43 INFO - ##### 14:39:43 INFO - Running pre-action listener: _resource_record_pre_action 14:39:43 INFO - Running main action method: clobber 14:39:43 INFO - rmtree: /builds/slave/test/build 14:39:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:45 INFO - Running post-action listener: _resource_record_post_action 14:39:45 INFO - ##### 14:39:45 INFO - ##### Running read-buildbot-config step. 14:39:45 INFO - ##### 14:39:45 INFO - Running pre-action listener: _resource_record_pre_action 14:39:45 INFO - Running main action method: read_buildbot_config 14:39:45 INFO - Using buildbot properties: 14:39:45 INFO - { 14:39:45 INFO - "project": "", 14:39:45 INFO - "product": "firefox", 14:39:45 INFO - "script_repo_revision": "production", 14:39:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:39:45 INFO - "repository": "", 14:39:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:39:45 INFO - "buildid": "20160218124425", 14:39:45 INFO - "pgo_build": "False", 14:39:45 INFO - "basedir": "/builds/slave/test", 14:39:45 INFO - "buildnumber": 459, 14:39:45 INFO - "slavename": "t-yosemite-r7-0166", 14:39:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:39:45 INFO - "platform": "yosemite_r7", 14:39:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:39:45 INFO - "branch": "fx-team", 14:39:45 INFO - "repo_path": "integration/fx-team", 14:39:45 INFO - "revision": "f9e4a56281d86c553b8cedd9cb86025813946ec0", 14:39:45 INFO - "stage_platform": "macosx64", 14:39:45 INFO - "builduid": "780042d85db04ec8b3728de924f704d9", 14:39:45 INFO - "slavebuilddir": "test" 14:39:45 INFO - } 14:39:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:39:45 INFO - Running post-action listener: _resource_record_post_action 14:39:45 INFO - ##### 14:39:45 INFO - ##### Running download-and-extract step. 14:39:45 INFO - ##### 14:39:45 INFO - Running pre-action listener: _resource_record_pre_action 14:39:45 INFO - Running main action method: download_and_extract 14:39:45 INFO - mkdir: /builds/slave/test/build/tests 14:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:45 INFO - https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:39:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/test_packages.json 14:39:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/test_packages.json 14:39:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:39:46 INFO - Downloaded 1277 bytes. 14:39:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:39:46 INFO - Using the following test package requirements: 14:39:46 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:39:46 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:39:46 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:39:46 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'jsshell-mac.zip'], 14:39:46 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:39:46 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:39:46 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:39:46 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:39:46 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:39:46 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:39:46 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:39:46 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:39:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:39:48 INFO - Downloaded 17807109 bytes. 14:39:48 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'] 14:39:48 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 14:39:51 INFO - Return code: 0 14:39:51 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 14:39: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')]} 14:39:51 INFO - https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:39:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:39:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:39:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:39:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:39:52 INFO - Downloaded 17807109 bytes. 14:39:52 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'] 14:39:52 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 14:39:56 INFO - Return code: 0 14:39:56 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')]} 14:39:56 INFO - https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:39:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:39:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:39:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:39:57 INFO - Downloaded 10707015 bytes. 14:39:57 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'] 14:39:57 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 14:39:57 INFO - Return code: 0 14:39:57 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')]} 14:39:57 INFO - https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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 14:40:00 INFO - Downloaded 111338299 bytes. 14:40:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:40:00 INFO - mkdir: /builds/slave/test/properties 14:40:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:40:00 INFO - Writing to file /builds/slave/test/properties/build_url 14:40:00 INFO - Contents: 14:40:00 INFO - build_url:https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:40:01 INFO - Running post-action listener: _resource_record_post_action 14:40:01 INFO - Running post-action listener: set_extra_try_arguments 14:40:01 INFO - ##### 14:40:01 INFO - ##### Running populate-webroot step. 14:40:01 INFO - ##### 14:40:01 INFO - Running pre-action listener: _resource_record_pre_action 14:40:01 INFO - Running main action method: populate_webroot 14:40:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:40:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:40:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:40:01 INFO - '--tppagecycles', 14:40:01 INFO - '7'], 14:40:01 INFO - 'tests': ['tsvgm']}}, 14:40:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:40:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:40:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:40:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:40:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:40:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:40:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'tests': ['damp', 'tps']}, 14:40:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['damp', 'tps']}, 14:40:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:40:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:40:01 INFO - 'other': {'tests': ['a11yr', 14:40:01 INFO - 'ts_paint', 14:40:01 INFO - 'tpaint', 14:40:01 INFO - 'sessionrestore', 14:40:01 INFO - 'sessionrestore_no_auto_restore']}, 14:40:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['a11yr', 14:40:01 INFO - 'ts_paint', 14:40:01 INFO - 'tpaint', 14:40:01 INFO - 'sessionrestore', 14:40:01 INFO - 'sessionrestore_no_auto_restore']}, 14:40:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['a11yr', 14:40:01 INFO - 'ts_paint', 14:40:01 INFO - 'tpaint', 14:40:01 INFO - 'sessionrestore', 14:40:01 INFO - 'sessionrestore_no_auto_restore']}, 14:40:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['a11yr', 14:40:01 INFO - 'ts_paint', 14:40:01 INFO - 'tpaint', 14:40:01 INFO - 'sessionrestore', 14:40:01 INFO - 'sessionrestore_no_auto_restore']}, 14:40:01 INFO - 'other_l64': {'tests': ['a11yr', 14:40:01 INFO - 'ts_paint', 14:40:01 INFO - 'tpaint', 14:40:01 INFO - 'sessionrestore', 14:40:01 INFO - 'sessionrestore_no_auto_restore']}, 14:40:01 INFO - 'other_nol64': {'tests': ['a11yr', 14:40:01 INFO - 'ts_paint', 14:40:01 INFO - 'tpaint', 14:40:01 INFO - 'sessionrestore', 14:40:01 INFO - 'sessionrestore_no_auto_restore']}, 14:40:01 INFO - 'svgr': {'tests': ['tsvgx', 14:40:01 INFO - 'tsvgr_opacity', 14:40:01 INFO - 'tart', 14:40:01 INFO - 'tscrollx', 14:40:01 INFO - 'cart']}, 14:40:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['tsvgx', 14:40:01 INFO - 'tsvgr_opacity', 14:40:01 INFO - 'tart', 14:40:01 INFO - 'tscrollx', 14:40:01 INFO - 'cart']}, 14:40:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'tests': ['tp5o']}, 14:40:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'talos_options': ['--e10s'], 14:40:01 INFO - 'tests': ['tp5o']}, 14:40:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'talos_options': ['--xperf_path', 14:40:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:40:01 INFO - 'tests': ['tp5n']}, 14:40:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:40:01 INFO - 'talos_options': ['--e10s', 14:40:01 INFO - '--xperf_path', 14:40:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:40:01 INFO - 'tests': ['tp5n']}}, 14:40:01 INFO - 'talos.zip': {'path': '', 14:40:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:40:01 INFO - Running post-action listener: _resource_record_post_action 14:40:01 INFO - ##### 14:40:01 INFO - ##### Running create-virtualenv step. 14:40:01 INFO - ##### 14:40:01 INFO - Running pre-action listener: _resource_record_pre_action 14:40:01 INFO - Running main action method: create_virtualenv 14:40:01 INFO - Creating virtualenv /builds/slave/test/build/venv 14:40:01 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 14:40:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:40:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:40:01 INFO - Using real prefix '/tools/python27' 14:40:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:40:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:40:04 INFO - Installing pip.................done. 14:40:04 INFO - Return code: 0 14:40:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:04 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 14:40:04 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 14:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:04 INFO - 'HOME': '/Users/cltbld', 14:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:04 INFO - 'LOGNAME': 'cltbld', 14:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:04 INFO - 'MOZ_NO_REMOTE': '1', 14:40:04 INFO - 'NO_EM_RESTART': '1', 14:40:04 INFO - 'PAGER': '/bin/cat', 14:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:04 INFO - 'PWD': '/builds/slave/test', 14:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:04 INFO - 'SHELL': '/bin/bash', 14:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:04 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:04 INFO - 'USER': 'cltbld', 14:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:04 INFO - 'XPC_FLAGS': '0x0', 14:40:04 INFO - 'XPC_SERVICE_NAME': '0', 14:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:05 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 14:40:05 INFO - Cleaning up... 14:40:05 INFO - Return code: 0 14:40:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:05 INFO - 'HOME': '/Users/cltbld', 14:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:05 INFO - 'LOGNAME': 'cltbld', 14:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:05 INFO - 'MOZ_NO_REMOTE': '1', 14:40:05 INFO - 'NO_EM_RESTART': '1', 14:40:05 INFO - 'PAGER': '/bin/cat', 14:40:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:05 INFO - 'PWD': '/builds/slave/test', 14:40:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:05 INFO - 'SHELL': '/bin/bash', 14:40:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:05 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:05 INFO - 'USER': 'cltbld', 14:40:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:05 INFO - 'XPC_FLAGS': '0x0', 14:40:05 INFO - 'XPC_SERVICE_NAME': '0', 14:40:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:05 INFO - Downloading/unpacking psutil>=0.7.1 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:40:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:08 INFO - Installing collected packages: psutil 14:40:08 INFO - Running setup.py install for psutil 14:40:08 INFO - building 'psutil._psutil_osx' extension 14:40:08 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 14:40:08 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 14:40:08 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 14:40:08 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 14:40:09 INFO - building 'psutil._psutil_posix' extension 14:40:09 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 14:40:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:40:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:40:09 INFO - ^ 14:40:09 INFO - 1 warning generated. 14:40:09 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 14:40:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:09 INFO - Successfully installed psutil 14:40:09 INFO - Cleaning up... 14:40:09 INFO - Return code: 0 14:40:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:09 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:09 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 14:40:09 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 14:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:09 INFO - 'HOME': '/Users/cltbld', 14:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:09 INFO - 'LOGNAME': 'cltbld', 14:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:09 INFO - 'MOZ_NO_REMOTE': '1', 14:40:09 INFO - 'NO_EM_RESTART': '1', 14:40:09 INFO - 'PAGER': '/bin/cat', 14:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:09 INFO - 'PWD': '/builds/slave/test', 14:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:09 INFO - 'SHELL': '/bin/bash', 14:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:09 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:09 INFO - 'USER': 'cltbld', 14:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:09 INFO - 'XPC_FLAGS': '0x0', 14:40:09 INFO - 'XPC_SERVICE_NAME': '0', 14:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:40:12 INFO - Installing collected packages: mozsystemmonitor 14:40:12 INFO - Running setup.py install for mozsystemmonitor 14:40:12 INFO - Successfully installed mozsystemmonitor 14:40:12 INFO - Cleaning up... 14:40:12 INFO - Return code: 0 14:40:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:12 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:12 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 14:40:12 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 14:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:12 INFO - 'HOME': '/Users/cltbld', 14:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:12 INFO - 'LOGNAME': 'cltbld', 14:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:12 INFO - 'MOZ_NO_REMOTE': '1', 14:40:12 INFO - 'NO_EM_RESTART': '1', 14:40:12 INFO - 'PAGER': '/bin/cat', 14:40:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:12 INFO - 'PWD': '/builds/slave/test', 14:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:12 INFO - 'SHELL': '/bin/bash', 14:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:12 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:12 INFO - 'USER': 'cltbld', 14:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:12 INFO - 'XPC_FLAGS': '0x0', 14:40:12 INFO - 'XPC_SERVICE_NAME': '0', 14:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:12 INFO - Downloading/unpacking blobuploader==1.2.4 14:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:14 INFO - Downloading blobuploader-1.2.4.tar.gz 14:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:40:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:40:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:40:15 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 14:40:15 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 14:40:15 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 14:40:15 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 14:40:15 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 14:40:15 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 14:40:15 INFO - Downloading docopt-0.6.1.tar.gz 14:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:40:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:40:16 INFO - Running setup.py install for blobuploader 14:40:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:40:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:40:16 INFO - Running setup.py install for requests 14:40:16 INFO - Running setup.py install for docopt 14:40:16 INFO - Successfully installed blobuploader requests docopt 14:40:16 INFO - Cleaning up... 14:40:16 INFO - Return code: 0 14:40:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:16 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')]} 14:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:16 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')]} 14:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:16 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:16 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 14:40:16 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 14:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:16 INFO - 'HOME': '/Users/cltbld', 14:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:16 INFO - 'LOGNAME': 'cltbld', 14:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:16 INFO - 'MOZ_NO_REMOTE': '1', 14:40:16 INFO - 'NO_EM_RESTART': '1', 14:40:16 INFO - 'PAGER': '/bin/cat', 14:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:16 INFO - 'PWD': '/builds/slave/test', 14:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:16 INFO - 'SHELL': '/bin/bash', 14:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:16 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:16 INFO - 'USER': 'cltbld', 14:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:16 INFO - 'XPC_FLAGS': '0x0', 14:40:16 INFO - 'XPC_SERVICE_NAME': '0', 14:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-dIVAG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-EO_hvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-LjpVyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-OWPBcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-kPuuwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-VlrNdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-FAtaGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:17 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-jw7Esr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Iwn5di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-v256YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-_C9Cq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-iglqwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-dPrO0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-uPQRNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-CpAU6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-_3lyEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:18 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-QWoVx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:40:18 INFO - Running setup.py install for manifestparser 14:40:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozcrash 14:40:19 INFO - Running setup.py install for mozdebug 14:40:19 INFO - Running setup.py install for mozdevice 14:40:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozfile 14:40:19 INFO - Running setup.py install for mozhttpd 14:40:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozinfo 14:40:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:40:19 INFO - Running setup.py install for mozInstall 14:40:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for mozleak 14:40:20 INFO - Running setup.py install for mozlog 14:40:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for moznetwork 14:40:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for mozprocess 14:40:20 INFO - Running setup.py install for mozprofile 14:40:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:40:20 INFO - Running setup.py install for mozrunner 14:40:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:40:21 INFO - Running setup.py install for mozscreenshot 14:40:21 INFO - Running setup.py install for moztest 14:40:21 INFO - Running setup.py install for mozversion 14:40:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:40:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:40:21 INFO - Cleaning up... 14:40:21 INFO - Return code: 0 14:40:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:21 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:21 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 14:40:21 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 14:40:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:21 INFO - 'HOME': '/Users/cltbld', 14:40:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:21 INFO - 'LOGNAME': 'cltbld', 14:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:21 INFO - 'MOZ_NO_REMOTE': '1', 14:40:21 INFO - 'NO_EM_RESTART': '1', 14:40:21 INFO - 'PAGER': '/bin/cat', 14:40:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:21 INFO - 'PWD': '/builds/slave/test', 14:40:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:21 INFO - 'SHELL': '/bin/bash', 14:40:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:21 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:21 INFO - 'USER': 'cltbld', 14:40:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:21 INFO - 'XPC_FLAGS': '0x0', 14:40:21 INFO - 'XPC_SERVICE_NAME': '0', 14:40:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:21 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ytTUqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:21 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)) 14:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:21 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-qpdaiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7qEVXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-vPpwmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-6K9P7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-vew8IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-PdPMy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7AGLiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-GBVj3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-6969i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-HzVwGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:22 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)) 14:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:22 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-vJvlme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:23 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)) 14:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:23 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-4B3ypr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:23 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)) 14:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:23 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-UEhhM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:23 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)) 14:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:23 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-1JQuEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:23 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)) 14:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:23 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9VB7ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:23 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)) 14:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:23 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-jpiWWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:23 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)) 14:40:23 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)) 14:40:23 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)) 14:40:23 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)) 14:40:23 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)) 14:40:23 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)) 14:40:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:23 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 14:40:23 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 14:40:23 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 14:40:23 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 14:40:23 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 14:40:23 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 14:40:25 INFO - Downloading blessings-1.6.tar.gz 14:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:26 INFO - Installing collected packages: blessings 14:40:26 INFO - Running setup.py install for blessings 14:40:26 INFO - Successfully installed blessings 14:40:26 INFO - Cleaning up... 14:40:26 INFO - Return code: 0 14:40:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:26 INFO - Reading from file tmpfile_stdout 14:40:26 INFO - Current package versions: 14:40:26 INFO - blessings == 1.6 14:40:26 INFO - blobuploader == 1.2.4 14:40:26 INFO - docopt == 0.6.1 14:40:26 INFO - manifestparser == 1.1 14:40:26 INFO - mozInstall == 1.12 14:40:26 INFO - mozcrash == 0.16 14:40:26 INFO - mozdebug == 0.1 14:40:26 INFO - mozdevice == 0.48 14:40:26 INFO - mozfile == 1.2 14:40:26 INFO - mozhttpd == 0.7 14:40:26 INFO - mozinfo == 0.9 14:40:26 INFO - mozleak == 0.1 14:40:26 INFO - mozlog == 3.1 14:40:26 INFO - moznetwork == 0.27 14:40:26 INFO - mozprocess == 0.22 14:40:26 INFO - mozprofile == 0.28 14:40:26 INFO - mozrunner == 6.11 14:40:26 INFO - mozscreenshot == 0.1 14:40:26 INFO - mozsystemmonitor == 0.0 14:40:26 INFO - moztest == 0.7 14:40:26 INFO - mozversion == 1.4 14:40:26 INFO - psutil == 3.1.1 14:40:26 INFO - requests == 1.2.3 14:40:26 INFO - wsgiref == 0.1.2 14:40:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:26 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:26 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 14:40:26 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 14:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:26 INFO - 'HOME': '/Users/cltbld', 14:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:26 INFO - 'LOGNAME': 'cltbld', 14:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:26 INFO - 'MOZ_NO_REMOTE': '1', 14:40:26 INFO - 'NO_EM_RESTART': '1', 14:40:26 INFO - 'PAGER': '/bin/cat', 14:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:26 INFO - 'PWD': '/builds/slave/test', 14:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:26 INFO - 'SHELL': '/bin/bash', 14:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:26 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:26 INFO - 'USER': 'cltbld', 14:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:26 INFO - 'XPC_FLAGS': '0x0', 14:40:26 INFO - 'XPC_SERVICE_NAME': '0', 14:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 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)) 14:40:26 INFO - Cleaning up... 14:40:26 INFO - Return code: 0 14:40:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40: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', 'jsonschema'] in /builds/slave/test/build 14:40: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 jsonschema 14:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:26 INFO - 'HOME': '/Users/cltbld', 14:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:26 INFO - 'LOGNAME': 'cltbld', 14:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:26 INFO - 'MOZ_NO_REMOTE': '1', 14:40:26 INFO - 'NO_EM_RESTART': '1', 14:40:26 INFO - 'PAGER': '/bin/cat', 14:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:26 INFO - 'PWD': '/builds/slave/test', 14:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:26 INFO - 'SHELL': '/bin/bash', 14:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:26 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:26 INFO - 'USER': 'cltbld', 14:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:26 INFO - 'XPC_FLAGS': '0x0', 14:40:26 INFO - 'XPC_SERVICE_NAME': '0', 14:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:27 INFO - Downloading/unpacking jsonschema 14:40:27 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 14:40:27 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 14:40:27 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 14:40:27 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 14:40:27 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 14:40:27 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 14:40:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:29 INFO - Downloading/unpacking functools32 (from jsonschema) 14:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:29 INFO - warning: no files found matching '*.txt' 14:40:29 INFO - no previously-included directories found matching 'build' 14:40:29 INFO - no previously-included directories found matching 'dist' 14:40:29 INFO - no previously-included directories found matching '.git*' 14:40:29 INFO - Installing collected packages: jsonschema, functools32 14:40:29 INFO - Running setup.py install for functools32 14:40:30 INFO - warning: no files found matching '*.txt' 14:40:30 INFO - no previously-included directories found matching 'build' 14:40:30 INFO - no previously-included directories found matching 'dist' 14:40:30 INFO - no previously-included directories found matching '.git*' 14:40:30 INFO - Successfully installed jsonschema functools32 14:40:30 INFO - Cleaning up... 14:40:30 INFO - Return code: 0 14:40:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:30 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 0x10ed13a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed1a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81455930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, '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.whZQxFIh6L/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.0vbAmhlO8V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 14:40:30 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 14:40:30 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 14:40:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:40:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:30 INFO - 'HOME': '/Users/cltbld', 14:40:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:30 INFO - 'LOGNAME': 'cltbld', 14:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:30 INFO - 'MOZ_NO_REMOTE': '1', 14:40:30 INFO - 'NO_EM_RESTART': '1', 14:40:30 INFO - 'PAGER': '/bin/cat', 14:40:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:30 INFO - 'PWD': '/builds/slave/test', 14:40:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:30 INFO - 'SHELL': '/bin/bash', 14:40:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:40:30 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:40:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:30 INFO - 'USER': 'cltbld', 14:40:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:30 INFO - 'XPC_FLAGS': '0x0', 14:40:30 INFO - 'XPC_SERVICE_NAME': '0', 14:40:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:30 INFO - Downloading/unpacking flake8 14:40:30 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 14:40:30 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 14:40:30 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 14:40:30 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 14:40:30 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 14:40:30 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 14:40:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:40:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:40:32 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 14:40:32 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 14:40:32 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 14:40:32 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 14:40:32 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 14:40:32 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 14:40:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:40:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:40:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:33 INFO - no previously-included directories found matching 'docs/_build' 14:40:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:40:34 INFO - Running setup.py install for pep8 14:40:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:34 INFO - no previously-included directories found matching 'docs/_build' 14:40:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:40:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:40:34 INFO - Cleaning up... 14:40:34 INFO - Return code: 0 14:40:34 INFO - Running post-action listener: _resource_record_post_action 14:40:34 INFO - Running post-action listener: _start_resource_monitoring 14:40:34 INFO - Starting resource monitoring. 14:40:34 INFO - ##### 14:40:34 INFO - ##### Running install step. 14:40:34 INFO - ##### 14:40:34 INFO - Running pre-action listener: _resource_record_pre_action 14:40:34 INFO - Running main action method: install 14:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:34 INFO - Reading from file tmpfile_stdout 14:40:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:34 INFO - Reading from file tmpfile_stdout 14:40:34 INFO - Output received: 14:40:34 INFO - Usage: mozinstall [options] installer 14:40:34 INFO - Options: 14:40:34 INFO - -h, --help show this help message and exit 14:40:34 INFO - -d DEST, --destination=DEST 14:40:34 INFO - Directory to install application into. [default: 14:40:34 INFO - "/builds/slave/test"] 14:40:34 INFO - --app=APP Application being installed. [default: firefox] 14:40:34 INFO - mkdir: /builds/slave/test/build/application 14:40:34 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'] 14:40:34 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 14:41:09 INFO - Reading from file tmpfile_stdout 14:41:09 INFO - Output received: 14:41:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:41:09 INFO - Running post-action listener: _resource_record_post_action 14:41:09 INFO - ##### 14:41:09 INFO - ##### Running run-tests step. 14:41:09 INFO - ##### 14:41:09 INFO - Running pre-action listener: _resource_record_pre_action 14:41:09 INFO - Running main action method: run_tests 14:41:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:09 INFO - 2016-02-18 14:41:09.762 screenresolution[1882:8684] starting screenresolution argv=screenresolution get 14:41:09 INFO - 2016-02-18 14:41:09.765 screenresolution[1882:8684] Display 0: 1600x1200x32@60 14:41:09 INFO - 2016-02-18 14:41:09.771 screenresolution[1883:8686] starting screenresolution argv=screenresolution list 14:41:09 INFO - Available Modes on Display 0 14:41:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:09 INFO - Intel Iris: 14:41:09 INFO - Chipset Model: Intel Iris 14:41:09 INFO - Type: GPU 14:41:09 INFO - Bus: Built-In 14:41:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:09 INFO - Vendor: Intel (0x8086) 14:41:09 INFO - Device ID: 0x0a2e 14:41:09 INFO - Revision ID: 0x0009 14:41:09 INFO - Displays: 14:41:10 INFO - Display: 14:41:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:10 INFO - Display Serial Number: 1600x1200 60 14:41:10 INFO - Main Display: Yes 14:41:10 INFO - Mirror: Off 14:41:10 INFO - Online: Yes 14:41:10 INFO - Rotation: Supported 14:41:10 INFO - Return code: 0 14:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:41:10 INFO - Python 2.7.3 14:41:10 INFO - Return code: 0 14:41:10 INFO - grabbing minidump binary from tooltool 14:41:10 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')]} 14:41:10 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 0x10ebb7d30>, '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 0x10e9dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebaeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:41:10 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 14:41:10 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 14:41:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:41:10 INFO - Return code: 0 14:41:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:41:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:41:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:41:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:41:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:41:11 INFO - Return code: 0 14:41:11 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/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--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 14:41:11 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/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --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 14:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.whZQxFIh6L/Render', 14:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:11 INFO - 'HOME': '/Users/cltbld', 14:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:11 INFO - 'LOGNAME': 'cltbld', 14:41:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:41:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:11 INFO - 'MOZ_NO_REMOTE': '1', 14:41:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:41:11 INFO - 'NO_EM_RESTART': '1', 14:41:11 INFO - 'PAGER': '/bin/cat', 14:41:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:11 INFO - 'PWD': '/builds/slave/test', 14:41:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:11 INFO - 'SHELL': '/bin/bash', 14:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0vbAmhlO8V/Listeners', 14:41:11 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 14:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:11 INFO - 'USER': 'cltbld', 14:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:11 INFO - 'XPC_FLAGS': '0x0', 14:41:11 INFO - 'XPC_SERVICE_NAME': '0', 14:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:41:11 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/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--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 14:41:11 INFO - mozversion application_buildid: 20160218124425 14:41:11 INFO - mozversion application_changeset: f9e4a56281d86c553b8cedd9cb86025813946ec0 14:41:11 INFO - mozversion application_display_name: Nightly 14:41:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:41:11 INFO - mozversion application_name: Firefox 14:41:11 INFO - mozversion application_remotingname: firefox 14:41:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:41:11 INFO - mozversion application_vendor: Mozilla 14:41:11 INFO - mozversion application_version: 47.0a1 14:41:11 INFO - mozversion platform_buildid: 20160218124425 14:41:11 INFO - mozversion platform_changeset: f9e4a56281d86c553b8cedd9cb86025813946ec0 14:41:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:41:11 INFO - mozversion platform_version: 47.0a1 14:41:11 INFO - using testdate: 1455835271 14:41:11 INFO - actual date: 1455835271 14:41:11 INFO - starting webserver on 'localhost:49281' 14:41:11 INFO - SUITE-START | Running 2 tests 14:41:11 INFO - TEST-START | dromaeo_css 14:41:11 INFO - operating with platform_type : mac_ 14:41:11 INFO - Initialising browser for dromaeo_css test... 14:41:11 INFO - TEST-INFO | started process 1901 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpFrweYd/profile http://localhost:49281/getInfo.html) 14:41:14 INFO - PROCESS | 1901 | __metrics Screen width/height:1600/1200 14:41:14 INFO - PROCESS | 1901 | colorDepth:24 14:41:14 INFO - PROCESS | 1901 | Browser inner width/height: 1024/689 14:41:14 INFO - PROCESS | 1901 | __metrics 14:41:14 ERROR - PROCESS | 1901 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 14:41:15 INFO - TEST-INFO | 1901: exit 0 14:41:15 INFO - Browser initialized. 14:41:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:41:15 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpFrweYd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:27 INFO - PROCESS | 1906 | RSS: Main: 255209472 14:41:27 INFO - PROCESS | 1906 | 14:42:17 INFO - PROCESS | 1906 | 1455835337137 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] 14:44:27 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 14:44:29 INFO - PROCESS | 1906 | RSS: Main: 270131200 14:44:29 INFO - PROCESS | 1906 | 14:47:31 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 14:47:32 INFO - PROCESS | 1906 | RSS: Main: 281759744 14:47:32 INFO - PROCESS | 1906 | 14:50:34 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 14:50:34 INFO - PROCESS | 1906 | RSS: Main: 282255360 14:50:34 INFO - PROCESS | 1906 | 14:53:36 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 14:53:37 INFO - PROCESS | 1906 | RSS: Main: 284221440 14:53:37 INFO - PROCESS | 1906 | 14:56:39 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 14:56:40 INFO - PROCESS | 1906 | RSS: Main: 287985664 14:56:40 INFO - PROCESS | 1906 | 14:59:42 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 14:59:43 INFO - PROCESS | 1906 | RSS: Main: 289312768 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | __start_tp_report 14:59:43 INFO - PROCESS | 1906 | _x_x_mozilla_page_load 14:59:43 INFO - PROCESS | 1906 | _x_x_mozilla_page_load_details 14:59:43 INFO - PROCESS | 1906 | |i|pagename|runs| 14:59:43 INFO - PROCESS | 1906 | |0;dojo.html;3502.054445299769;3515.964840351597;3550.3786837303496;3575.1777091269;3578.7494875358734;4696.577308042271;5649.774009039644;5749.310082790061;5794.3626201117895;5797.884042319156;4752.833650822222;5731.398203188668;5828.504577110951;5861.912071318934;5872.060470324749;5164.483551644824;5219.582433405319;5308.23030660554;5381.865453363658;5422.945770542284;4896.828610998616;5162.870928226786;5284.44513326101;5328.733563321838;5361.624686271963;5187.4034486034025;5219.582433405357;5228.163493841005;5265.289185959885;5268.420473747885;5233.267342572043;5237.502437268454;5277.340332458442;5279.234510995884;5290.047791397586;5126.512981266774;5166.276721259027;5228.843134705965;5275.314209152824;5284.07528682479;5016.197408414636;5369.355677318707;5677.261955945742;5685.204071430003;5740.512056475163;6197.03945888388;6220.533459990519;6230.158928544633;6233.844153896143;6234.1583886175695;6109.040306147832;6132.110769107974;6170.167027451282;6192.566520343577;6198.132261483396;4961.875953101166;5850.76596936122;5896.675682837442;5896.911546326808;5912.852178695567;6144.941444616014;6206.131141640174;6272.843178920563;6279.277883043508;6280.497560195174;6134.018557030854;6154.846128846814;6163.7842675506145;6185.597936134137;6194.5973511721595;6157.107219453154;6181.258249010148;6192.071189321638;6192.969035154795;6202.4417802398;6032.969835150796;6117.4620395853735;6144.740328232701;6178.7219575119225;6218;6164.291106522807;6187.535934804908;6189.473894718999;6190.133381326618;6234.5635805494085;4761.714297142183;4816.783244753994;4886.267059941038;4888.340074090023;4895.216765317532;3778.771899132738;4014.578469260744;4412.382266482695;4424.579664931826;4454.732716037048;4802.423709154924;5687.488126068673;5778.451047150598;5779.653220806765;5792.710364481759;6168.9691551541955;6182.010878259457;6186.845328866814;6200.968995154995;6212.1303017577575;5561.193626924073;5678.772849086073;5777.422257774189;5797.36229014808;5849.590528662953;5359.732013399314;5372.785088596413;5377.892442151135;5379.67721936685;5398.730063496888;6325.778597749057;6339.461145802658;6351.2696039956;6355.841103972438;6358.872822543616;6055.394460553909;6079.3008803988105;6111.227117700271;6131.315499379051;6142.498775697809;6354.23749150105;6364.809055728336;6371.299157092809;6381.29805721361;6415.005674120519;6018.759249630141;6131.908021379593;6137.140800288053;6137.9693101535995;6152.938470615416;6096.889554637438;6166.013437849922;6173.228346456693;6176.7838125665385;6179.104029915727;5252.369715634149;5277;6059.424354686298;6069.246435845284;6095.603785753912;5963.165156877953;6025.548083893813;6040.456358927718;6087.482563981934;6095.817125486243;5838.4453476919625;5856;5874.94125058744;5945.137954996588;5989.550783691154;6024.33732289439;6048.788292409745;6075.605085669417;6075.939240607714;6100.969495152496;5014.52362025607;5932.614380065282;5937.614055086406;5944.227250457413;5946.554008449297 14:59:43 INFO - PROCESS | 1906 | |1;ext.html;469.1836205003293;496.8795366448659;514.3647595219903;571.1318795430946;595.9332794298207;37288.06779830502;37845.62154378452;38012.42981355275;38084.80957595208;38193.42709859354;39376.60623393765;39830;39871.40192897102;39926.201475970534;39941.60058399415;8406.327493800482;9291.953540232305;9440.055994400574;9509;9530.285228607847;9281.72154835356;9439.716808495721;9464.763380915463;9478.241740660731;9516.71449856502;9494.477803720827;9537.904620953806;9576.952115239414;9577.233821294314;9611.759706007371;9472.621095156186;9509.286803489766;9529;9549.47477888716;9580.233581313478;9555.092266234697;9628;9643.373180743229;9662;9711.028897110233;36491.4526282106;36517.81741091304;36626;36843.81578092119;36854.63145368539;2780.805343625947;3135.749140068789;3151.401233765577;3176.28533579945;3233.304839459504;28636.570451443244;28706.569401458994;28740.281492962633;29100.563491547644;29387.11838644844;2757.820741651786;2811.9156425307274;2812.70466601006;2836.9007084752143;2957.1128661401494;464168;468810;470767;471897;475098;55621.72189139109;64845.67577162084;65224;65283.34716652868;65340;61510;61708;61783.073253901224;62060.75878482495;62120;15937.681246375008;15964.36142554308;16067.196640167946;16264.18679066042;16345.937514061548;12427;12495.375231238584;12638.2417054977;12707.87292127067;12716;19602.411927642195;19996.60006799856;20428.897855510626;20430.08064637095;20604.27885024047;7280.6723697433745;8045.345036138177;8208.753737387888;8219.876701849476;8267.669293228204;919.9632014719471;929.2798081486902;939.7462685074992;1030.2324768047852;1032;29575.408491830472;29651.110466686034;29859.552106718416;30340.54489182664;30464;897.3673560140086;1013.3210748798175;1014.7260239735377;1017.5726194998118;1043.9895601043893;12280.815787763191;14082.71834563303;14565.708685826225;14835.629109272139;15280.388784448498;476248;494104.5884311738;533798;538353;539513.3024334853;48974.51025489771;54718.726406367714;55942.44057559453;56292.43707562954;56641.716791415776;1238.5479300055595;1346.1317450244537;1348.7235116801032;1374.714641809911;1410.4005797536006;28727.856360718062;28867;29295.560566591943;29466.852665736533;29687;50367.24449133339;50754.238686419;51037.48962510328;51124;51273.743631281606;434466.82766585966;508139;509870;510208;510209;32250.709971601813;32870.506942396365;33692.49461258132;33699;33785.986420407426;40384.59615403808;40710.389344159266;41608.16783664249;42025;42613;35427.468587971714;35451.64548354483;36780.44829327616;36976.63023369732;37122;28600;32372;33960.490592641625;34233.657663423044;34555.48166777551;33587.83206083954;33829.83085084559;35980.640193598774;36823.63176368309;37081;29819.552706708982;31085.53371699381;31419.214519637193;31507.054788356385;31523.684763152076;24043.51912961696;24043.879780600986;24145.637815433132;24477.87761061183;24561.75438245666 14:59:43 INFO - PROCESS | 1906 | |2;jquery.html;343.09080935520876;352.6403068869753;359.80570491934355;366.1687968311934;366.2766037076774;15829.60425989348;19197.46420286377;19649.803501964976;20120.09459574319;21341.893290533546;19479.513012174702;19719.70420443691;19952.800471995277;20095.397138085846;20106.497337566532;5435.537979271757;5486.835394938138;5679.233303504016;5749.913751293734;5754.424557544233;4912.533309335608;5613.831585052434;5683.175939488771;5686.346070201917;5692.203091567184;4058.553559108496;5483.8080667176655;5661.745221465023;5663.688497132656;6023.759049638009;6188.566800323979;6215.782447614334;6227.96886015567;6247.9687601562155;6267.905981410283;5258.395284542288;5399.595030372738;5410.810621628224;5423.7830486780485;5478.506934375885;16027.679446411123;21472.677909831364;24186;24323.635145472832;24459.755402445924;2095.559932414195;2180.5202855371795;2210.071769856664;2435.330284171849;2562.0264299566234;9307.813843723156;9323.580438880266;9541.666041688508;9885.555150018194;9987;1746.4585978346754;1748.6327871147075;1778.4042345814169;1789.4810504953548;1827;92577;93642;93987;98658.56392119733;99494;9307.76730581741;9928.858181309097;10779.191560632984;10999.945000275107;11224.698936717954;11325.320480771015;13258.939284857188;13359.332033398292;13390.732185356239;13398.196108233342;7055.329743674342;7633.198514156044;7859.214078592209;8448.408611397266;8471.941007374078;8519.190676885686;8576.185262400062;8586.914130858737;8621.827563448696;8627.396082274307;4377.8248870044845;4413.117376524708;4455.4876189238;4458.130664520452;4502.649205238416;1637.7215873301568;1656.2712406541084;1877.5400026993475;1881.6236752649525;1881.6801143805585;392.7937832637888;396.6192455242999;407.3177427808409;415.2981461330342;420.51220584122274;11425.751064402548;11816.113791465503;11846.644600661994;11970.281783093042;12103.939480302719;442.33870363805676;450.3110241330769;455.0875494633239;465.58795466012145;465.8695565241738;6036.728347224385;6205.441510264008;6226.439620434092;6281.96859015702;6298.559100862895;611829;616257;618175.9091204605;641758.7472375836;658233;105440;112737;113050.43474782738;114202.4289878562;118453;447.78506316968037;451.3590701204298;454.8135264541522;458.26677316293666;459.24912767624505;11313.434328283718;11361.261518001304;11437.771244575228;11439.256448330832;11484.023857972166;49294;49717.75141124271;50395.74802125966;50618;51197;63848;63905.36094638994;64038.67980660067;64265.67867160634;69703;7728.652210650422;8015.559144246889;8016.679332826621;8038.196180381915;8079.87880181786;8528.914710852812;8845.336599754915;12138.878611214128;12576.182548134342;12792.424340904869;7755.2244775521995;7819.609019549113;7902;7920.5247685139075;8084.63619137152;7781.26078022587;7998.5600791957;8038;8244.381671374551;8311;7783.027121609799;7947.284744372803;8289.95855020721;8392.4544904581;8399.160083991796;11165.385903775046;11451.25566838153;11462.369569673749;11562.190646654653;11812.763744724885;11300.434978251218;11340.6030788922;11469.598564050551;11562.94218528902;11571.132165087483 14:59:43 INFO - PROCESS | 1906 | |3;mootools.html;1407.6551244944988;1531.6706908014778;1739.913004349782;1872.9344472943449;1898.7816401113876;7753.418493612973;8396.412251142423;8543.188397102273;8686.739397818059;8736.301095912328;8433.78915527112;8441.831163376728;8569.228769410753;8574.785630359243;8588.570571471433;2443.6456713776493;2449.8775061246956;2450.3996520852415;2453.6196889482158;2460.803135749136;2348.072511358021;2407.1935901473025;2412.0592968742203;2423.6970378702663;2431.7932975697;2141.0472339808794;2334.5564342774906;2353.8116950643994;2404.615261558151;2466.5930121529927;2405.7129435751963;2414.782669559739;2443.8289319747623;2461.3354394313524;2464.7042354917344;2358.516504116652;2359.9410014749596;2360.138549429463;2366.7514910934447;2367.857928524294;8132.227438393344;8508.361872859561;8548.358873084544;8554.443961142506;8568.528730919797;5265.394479634852;5440.265564148829;5442.891142177174;5446.400895901447;5458.2904222451225;3087.4596945534668;3543.539339885798;3556.697680697144;3660.4692319613773;3660.7254455915913;1035.6219979707428;1047.9782212342905;1051.3796859852648;1077.9245452818307;1094.9488491048523;9904.504774761304;11751.941240293743;11782.882171178264;11797.469113889896;11809.586664466702;4797.304390863305;4835.492273311322;4857.149998750205;4894.681845680019;4917.729524876167;10089.394636321844;10090.445025523666;10131.949340253252;10157.238207134495;10160.542775575117;5456.208849716769;5468.6171967962655;5469.042917489423;5481.890362192734;5509.118541033416;4952.628552858478;4972.676776009548;4974.701517908937;5001.724905130252;5006.949930500721;3913.804309784556;3968.2460332536725;3995.760254384746;3996.740211886276;4004.4794176756836;1193.2721040165493;1307.4116647508658;1308.6924572725402;1310.33173081729;1327.887129593976;1026.2610920137488;1039.6101461951769;1051.8264486359817;1111.183280288987;1271.9236845789283;7850.528968261922;7860.606969651494;7900.68397264103;7949.443538952218;7957.244061814118;1182.6392950150287;1184.673166054025;1190.4940400329824;1196.6230637349206;1207.7524107557929;5581.772010157759;5842.766289348378;6096.298925623521;6156.6921653918025;6161.383861613803;10176.236782241362;10821.621243256448;10909.39998300101;10933.28933619328;10934.56261749521;10381.532831022621;10704.983026612459;10721.410322432184;10754.193435492212;10778.02997730208;8216.958915205385;8262.83474330522;8314.916850831536;8358.958205208935;8380.20388063133;7805.258500442449;7815.921840781747;7861.174576669596;7871.606419678878;8021.398395120506;9295.67465138717;9302.44185348854;9467;9495.952520237355;9504.95247523758;9589.520523973913;9597.376170548892;9721.027897210506;9778.804423911339;9832.852507212541;6706.798796036127;7177.533460325062;7337.523061001018;7447.292507211806;7449.851002979802;7950.920490795018;7974.760757177294;8006.959965200137;8017.478863873829;8038.39712021589;7404.777856664308;7413.629318533944;7437.702491900263;7512.812179695551;7538.547687138789;6497.18785151856;7031.894521582078;7118.9644051779405;7153.82115447118;7206.747763828241;7435.665395057127;7507.324340809353;7578.166401695698;7584;7590.7722768317035;5883.235179426647;6881.13985751781;6887.862242755217;6916.965415172892;6929.82675433098;6967.1291088613925;6978.127734033246;7032.26161253061;7040.5071644984355;7062.470314726519 14:59:43 INFO - PROCESS | 1906 | |4;prototype.html;323.8720705321398;325.6320357995466;326.59828411054417;333.4597951318864;336.441507098217;5039.82360617378;5991.730372133254;6779.830504237397;6780.55926364786;6871.690773915186;6857.348551887562;6964.408025317842;6980.127484064492;6991.720331186746;7014.614196219206;5166.948330516703;5171.508706672869;5172.560332371734;5182.714950677711;5208.218767184915;4001.6998725095586;5135.948640513603;5174.818881339153;5175.87060323493;5187.922181167267;4922.187839006559;4934.6299027572895;4939.012197560484;4943.505649435064;4952.87617809554;4098.938515922278;4928.26076088586;4930.876728081808;4938.2098864181735;4949.168807541197;4173.08192197716;4181.979090104561;4184.058586817941;4194.203101410722;4196.81114349855;5483.643563168382;5483.698396588186;6516.478681705452;6565.770198043046;6611.3058128896255;4996.925046124311;5860.882782344372;5863.208466856962;5869.148973398833;5891.086881533369;7351.779446616557;7365.594892280922;7369.410447164214;7376.741814036536;7395.445341599401;4459.598636122764;4564.360989461478;4640.86077417678;4670.392848929651;4704.764761761899;7615.200403957616;7750.263724946121;7805.336546393563;7813.374930005642;7834.294913457816;4734.550217729379;4745.572898439088;4749.786259618326;4755.690880092783;4769.451513075971;4732.834350797705;4828.348172996671;4845.854624361275;4848.10310092634;4856.101621200019;5808.506276966421;5820.767169313265;5830.679312637845;5830.766769329264;5848.181254624356;7366.968624392589;7373.926260737324;7377.26227377258;7388.1503627083575;7434.591097489581;1654.6856097341708;1684.3178512702375;1705.7782488276446;1709.1539687854593;1712.4006597690957;1065.4459680966008;1077.9407132607625;1083.8916108389099;1085.696005118568;1089.5696200000955;6992.580445173306;7005.789826305219;7017.3684368407085;7023.192332881784;7040.295970402919;7889;7899.210078992055;7906.209379062163;7915.485493442908;7916.960415197887;6791.320867913169;6987.545809522365;6989.266127056688;7023.683934222972;7027.262137475492;4130.958690413057;4151.958480415217;4162;4165.042040330681;4174.998000479924;8286.922700048955;8289.502629842109;8305.916940830635;8310.958445207856;8322.66709331632;7970.601469926481;8135.471194372347;8179.263866252066;8187.754367368989;8214.63034163464;8268.751937441886;8276.710315138942;8285.95857020723;8299.128591497927;8328.583570821434;7514.098308203051;7696.7306144284685;7894.21057894206;7904.091029531677;7919.970403847463;7565.4325925556905;7633.809154771176;7635.312821846061;7646.738288182388;7650.426218033781;6623.834404139935;8085.43401961857;8089.433739638404;8100.149484304063;8101.311388531805;4646.8141274348645;4823.589994850477;4836.105320515716;4843.39457567804;4851.442084160367;6293.653849038347;7613;7749.225077492206;7765.378769698297;7768.184340644151;5996;7466.77599671989;7469.477136600386;7469.88795168062;7489.138749043712;7420.961065450949;7428.294312040348;7441.255874412515;7442.665080071301;7469.029026226556;6020.759169633166;6413.390727880844;6946.756863509753;7281.745138920112;7349.706011759684;7254.782356529313;7452.397734487111;7470.4023678106705;7471.813204669927;7482.551046937201;6039.758409663565;7212;7232.421406287379;7289.817754556178;7301.488895777245 14:59:43 INFO - PROCESS | 1906 | |5;yui.html;689.2383915773072;744.0550500863903;749.5277974875827;760.7451503746245;762.973295934642;14955.55133346;15049.92475037626;15154;15157.166355850424;15181.772273415894;15773.132477713722;16014.759778603331;16016.35934562619;16017.839821601781;16044.679106417865;696.1124566178113;850.3324889961351;852.0669866496177;859.6819176904554;877.7410663854147;854.4702284583567;857.2456238510102;857.5197889182078;866.2247288676631;868.722008957134;900.6622516556291;918.0223062438482;918.0589895357278;922.0088404964656;922.0917396364609;905.9094090590921;909.1999040844081;909.8134882349169;910.1353713971753;910.194477887068;579.7738881836087;665.9267480577132;668.2949488289852;668.4017804065383;670.4267850987433;15391.538253852403;15446.150461724601;15450.845491545166;15491.457798976982;15533.456329028542;12544.059195560278;12682.74634507314;12748.872511274862;12971.67570810728;13114.672133196651;9949.502524873727;10146.188304935662;10194.949025254826;10572.15422766177;10892.564297428093;3397.303552771676;3427.4516077427493;3456.0495863637448;3517.402041652925;3624.691901188402;82007.3598528026;83614.58192709058;83862;86062.56968715116;86495.99999999937;9316.813663726687;9398.67104651334;9566.661844592814;9636.662716804878;9939.304248702521;20940.58118837615;21060.578788424147;21065.473363166042;21086.789132108483;21090.683639745417;7237.819054523679;7305;7369.078865141857;7582.317591416799;7720;3978.124812541236;4063.959360406417;4070.4163173793595;4074.0336209550073;4120.793960301973;3417.2823707021803;3447.413939630269;3481.060113769268;3495.615482296945;3501.2122272488486;632;635.0569404434411;650.1385663995226;651.1990251989984;652.2075678051191;583.4282403244844;587.224863180606;619.1610367951452;628;629.1109487032561;6731.966340168267;8346.290565301895;8568.52873091986;8706.303495720327;8727.258183054384;449.91901457737265;594.2186025376616;603.4207161125281;617.2346290599714;637.8341631175834;3794.8213602745977;3953.6441720245316;4074.898127546776;4147.797138829766;4161;95017;96541;96687.51656241814;96764.06471870524;98808.01191988132;82979;83259.5837020811;83987;86334.70497942535;87131;73911.26088739044;74325.62837185779;74453.627731861;75251.87122193171;76545.61727191329;8326;8577.614007369808;8636.26591739684;8835.823283534164;8860.113988601088;48387.370947178395;49174;49598.50401495939;50005;51272;65039.349606505224;73820;74037.14907127366;74143.62928185324;74578.88131677921;11087.944560277147;11525.308481491138;11588.710282243012;11664.183507154417;12020.929430637472;12183.269003859798;12228.266304021787;12410.193337433038;12438.875611243771;12709.555165569162;11771.11716621274;11800.76398472043;11824.586139485076;12009.459574319002;12068.698282542655;10171.796564068825;11536.307821530734;11774.646760597196;11838.763224735629;11998.280103193836;10900.881101276811;11407.372594507382;11498.02956154006;11600;11673.533058677558;8207.425480216327;9649.517524123625;9658.661946831828;9733.249670205925;9871.012898710358;9933.155681766842;10169.237307202138;10196.4391958443;10197.54111064989;10206.387616743019 14:59:43 INFO - PROCESS | 1906 | __end_tp_report 14:59:43 INFO - PROCESS | 1906 | __start_cc_report 14:59:43 INFO - PROCESS | 1906 | _x_x_mozilla_cycle_collect,359 14:59:43 INFO - PROCESS | 1906 | __end_cc_report 14:59:43 INFO - PROCESS | 1906 | __startTimestamp1455836383070__endTimestamp 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | ------- Summary: start ------- 14:59:43 INFO - PROCESS | 1906 | Number of tests: 6 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | [#0] dojo.html Cycles:165 Average:5696.00 Median:5937.61 stddev:644.09 (10.8%) stddev-sans-first:622.64 14:59:43 INFO - PROCESS | 1906 | Values: 3502.1 3516.0 3550.4 3575.2 3578.7 4696.6 5649.8 5749.3 5794.4 5797.9 4752.8 5731.4 5828.5 5861.9 5872.1 5164.5 5219.6 5308.2 5381.9 5422.9 4896.8 5162.9 5284.4 5328.7 5361.6 5187.4 5219.6 5228.2 5265.3 5268.4 5233.3 5237.5 5277.3 5279.2 5290.0 5126.5 5166.3 5228.8 5275.3 5284.1 5016.2 5369.4 5677.3 5685.2 5740.5 6197.0 6220.5 6230.2 6233.8 6234.2 6109.0 6132.1 6170.2 6192.6 6198.1 4961.9 5850.8 5896.7 5896.9 5912.9 6144.9 6206.1 6272.8 6279.3 6280.5 6134.0 6154.8 6163.8 6185.6 6194.6 6157.1 6181.3 6192.1 6193.0 6202.4 6033.0 6117.5 6144.7 6178.7 6218.0 6164.3 6187.5 6189.5 6190.1 6234.6 4761.7 4816.8 4886.3 4888.3 4895.2 3778.8 4014.6 4412.4 4424.6 4454.7 4802.4 5687.5 5778.5 5779.7 5792.7 6169.0 6182.0 6186.8 6201.0 6212.1 5561.2 5678.8 5777.4 5797.4 5849.6 5359.7 5372.8 5377.9 5379.7 5398.7 6325.8 6339.5 6351.3 6355.8 6358.9 6055.4 6079.3 6111.2 6131.3 6142.5 6354.2 6364.8 6371.3 6381.3 6415.0 6018.8 6131.9 6137.1 6138.0 6152.9 6096.9 6166.0 6173.2 6176.8 6179.1 5252.4 5277.0 6059.4 6069.2 6095.6 5963.2 6025.5 6040.5 6087.5 6095.8 5838.4 5856.0 5874.9 5945.1 5989.6 6024.3 6048.8 6075.6 6075.9 6101.0 5014.5 5932.6 5937.6 5944.2 5946.6 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | [#1] ext.html Cycles:180 Average:63250.46 Median:37205.03 stddev:131585.63 (353.7%) stddev-sans-first:131870.33 14:59:43 INFO - PROCESS | 1906 | Values: 469.2 496.9 514.4 571.1 595.9 37288.1 37845.6 38012.4 38084.8 38193.4 39376.6 39830.0 39871.4 39926.2 39941.6 8406.3 9292.0 9440.1 9509.0 9530.3 9281.7 9439.7 9464.8 9478.2 9516.7 9494.5 9537.9 9577.0 9577.2 9611.8 9472.6 9509.3 9529.0 9549.5 9580.2 9555.1 9628.0 9643.4 9662.0 9711.0 36491.5 36517.8 36626.0 36843.8 36854.6 2780.8 3135.7 3151.4 3176.3 3233.3 28636.6 28706.6 28740.3 29100.6 29387.1 2757.8 2811.9 2812.7 2836.9 2957.1 464168.0 468810.0 470767.0 471897.0 475098.0 55621.7 64845.7 65224.0 65283.3 65340.0 61510.0 61708.0 61783.1 62060.8 62120.0 15937.7 15964.4 16067.2 16264.2 16345.9 12427.0 12495.4 12638.2 12707.9 12716.0 19602.4 19996.6 20428.9 20430.1 20604.3 7280.7 8045.3 8208.8 8219.9 8267.7 920.0 929.3 939.7 1030.2 1032.0 29575.4 29651.1 29859.6 30340.5 30464.0 897.4 1013.3 1014.7 1017.6 1044.0 12280.8 14082.7 14565.7 14835.6 15280.4 476248.0 494104.6 533798.0 538353.0 539513.3 48974.5 54718.7 55942.4 56292.4 56641.7 1238.5 1346.1 1348.7 1374.7 1410.4 28727.9 28867.0 29295.6 29466.9 29687.0 50367.2 50754.2 51037.5 51124.0 51273.7 434466.8 508139.0 509870.0 510208.0 510209.0 32250.7 32870.5 33692.5 33699.0 33786.0 40384.6 40710.4 41608.2 42025.0 42613.0 35427.5 35451.6 36780.4 36976.6 37122.0 28600.0 32372.0 33960.5 34233.7 34555.5 33587.8 33829.8 35980.6 36823.6 37081.0 29819.6 31085.5 31419.2 31507.1 31523.7 24043.5 24043.9 24145.6 24477.9 24561.8 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | [#2] jquery.html Cycles:180 Average:33315.69 Median:465.73 stddev:104093.32 (22350.6%) stddev-sans-first:104355.89 14:59:43 INFO - PROCESS | 1906 | Values: 343.1 352.6 359.8 366.2 366.3 15829.6 19197.5 19649.8 20120.1 21341.9 19479.5 19719.7 19952.8 20095.4 20106.5 5435.5 5486.8 5679.2 5749.9 5754.4 4912.5 5613.8 5683.2 5686.3 5692.2 4058.6 5483.8 5661.7 5663.7 6023.8 6188.6 6215.8 6228.0 6248.0 6267.9 5258.4 5399.6 5410.8 5423.8 5478.5 16027.7 21472.7 24186.0 24323.6 24459.8 2095.6 2180.5 2210.1 2435.3 2562.0 9307.8 9323.6 9541.7 9885.6 9987.0 1746.5 1748.6 1778.4 1789.5 1827.0 92577.0 93642.0 93987.0 98658.6 99494.0 9307.8 9928.9 10779.2 10999.9 11224.7 11325.3 13258.9 13359.3 13390.7 13398.2 7055.3 7633.2 7859.2 8448.4 8471.9 8519.2 8576.2 8586.9 8621.8 8627.4 4377.8 4413.1 4455.5 4458.1 4502.6 1637.7 1656.3 1877.5 1881.6 1881.7 392.8 396.6 407.3 415.3 420.5 11425.8 11816.1 11846.6 11970.3 12103.9 442.3 450.3 455.1 465.6 465.9 6036.7 6205.4 6226.4 6282.0 6298.6 611829.0 616257.0 618175.9 641758.7 658233.0 105440.0 112737.0 113050.4 114202.4 118453.0 447.8 451.4 454.8 458.3 459.2 11313.4 11361.3 11437.8 11439.3 11484.0 49294.0 49717.8 50395.7 50618.0 51197.0 63848.0 63905.4 64038.7 64265.7 69703.0 7728.7 8015.6 8016.7 8038.2 8079.9 8528.9 8845.3 12138.9 12576.2 12792.4 7755.2 7819.6 7902.0 7920.5 8084.6 7781.3 7998.6 8038.0 8244.4 8311.0 7783.0 7947.3 8290.0 8392.5 8399.2 11165.4 11451.3 11462.4 11562.2 11812.8 11300.4 11340.6 11469.6 11562.9 11571.1 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | [#3] mootools.html Cycles:180 Average:5972.61 Median:5441.58 stddev:3131.42 (57.5%) stddev-sans-first:3121.40 14:59:43 INFO - PROCESS | 1906 | Values: 1407.7 1531.7 1739.9 1872.9 1898.8 7753.4 8396.4 8543.2 8686.7 8736.3 8433.8 8441.8 8569.2 8574.8 8588.6 2443.6 2449.9 2450.4 2453.6 2460.8 2348.1 2407.2 2412.1 2423.7 2431.8 2141.0 2334.6 2353.8 2404.6 2466.6 2405.7 2414.8 2443.8 2461.3 2464.7 2358.5 2359.9 2360.1 2366.8 2367.9 8132.2 8508.4 8548.4 8554.4 8568.5 5265.4 5440.3 5442.9 5446.4 5458.3 3087.5 3543.5 3556.7 3660.5 3660.7 1035.6 1048.0 1051.4 1077.9 1094.9 9904.5 11751.9 11782.9 11797.5 11809.6 4797.3 4835.5 4857.1 4894.7 4917.7 10089.4 10090.4 10131.9 10157.2 10160.5 5456.2 5468.6 5469.0 5481.9 5509.1 4952.6 4972.7 4974.7 5001.7 5006.9 3913.8 3968.2 3995.8 3996.7 4004.5 1193.3 1307.4 1308.7 1310.3 1327.9 1026.3 1039.6 1051.8 1111.2 1271.9 7850.5 7860.6 7900.7 7949.4 7957.2 1182.6 1184.7 1190.5 1196.6 1207.8 5581.8 5842.8 6096.3 6156.7 6161.4 10176.2 10821.6 10909.4 10933.3 10934.6 10381.5 10705.0 10721.4 10754.2 10778.0 8217.0 8262.8 8314.9 8359.0 8380.2 7805.3 7815.9 7861.2 7871.6 8021.4 9295.7 9302.4 9467.0 9496.0 9505.0 9589.5 9597.4 9721.0 9778.8 9832.9 6706.8 7177.5 7337.5 7447.3 7449.9 7950.9 7974.8 8007.0 8017.5 8038.4 7404.8 7413.6 7437.7 7512.8 7538.5 6497.2 7031.9 7119.0 7153.8 7206.7 7435.7 7507.3 7578.2 7584.0 7590.8 5883.2 6881.1 6887.9 6917.0 6929.8 6967.1 6978.1 7032.3 7040.5 7062.5 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | [#4] prototype.html Cycles:180 Average:6022.65 Median:6824.33 stddev:1993.58 (29.2%) stddev-sans-first:1952.74 14:59:43 INFO - PROCESS | 1906 | Values: 323.9 325.6 326.6 333.5 336.4 5039.8 5991.7 6779.8 6780.6 6871.7 6857.3 6964.4 6980.1 6991.7 7014.6 5166.9 5171.5 5172.6 5182.7 5208.2 4001.7 5135.9 5174.8 5175.9 5187.9 4922.2 4934.6 4939.0 4943.5 4952.9 4098.9 4928.3 4930.9 4938.2 4949.2 4173.1 4182.0 4184.1 4194.2 4196.8 5483.6 5483.7 6516.5 6565.8 6611.3 4996.9 5860.9 5863.2 5869.1 5891.1 7351.8 7365.6 7369.4 7376.7 7395.4 4459.6 4564.4 4640.9 4670.4 4704.8 7615.2 7750.3 7805.3 7813.4 7834.3 4734.6 4745.6 4749.8 4755.7 4769.5 4732.8 4828.3 4845.9 4848.1 4856.1 5808.5 5820.8 5830.7 5830.8 5848.2 7367.0 7373.9 7377.3 7388.2 7434.6 1654.7 1684.3 1705.8 1709.2 1712.4 1065.4 1077.9 1083.9 1085.7 1089.6 6992.6 7005.8 7017.4 7023.2 7040.3 7889.0 7899.2 7906.2 7915.5 7917.0 6791.3 6987.5 6989.3 7023.7 7027.3 4131.0 4152.0 4162.0 4165.0 4175.0 8286.9 8289.5 8305.9 8311.0 8322.7 7970.6 8135.5 8179.3 8187.8 8214.6 8268.8 8276.7 8286.0 8299.1 8328.6 7514.1 7696.7 7894.2 7904.1 7920.0 7565.4 7633.8 7635.3 7646.7 7650.4 6623.8 8085.4 8089.4 8100.1 8101.3 4646.8 4823.6 4836.1 4843.4 4851.4 6293.7 7613.0 7749.2 7765.4 7768.2 5996.0 7466.8 7469.5 7469.9 7489.1 7421.0 7428.3 7441.3 7442.7 7469.0 6020.8 6413.4 6946.8 7281.7 7349.7 7254.8 7452.4 7470.4 7471.8 7482.6 6039.8 7212.0 7232.4 7289.8 7301.5 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - PROCESS | 1906 | [#5] yui.html Cycles:180 Average:19098.22 Median:623.58 stddev:27228.41 (4366.5%) stddev-sans-first:27269.71 14:59:43 INFO - PROCESS | 1906 | Values: 689.2 744.1 749.5 760.7 763.0 14955.6 15049.9 15154.0 15157.2 15181.8 15773.1 16014.8 16016.4 16017.8 16044.7 696.1 850.3 852.1 859.7 877.7 854.5 857.2 857.5 866.2 868.7 900.7 918.0 918.1 922.0 922.1 905.9 909.2 909.8 910.1 910.2 579.8 665.9 668.3 668.4 670.4 15391.5 15446.2 15450.8 15491.5 15533.5 12544.1 12682.7 12748.9 12971.7 13114.7 9949.5 10146.2 10194.9 10572.2 10892.6 3397.3 3427.5 3456.0 3517.4 3624.7 82007.4 83614.6 83862.0 86062.6 86496.0 9316.8 9398.7 9566.7 9636.7 9939.3 20940.6 21060.6 21065.5 21086.8 21090.7 7237.8 7305.0 7369.1 7582.3 7720.0 3978.1 4064.0 4070.4 4074.0 4120.8 3417.3 3447.4 3481.1 3495.6 3501.2 632.0 635.1 650.1 651.2 652.2 583.4 587.2 619.2 628.0 629.1 6732.0 8346.3 8568.5 8706.3 8727.3 449.9 594.2 603.4 617.2 637.8 3794.8 3953.6 4074.9 4147.8 4161.0 95017.0 96541.0 96687.5 96764.1 98808.0 82979.0 83259.6 83987.0 86334.7 87131.0 73911.3 74325.6 74453.6 75251.9 76545.6 8326.0 8577.6 8636.3 8835.8 8860.1 48387.4 49174.0 49598.5 50005.0 51272.0 65039.3 73820.0 74037.1 74143.6 74578.9 11087.9 11525.3 11588.7 11664.2 12020.9 12183.3 12228.3 12410.2 12438.9 12709.6 11771.1 11800.8 11824.6 12009.5 12068.7 10171.8 11536.3 11774.6 11838.8 11998.3 10900.9 11407.4 11498.0 11600.0 11673.5 8207.4 9649.5 9658.7 9733.2 9871.0 9933.2 10169.2 10196.4 10197.5 10206.4 14:59:43 INFO - PROCESS | 1906 | -------- Summary: end -------- 14:59:43 INFO - PROCESS | 1906 | 14:59:43 INFO - TEST-INFO | 1906: exit 0 14:59:43 INFO - TEST-OK | dromaeo_css | took 1111651ms 14:59:43 INFO - TEST-START | kraken 14:59:43 INFO - operating with platform_type : mac_ 14:59:43 INFO - Initialising browser for kraken test... 14:59:43 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpo_MseS/profile http://localhost:49281/getInfo.html) 14:59:46 INFO - PROCESS | 1913 | __metrics Screen width/height:1600/1200 14:59:46 INFO - PROCESS | 1913 | colorDepth:24 14:59:46 INFO - PROCESS | 1913 | Browser inner width/height: 1024/689 14:59:46 INFO - PROCESS | 1913 | __metrics 14:59:46 ERROR - PROCESS | 1913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 14:59:47 INFO - TEST-INFO | 1913: exit 0 14:59:47 INFO - Browser initialized. 14:59:47 INFO - Running cycle 1/1 for kraken test... 14:59:47 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpo_MseS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:59 INFO - PROCESS | 1916 | RSS: Main: 255442944 14:59:59 INFO - PROCESS | 1916 | 15:00:01 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 15:00:02 INFO - PROCESS | 1916 | RSS: Main: 268492800 15:00:02 INFO - PROCESS | 1916 | 15:00:05 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 15:00:05 INFO - PROCESS | 1916 | RSS: Main: 278355968 15:00:05 INFO - PROCESS | 1916 | 15:00:08 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 15:00:09 INFO - PROCESS | 1916 | RSS: Main: 280408064 15:00:09 INFO - PROCESS | 1916 | 15:00:11 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 15:00:12 INFO - PROCESS | 1916 | RSS: Main: 282173440 15:00:12 INFO - PROCESS | 1916 | 15:00:14 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:00:14 INFO - PROCESS | 1916 | RSS: Main: 283230208 15:00:14 INFO - PROCESS | 1916 | 15:00:17 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 15:00:18 INFO - PROCESS | 1916 | RSS: Main: 282759168 15:00:18 INFO - PROCESS | 1916 | 15:00:20 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 15:00:21 INFO - PROCESS | 1916 | RSS: Main: 282570752 15:00:21 INFO - PROCESS | 1916 | 15:00:24 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 15:00:25 INFO - PROCESS | 1916 | RSS: Main: 283021312 15:00:25 INFO - PROCESS | 1916 | 15:00:26 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:00:27 INFO - PROCESS | 1916 | RSS: Main: 282820608 15:00:27 INFO - PROCESS | 1916 | 15:00:29 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:00:29 INFO - PROCESS | 1916 | RSS: Main: 283553792 15:00:29 INFO - PROCESS | 1916 | 15:00:32 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:00:32 INFO - PROCESS | 1916 | RSS: Main: 284082176 15:00:32 INFO - PROCESS | 1916 | 15:00:35 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:00:35 INFO - PROCESS | 1916 | RSS: Main: 283033600 15:00:35 INFO - PROCESS | 1916 | 15:00:38 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:00:39 INFO - PROCESS | 1916 | RSS: Main: 284188672 15:00:39 INFO - PROCESS | 1916 | 15:00:40 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 15:00:41 INFO - PROCESS | 1916 | RSS: Main: 283738112 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | __start_tp_report 15:00:41 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 15:00:41 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 15:00:41 INFO - PROCESS | 1916 | |i|pagename|runs| 15:00:41 INFO - PROCESS | 1916 | |0;ai-astar;115;110;116;114;116;126;115;116;113;114 15:00:41 INFO - PROCESS | 1916 | |1;audio-beat-detection;155;124;150;175;146;144;139;123;157;121 15:00:41 INFO - PROCESS | 1916 | |2;audio-dft;193;199;199;195;199;212;207;193;203;200 15:00:41 INFO - PROCESS | 1916 | |3;audio-fft;56;66;74;69;133;105;100;71;59;92 15:00:41 INFO - PROCESS | 1916 | |4;audio-oscillator;82;82;123;79;80;82;113;79;79;112 15:00:41 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;107;96;89;97;90;94;89;96;89;96 15:00:41 INFO - PROCESS | 1916 | |6;imaging-darkroom;109;99;98;98;99;112;120;96;103;97 15:00:41 INFO - PROCESS | 1916 | |7;imaging-desaturate;94;124;78;104;111;136;134;143;145;93 15:00:41 INFO - PROCESS | 1916 | |8;json-parse-financial;74;76;51;49;47;68;81;83;80;76 15:00:41 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;68;72;66;75;75;74;69;67;68;67 15:00:41 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;97;79;98;102;102;100;110;86;84;85 15:00:41 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;140;144;121;133;135;125;130;122;134;133 15:00:41 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;133;129;175;134;173;165;170;156;141;140 15:00:41 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;67;67;68;67;95;91;64;61;98;91 15:00:41 INFO - PROCESS | 1916 | __end_tp_report 15:00:41 INFO - PROCESS | 1916 | __start_cc_report 15:00:41 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,883 15:00:41 INFO - PROCESS | 1916 | __end_cc_report 15:00:41 INFO - PROCESS | 1916 | __startTimestamp1455836441187__endTimestamp 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | ------- Summary: start ------- 15:00:41 INFO - PROCESS | 1916 | Number of tests: 14 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.12 (3.6%) stddev-sans-first:4.36 15:00:41 INFO - PROCESS | 1916 | Values: 115.0 110.0 116.0 114.0 116.0 126.0 115.0 116.0 113.0 114.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:148.00 stddev:17.26 (11.7%) stddev-sans-first:17.79 15:00:41 INFO - PROCESS | 1916 | Values: 155.0 124.0 150.0 175.0 146.0 144.0 139.0 123.0 157.0 121.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:200.00 Median:199.50 stddev:6.04 (3.0%) stddev-sans-first:5.85 15:00:41 INFO - PROCESS | 1916 | Values: 193.0 199.0 199.0 195.0 199.0 212.0 207.0 193.0 203.0 200.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:82.50 Median:67.50 stddev:24.42 (36.2%) stddev-sans-first:23.94 15:00:41 INFO - PROCESS | 1916 | Values: 56.0 66.0 74.0 69.0 133.0 105.0 100.0 71.0 59.0 92.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:79.50 stddev:17.46 (22.0%) stddev-sans-first:18.21 15:00:41 INFO - PROCESS | 1916 | Values: 82.0 82.0 123.0 79.0 80.0 82.0 113.0 79.0 79.0 112.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:95.00 stddev:5.58 (5.9%) stddev-sans-first:3.55 15:00:41 INFO - PROCESS | 1916 | Values: 107.0 96.0 89.0 97.0 90.0 94.0 89.0 96.0 89.0 96.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:97.50 stddev:7.98 (8.2%) stddev-sans-first:8.17 15:00:41 INFO - PROCESS | 1916 | Values: 109.0 99.0 98.0 98.0 99.0 112.0 120.0 96.0 103.0 97.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:144.00 stddev:23.53 (16.3%) stddev-sans-first:23.55 15:00:41 INFO - PROCESS | 1916 | Values: 94.0 124.0 78.0 104.0 111.0 136.0 134.0 143.0 145.0 93.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:76.00 stddev:14.10 (18.6%) stddev-sans-first:14.82 15:00:41 INFO - PROCESS | 1916 | Values: 74.0 76.0 51.0 49.0 47.0 68.0 81.0 83.0 80.0 76.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:3.54 (5.0%) stddev-sans-first:3.67 15:00:41 INFO - PROCESS | 1916 | Values: 68.0 72.0 66.0 75.0 75.0 74.0 69.0 67.0 68.0 67.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:84.50 stddev:10.08 (11.9%) stddev-sans-first:10.64 15:00:41 INFO - PROCESS | 1916 | Values: 97.0 79.0 98.0 102.0 102.0 100.0 110.0 86.0 84.0 85.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:133.50 stddev:7.42 (5.6%) stddev-sans-first:7.24 15:00:41 INFO - PROCESS | 1916 | Values: 140.0 144.0 121.0 133.0 135.0 125.0 130.0 122.0 134.0 133.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:160.50 stddev:18.12 (11.3%) stddev-sans-first:17.93 15:00:41 INFO - PROCESS | 1916 | Values: 133.0 129.0 175.0 134.0 173.0 165.0 170.0 156.0 141.0 140.0 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:79.50 stddev:14.77 (18.6%) stddev-sans-first:15.22 15:00:41 INFO - PROCESS | 1916 | Values: 67.0 67.0 68.0 67.0 95.0 91.0 64.0 61.0 98.0 91.0 15:00:41 INFO - PROCESS | 1916 | -------- Summary: end -------- 15:00:41 INFO - PROCESS | 1916 | 15:00:41 INFO - TEST-INFO | 1916: exit 0 15:00:41 INFO - TEST-OK | kraken | took 58380ms 15:00:41 INFO - SUITE-END | took 1170s 15:00:42 INFO - Completed test suite (00:19:30) 15:00:42 INFO - Working with test: dromaeo_css 15:00:42 INFO - Generating results file: dromaeo_css 15:00:42 INFO - Working with test: kraken 15:00:42 INFO - Generating results file: kraken 15:00:42 INFO - javascript benchmark 15:00:42 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:00:42 INFO - process_Request line: dromaeo_css 7374.69 graph.html#tests=[[72,64,61]] 15:00:42 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:42 INFO - process_Request line: kraken 1539.20 graph.html#tests=[[232,64,61]] 15:00:42 INFO - RETURN: dromaeo_css: 7374.69 15:00:42 INFO - RETURN: kraken: 1539.20 15:00:42 INFO - javascript benchmark 15:00:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3502.054445299769, 3515.964840351597, 3550.3786837303496, 3575.1777091269, 3578.7494875358734, 4696.577308042271, 5649.774009039644, 5749.310082790061, 5794.3626201117895, 5797.884042319156, 4752.833650822222, 5731.398203188668, 5828.504577110951, 5861.912071318934, 5872.060470324749, 5164.483551644824, 5219.582433405319, 5308.23030660554, 5381.865453363658, 5422.945770542284, 4896.828610998616, 5162.870928226786, 5284.44513326101, 5328.733563321838, 5361.624686271963, 5187.4034486034025, 5219.582433405357, 5228.163493841005, 5265.289185959885, 5268.420473747885, 5233.267342572043, 5237.502437268454, 5277.340332458442, 5279.234510995884, 5290.047791397586, 5126.512981266774, 5166.276721259027, 5228.843134705965, 5275.314209152824, 5284.07528682479, 5016.197408414636, 5369.355677318707, 5677.261955945742, 5685.204071430003, 5740.512056475163, 6197.03945888388, 6220.533459990519, 6230.158928544633, 6233.844153896143, 6234.1583886175695, 6109.040306147832, 6132.110769107974, 6170.167027451282, 6192.566520343577, 6198.132261483396, 4961.875953101166, 5850.76596936122, 5896.675682837442, 5896.911546326808, 5912.852178695567, 6144.941444616014, 6206.131141640174, 6272.843178920563, 6279.277883043508, 6280.497560195174, 6134.018557030854, 6154.846128846814, 6163.7842675506145, 6185.597936134137, 6194.5973511721595, 6157.107219453154, 6181.258249010148, 6192.071189321638, 6192.969035154795, 6202.4417802398, 6032.969835150796, 6117.4620395853735, 6144.740328232701, 6178.7219575119225, 6218.0, 6164.291106522807, 6187.535934804908, 6189.473894718999, 6190.133381326618, 6234.5635805494085, 4761.714297142183, 4816.783244753994, 4886.267059941038, 4888.340074090023, 4895.216765317532, 3778.771899132738, 4014.578469260744, 4412.382266482695, 4424.579664931826, 4454.732716037048, 4802.423709154924, 5687.488126068673, 5778.451047150598, 5779.653220806765, 5792.710364481759, 6168.9691551541955, 6182.010878259457, 6186.845328866814, 6200.968995154995, 6212.1303017577575, 5561.193626924073, 5678.772849086073, 5777.422257774189, 5797.36229014808, 5849.590528662953, 5359.732013399314, 5372.785088596413, 5377.892442151135, 5379.67721936685, 5398.730063496888, 6325.778597749057, 6339.461145802658, 6351.2696039956, 6355.841103972438, 6358.872822543616, 6055.394460553909, 6079.3008803988105, 6111.227117700271, 6131.315499379051, 6142.498775697809, 6354.23749150105, 6364.809055728336, 6371.299157092809, 6381.29805721361, 6415.005674120519, 6018.759249630141, 6131.908021379593, 6137.140800288053, 6137.9693101535995, 6152.938470615416, 6096.889554637438, 6166.013437849922, 6173.228346456693, 6176.7838125665385, 6179.104029915727, 5252.369715634149, 5277.0, 6059.424354686298, 6069.246435845284, 6095.603785753912, 5963.165156877953, 6025.548083893813, 6040.456358927718, 6087.482563981934, 6095.817125486243, 5838.4453476919625, 5856.0, 5874.94125058744, 5945.137954996588, 5989.550783691154, 6024.33732289439, 6048.788292409745, 6075.605085669417, 6075.939240607714, 6100.969495152496, 5014.52362025607, 5932.614380065282, 5937.614055086406, 5944.227250457413, 5946.554008449297], "unit": "score", "name": "dojo.html", "value": 5657.603670193793}, {"lowerIsBetter": false, "replicates": [469.1836205003293, 496.8795366448659, 514.3647595219903, 571.1318795430946, 595.9332794298207, 37288.06779830502, 37845.62154378452, 38012.42981355275, 38084.80957595208, 38193.42709859354, 39376.60623393765, 39830.0, 39871.40192897102, 39926.201475970534, 39941.60058399415, 8406.327493800482, 9291.953540232305, 9440.055994400574, 9509.0, 9530.285228607847, 9281.72154835356, 9439.716808495721, 9464.763380915463, 9478.241740660731, 9516.71449856502, 9494.477803720827, 9537.904620953806, 9576.952115239414, 9577.233821294314, 9611.759706007371, 9472.621095156186, 9509.286803489766, 9529.0, 9549.47477888716, 9580.233581313478, 9555.092266234697, 9628.0, 9643.373180743229, 9662.0, 9711.028897110233, 36491.4526282106, 36517.81741091304, 36626.0, 36843.81578092119, 36854.63145368539, 2780.805343625947, 3135.749140068789, 3151.401233765577, 3176.28533579945, 3233.304839459504, 28636.570451443244, 28706.569401458994, 28740.281492962633, 29100.563491547644, 29387.11838644844, 2757.820741651786, 2811.9156425307274, 2812.70466601006, 2836.9007084752143, 2957.1128661401494, 464168.0, 468810.0, 470767.0, 471897.0, 475098.0, 55621.72189139109, 64845.67577162084, 65224.0, 65283.34716652868, 65340.0, 61510.0, 61708.0, 61783.073253901224, 62060.75878482495, 62120.0, 15937.681246375008, 15964.36142554308, 16067.196640167946, 16264.18679066042, 16345.937514061548, 12427.0, 12495.375231238584, 12638.2417054977, 12707.87292127067, 12716.0, 19602.411927642195, 19996.60006799856, 20428.897855510626, 20430.08064637095, 20604.27885024047, 7280.6723697433745, 8045.345036138177, 8208.753737387888, 8219.876701849476, 8267.669293228204, 919.9632014719471, 929.2798081486902, 939.7462685074992, 1030.2324768047852, 1032.0, 29575.408491830472, 29651.110466686034, 29859.552106718416, 30340.54489182664, 30464.0, 897.3673560140086, 1013.3210748798175, 1014.7260239735377, 1017.5726194998118, 1043.9895601043893, 12280.815787763191, 14082.71834563303, 14565.708685826225, 14835.629109272139, 15280.388784448498, 476248.0, 494104.5884311738, 533798.0, 538353.0, 539513.3024334853, 48974.51025489771, 54718.726406367714, 55942.44057559453, 56292.43707562954, 56641.716791415776, 1238.5479300055595, 1346.1317450244537, 1348.7235116801032, 1374.714641809911, 1410.4005797536006, 28727.856360718062, 28867.0, 29295.560566591943, 29466.852665736533, 29687.0, 50367.24449133339, 50754.238686419, 51037.48962510328, 51124.0, 51273.743631281606, 434466.82766585966, 508139.0, 509870.0, 510208.0, 510209.0, 32250.709971601813, 32870.506942396365, 33692.49461258132, 33699.0, 33785.986420407426, 40384.59615403808, 40710.389344159266, 41608.16783664249, 42025.0, 42613.0, 35427.468587971714, 35451.64548354483, 36780.44829327616, 36976.63023369732, 37122.0, 28600.0, 32372.0, 33960.490592641625, 34233.657663423044, 34555.48166777551, 33587.83206083954, 33829.83085084559, 35980.640193598774, 36823.63176368309, 37081.0, 29819.552706708982, 31085.53371699381, 31419.214519637193, 31507.054788356385, 31523.684763152076, 24043.51912961696, 24043.879780600986, 24145.637815433132, 24477.87761061183, 24561.75438245666], "unit": "score", "name": "ext.html", "value": 19249.951935798494}, {"lowerIsBetter": false, "replicates": [343.09080935520876, 352.6403068869753, 359.80570491934355, 366.1687968311934, 366.2766037076774, 15829.60425989348, 19197.46420286377, 19649.803501964976, 20120.09459574319, 21341.893290533546, 19479.513012174702, 19719.70420443691, 19952.800471995277, 20095.397138085846, 20106.497337566532, 5435.537979271757, 5486.835394938138, 5679.233303504016, 5749.913751293734, 5754.424557544233, 4912.533309335608, 5613.831585052434, 5683.175939488771, 5686.346070201917, 5692.203091567184, 4058.553559108496, 5483.8080667176655, 5661.745221465023, 5663.688497132656, 6023.759049638009, 6188.566800323979, 6215.782447614334, 6227.96886015567, 6247.9687601562155, 6267.905981410283, 5258.395284542288, 5399.595030372738, 5410.810621628224, 5423.7830486780485, 5478.506934375885, 16027.679446411123, 21472.677909831364, 24186.0, 24323.635145472832, 24459.755402445924, 2095.559932414195, 2180.5202855371795, 2210.071769856664, 2435.330284171849, 2562.0264299566234, 9307.813843723156, 9323.580438880266, 9541.666041688508, 9885.555150018194, 9987.0, 1746.4585978346754, 1748.6327871147075, 1778.4042345814169, 1789.4810504953548, 1827.0, 92577.0, 93642.0, 93987.0, 98658.56392119733, 99494.0, 9307.76730581741, 9928.858181309097, 10779.191560632984, 10999.945000275107, 11224.698936717954, 11325.320480771015, 13258.939284857188, 13359.332033398292, 13390.732185356239, 13398.196108233342, 7055.329743674342, 7633.198514156044, 7859.214078592209, 8448.408611397266, 8471.941007374078, 8519.190676885686, 8576.185262400062, 8586.914130858737, 8621.827563448696, 8627.396082274307, 4377.8248870044845, 4413.117376524708, 4455.4876189238, 4458.130664520452, 4502.649205238416, 1637.7215873301568, 1656.2712406541084, 1877.5400026993475, 1881.6236752649525, 1881.6801143805585, 392.7937832637888, 396.6192455242999, 407.3177427808409, 415.2981461330342, 420.51220584122274, 11425.751064402548, 11816.113791465503, 11846.644600661994, 11970.281783093042, 12103.939480302719, 442.33870363805676, 450.3110241330769, 455.0875494633239, 465.58795466012145, 465.8695565241738, 6036.728347224385, 6205.441510264008, 6226.439620434092, 6281.96859015702, 6298.559100862895, 611829.0, 616257.0, 618175.9091204605, 641758.7472375836, 658233.0, 105440.0, 112737.0, 113050.43474782738, 114202.4289878562, 118453.0, 447.78506316968037, 451.3590701204298, 454.8135264541522, 458.26677316293666, 459.24912767624505, 11313.434328283718, 11361.261518001304, 11437.771244575228, 11439.256448330832, 11484.023857972166, 49294.0, 49717.75141124271, 50395.74802125966, 50618.0, 51197.0, 63848.0, 63905.36094638994, 64038.67980660067, 64265.67867160634, 69703.0, 7728.652210650422, 8015.559144246889, 8016.679332826621, 8038.196180381915, 8079.87880181786, 8528.914710852812, 8845.336599754915, 12138.878611214128, 12576.182548134342, 12792.424340904869, 7755.2244775521995, 7819.609019549113, 7902.0, 7920.5247685139075, 8084.63619137152, 7781.26078022587, 7998.5600791957, 8038.0, 8244.381671374551, 8311.0, 7783.027121609799, 7947.284744372803, 8289.95855020721, 8392.4544904581, 8399.160083991796, 11165.385903775046, 11451.25566838153, 11462.369569673749, 11562.190646654653, 11812.763744724885, 11300.434978251218, 11340.6030788922, 11469.598564050551, 11562.94218528902, 11571.132165087483], "unit": "score", "name": "jquery.html", "value": 8077.191846831747}, {"lowerIsBetter": false, "replicates": [1407.6551244944988, 1531.6706908014778, 1739.913004349782, 1872.9344472943449, 1898.7816401113876, 7753.418493612973, 8396.412251142423, 8543.188397102273, 8686.739397818059, 8736.301095912328, 8433.78915527112, 8441.831163376728, 8569.228769410753, 8574.785630359243, 8588.570571471433, 2443.6456713776493, 2449.8775061246956, 2450.3996520852415, 2453.6196889482158, 2460.803135749136, 2348.072511358021, 2407.1935901473025, 2412.0592968742203, 2423.6970378702663, 2431.7932975697, 2141.0472339808794, 2334.5564342774906, 2353.8116950643994, 2404.615261558151, 2466.5930121529927, 2405.7129435751963, 2414.782669559739, 2443.8289319747623, 2461.3354394313524, 2464.7042354917344, 2358.516504116652, 2359.9410014749596, 2360.138549429463, 2366.7514910934447, 2367.857928524294, 8132.227438393344, 8508.361872859561, 8548.358873084544, 8554.443961142506, 8568.528730919797, 5265.394479634852, 5440.265564148829, 5442.891142177174, 5446.400895901447, 5458.2904222451225, 3087.4596945534668, 3543.539339885798, 3556.697680697144, 3660.4692319613773, 3660.7254455915913, 1035.6219979707428, 1047.9782212342905, 1051.3796859852648, 1077.9245452818307, 1094.9488491048523, 9904.504774761304, 11751.941240293743, 11782.882171178264, 11797.469113889896, 11809.586664466702, 4797.304390863305, 4835.492273311322, 4857.149998750205, 4894.681845680019, 4917.729524876167, 10089.394636321844, 10090.445025523666, 10131.949340253252, 10157.238207134495, 10160.542775575117, 5456.208849716769, 5468.6171967962655, 5469.042917489423, 5481.890362192734, 5509.118541033416, 4952.628552858478, 4972.676776009548, 4974.701517908937, 5001.724905130252, 5006.949930500721, 3913.804309784556, 3968.2460332536725, 3995.760254384746, 3996.740211886276, 4004.4794176756836, 1193.2721040165493, 1307.4116647508658, 1308.6924572725402, 1310.33173081729, 1327.887129593976, 1026.2610920137488, 1039.6101461951769, 1051.8264486359817, 1111.183280288987, 1271.9236845789283, 7850.528968261922, 7860.606969651494, 7900.68397264103, 7949.443538952218, 7957.244061814118, 1182.6392950150287, 1184.673166054025, 1190.4940400329824, 1196.6230637349206, 1207.7524107557929, 5581.772010157759, 5842.766289348378, 6096.298925623521, 6156.6921653918025, 6161.383861613803, 10176.236782241362, 10821.621243256448, 10909.39998300101, 10933.28933619328, 10934.56261749521, 10381.532831022621, 10704.983026612459, 10721.410322432184, 10754.193435492212, 10778.02997730208, 8216.958915205385, 8262.83474330522, 8314.916850831536, 8358.958205208935, 8380.20388063133, 7805.258500442449, 7815.921840781747, 7861.174576669596, 7871.606419678878, 8021.398395120506, 9295.67465138717, 9302.44185348854, 9467.0, 9495.952520237355, 9504.95247523758, 9589.520523973913, 9597.376170548892, 9721.027897210506, 9778.804423911339, 9832.852507212541, 6706.798796036127, 7177.533460325062, 7337.523061001018, 7447.292507211806, 7449.851002979802, 7950.920490795018, 7974.760757177294, 8006.959965200137, 8017.478863873829, 8038.39712021589, 7404.777856664308, 7413.629318533944, 7437.702491900263, 7512.812179695551, 7538.547687138789, 6497.18785151856, 7031.894521582078, 7118.9644051779405, 7153.82115447118, 7206.747763828241, 7435.665395057127, 7507.324340809353, 7578.166401695698, 7584.0, 7590.7722768317035, 5883.235179426647, 6881.13985751781, 6887.862242755217, 6916.965415172892, 6929.82675433098, 6967.1291088613925, 6978.127734033246, 7032.26161253061, 7040.5071644984355, 7062.470314726519], "unit": "score", "name": "mootools.html", "value": 4875.340691239852}, {"lowerIsBetter": false, "replicates": [323.8720705321398, 325.6320357995466, 326.59828411054417, 333.4597951318864, 336.441507098217, 5039.82360617378, 5991.730372133254, 6779.830504237397, 6780.55926364786, 6871.690773915186, 6857.348551887562, 6964.408025317842, 6980.127484064492, 6991.720331186746, 7014.614196219206, 5166.948330516703, 5171.508706672869, 5172.560332371734, 5182.714950677711, 5208.218767184915, 4001.6998725095586, 5135.948640513603, 5174.818881339153, 5175.87060323493, 5187.922181167267, 4922.187839006559, 4934.6299027572895, 4939.012197560484, 4943.505649435064, 4952.87617809554, 4098.938515922278, 4928.26076088586, 4930.876728081808, 4938.2098864181735, 4949.168807541197, 4173.08192197716, 4181.979090104561, 4184.058586817941, 4194.203101410722, 4196.81114349855, 5483.643563168382, 5483.698396588186, 6516.478681705452, 6565.770198043046, 6611.3058128896255, 4996.925046124311, 5860.882782344372, 5863.208466856962, 5869.148973398833, 5891.086881533369, 7351.779446616557, 7365.594892280922, 7369.410447164214, 7376.741814036536, 7395.445341599401, 4459.598636122764, 4564.360989461478, 4640.86077417678, 4670.392848929651, 4704.764761761899, 7615.200403957616, 7750.263724946121, 7805.336546393563, 7813.374930005642, 7834.294913457816, 4734.550217729379, 4745.572898439088, 4749.786259618326, 4755.690880092783, 4769.451513075971, 4732.834350797705, 4828.348172996671, 4845.854624361275, 4848.10310092634, 4856.101621200019, 5808.506276966421, 5820.767169313265, 5830.679312637845, 5830.766769329264, 5848.181254624356, 7366.968624392589, 7373.926260737324, 7377.26227377258, 7388.1503627083575, 7434.591097489581, 1654.6856097341708, 1684.3178512702375, 1705.7782488276446, 1709.1539687854593, 1712.4006597690957, 1065.4459680966008, 1077.9407132607625, 1083.8916108389099, 1085.696005118568, 1089.5696200000955, 6992.580445173306, 7005.789826305219, 7017.3684368407085, 7023.192332881784, 7040.295970402919, 7889.0, 7899.210078992055, 7906.209379062163, 7915.485493442908, 7916.960415197887, 6791.320867913169, 6987.545809522365, 6989.266127056688, 7023.683934222972, 7027.262137475492, 4130.958690413057, 4151.958480415217, 4162.0, 4165.042040330681, 4174.998000479924, 8286.922700048955, 8289.502629842109, 8305.916940830635, 8310.958445207856, 8322.66709331632, 7970.601469926481, 8135.471194372347, 8179.263866252066, 8187.754367368989, 8214.63034163464, 8268.751937441886, 8276.710315138942, 8285.95857020723, 8299.128591497927, 8328.583570821434, 7514.098308203051, 7696.7306144284685, 7894.21057894206, 7904.091029531677, 7919.970403847463, 7565.4325925556905, 7633.809154771176, 7635.312821846061, 7646.738288182388, 7650.426218033781, 6623.834404139935, 8085.43401961857, 8089.433739638404, 8100.149484304063, 8101.311388531805, 4646.8141274348645, 4823.589994850477, 4836.105320515716, 4843.39457567804, 4851.442084160367, 6293.653849038347, 7613.0, 7749.225077492206, 7765.378769698297, 7768.184340644151, 5996.0, 7466.77599671989, 7469.477136600386, 7469.88795168062, 7489.138749043712, 7420.961065450949, 7428.294312040348, 7441.255874412515, 7442.665080071301, 7469.029026226556, 6020.759169633166, 6413.390727880844, 6946.756863509753, 7281.745138920112, 7349.706011759684, 7254.782356529313, 7452.397734487111, 7470.4023678106705, 7471.813204669927, 7482.551046937201, 6039.758409663565, 7212.0, 7232.421406287379, 7289.817754556178, 7301.488895777245], "unit": "score", "name": "prototype.html", "value": 5353.9305731880695}, {"lowerIsBetter": false, "replicates": [689.2383915773072, 744.0550500863903, 749.5277974875827, 760.7451503746245, 762.973295934642, 14955.55133346, 15049.92475037626, 15154.0, 15157.166355850424, 15181.772273415894, 15773.132477713722, 16014.759778603331, 16016.35934562619, 16017.839821601781, 16044.679106417865, 696.1124566178113, 850.3324889961351, 852.0669866496177, 859.6819176904554, 877.7410663854147, 854.4702284583567, 857.2456238510102, 857.5197889182078, 866.2247288676631, 868.722008957134, 900.6622516556291, 918.0223062438482, 918.0589895357278, 922.0088404964656, 922.0917396364609, 905.9094090590921, 909.1999040844081, 909.8134882349169, 910.1353713971753, 910.194477887068, 579.7738881836087, 665.9267480577132, 668.2949488289852, 668.4017804065383, 670.4267850987433, 15391.538253852403, 15446.150461724601, 15450.845491545166, 15491.457798976982, 15533.456329028542, 12544.059195560278, 12682.74634507314, 12748.872511274862, 12971.67570810728, 13114.672133196651, 9949.502524873727, 10146.188304935662, 10194.949025254826, 10572.15422766177, 10892.564297428093, 3397.303552771676, 3427.4516077427493, 3456.0495863637448, 3517.402041652925, 3624.691901188402, 82007.3598528026, 83614.58192709058, 83862.0, 86062.56968715116, 86495.99999999937, 9316.813663726687, 9398.67104651334, 9566.661844592814, 9636.662716804878, 9939.304248702521, 20940.58118837615, 21060.578788424147, 21065.473363166042, 21086.789132108483, 21090.683639745417, 7237.819054523679, 7305.0, 7369.078865141857, 7582.317591416799, 7720.0, 3978.124812541236, 4063.959360406417, 4070.4163173793595, 4074.0336209550073, 4120.793960301973, 3417.2823707021803, 3447.413939630269, 3481.060113769268, 3495.615482296945, 3501.2122272488486, 632.0, 635.0569404434411, 650.1385663995226, 651.1990251989984, 652.2075678051191, 583.4282403244844, 587.224863180606, 619.1610367951452, 628.0, 629.1109487032561, 6731.966340168267, 8346.290565301895, 8568.52873091986, 8706.303495720327, 8727.258183054384, 449.91901457737265, 594.2186025376616, 603.4207161125281, 617.2346290599714, 637.8341631175834, 3794.8213602745977, 3953.6441720245316, 4074.898127546776, 4147.797138829766, 4161.0, 95017.0, 96541.0, 96687.51656241814, 96764.06471870524, 98808.01191988132, 82979.0, 83259.5837020811, 83987.0, 86334.70497942535, 87131.0, 73911.26088739044, 74325.62837185779, 74453.627731861, 75251.87122193171, 76545.61727191329, 8326.0, 8577.614007369808, 8636.26591739684, 8835.823283534164, 8860.113988601088, 48387.370947178395, 49174.0, 49598.50401495939, 50005.0, 51272.0, 65039.349606505224, 73820.0, 74037.14907127366, 74143.62928185324, 74578.88131677921, 11087.944560277147, 11525.308481491138, 11588.710282243012, 11664.183507154417, 12020.929430637472, 12183.269003859798, 12228.266304021787, 12410.193337433038, 12438.875611243771, 12709.555165569162, 11771.11716621274, 11800.76398472043, 11824.586139485076, 12009.459574319002, 12068.698282542655, 10171.796564068825, 11536.307821530734, 11774.646760597196, 11838.763224735629, 11998.280103193836, 10900.881101276811, 11407.372594507382, 11498.02956154006, 11600.0, 11673.533058677558, 8207.425480216327, 9649.517524123625, 9658.661946831828, 9733.249670205925, 9871.012898710358, 9933.155681766842, 10169.237307202138, 10196.4391958443, 10197.54111064989, 10206.387616743019], "unit": "score", "name": "yui.html", "value": 7005.364384418641}], "name": "dromaeo_css", "value": 7374.69091851411}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 114.0, 116.0, 126.0, 115.0, 116.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 150.0, 175.0, 146.0, 144.0, 139.0, 123.0, 157.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [193.0, 199.0, 199.0, 195.0, 199.0, 212.0, 207.0, 193.0, 203.0, 200.0], "unit": "score", "name": "audio-dft", "value": 200.0}, {"lowerIsBetter": true, "replicates": [56.0, 66.0, 74.0, 69.0, 133.0, 105.0, 100.0, 71.0, 59.0, 92.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 123.0, 79.0, 80.0, 82.0, 113.0, 79.0, 79.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 91.1}, {"lowerIsBetter": true, "replicates": [107.0, 96.0, 89.0, 97.0, 90.0, 94.0, 89.0, 96.0, 89.0, 96.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.3}, {"lowerIsBetter": true, "replicates": [109.0, 99.0, 98.0, 98.0, 99.0, 112.0, 120.0, 96.0, 103.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 103.1}, {"lowerIsBetter": true, "replicates": [94.0, 124.0, 78.0, 104.0, 111.0, 136.0, 134.0, 143.0, 145.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 116.2}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 51.0, 49.0, 47.0, 68.0, 81.0, 83.0, 80.0, 76.0], "unit": "score", "name": "json-parse-financial", "value": 68.5}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 66.0, 75.0, 75.0, 74.0, 69.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [97.0, 79.0, 98.0, 102.0, 102.0, 100.0, 110.0, 86.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.3}, {"lowerIsBetter": true, "replicates": [140.0, 144.0, 121.0, 133.0, 135.0, 125.0, 130.0, 122.0, 134.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.7}, {"lowerIsBetter": true, "replicates": [133.0, 129.0, 175.0, 134.0, 173.0, 165.0, 170.0, 156.0, 141.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 95.0, 91.0, 64.0, 61.0, 98.0, 91.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.9}], "name": "kraken", "value": 1539.2}]} 15:00:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1539.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7374.69"}}} 15:00:42 INFO - Return code: 0 15:00:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:00:42 ERROR - # TBPL SUCCESS # 15:00:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:00:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:00:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:00:42 INFO - 2016-02-18 15:00:42.543 screenresolution[1921:11312] starting screenresolution argv=screenresolution get 15:00:42 INFO - 2016-02-18 15:00:42.546 screenresolution[1921:11312] Display 0: 1600x1200x32@60 15:00:42 INFO - 2016-02-18 15:00:42.552 screenresolution[1922:11315] starting screenresolution argv=screenresolution list 15:00:42 INFO - Available Modes on Display 0 15:00:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:00:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:00:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:00:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:00:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:00:42 INFO - Intel Iris: 15:00:42 INFO - Chipset Model: Intel Iris 15:00:42 INFO - Type: GPU 15:00:42 INFO - Bus: Built-In 15:00:42 INFO - VRAM (Dynamic, Max): 1536 MB 15:00:42 INFO - Vendor: Intel (0x8086) 15:00:42 INFO - Device ID: 0x0a2e 15:00:42 INFO - Revision ID: 0x0009 15:00:42 INFO - Displays: 15:00:42 INFO - Display: 15:00:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:00:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:00:42 INFO - Display Serial Number: 1600x1200 60 15:00:42 INFO - Main Display: Yes 15:00:42 INFO - Mirror: Off 15:00:42 INFO - Online: Yes 15:00:42 INFO - Rotation: Supported 15:00:42 INFO - Return code: 0 15:00:42 INFO - Running post-action listener: _resource_record_post_action 15:00:42 INFO - Running post-run listener: _resource_record_post_run 15:00:43 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 33455616; Write bytes: 712860672; Read time: 354; Write time: 2302 15:00:43 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397810176; Write bytes: 395480576; Read time: 30778; Write time: 872 15:00:43 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 31669760; Write bytes: 301618688; Read time: 335; Write time: 1390 15:00:43 INFO - Running post-run listener: _upload_blobber_files 15:00:43 INFO - Blob upload gear active. 15:00:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:00:43 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:00:43 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:00:43 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:00:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:00:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:00:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:45 INFO - (blobuploader) - INFO - Done attempting. 15:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:00:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:46 INFO - (blobuploader) - INFO - Done attempting. 15:00:46 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:46 INFO - Return code: 0 15:00:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:00:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b16e3d1ada85dec55bdc896bba8e92db53fb108a8e1f7bc7a73275ecaf96ba5971aae77478fda3b522b7768b75f31d53fc0bbdc6442d81fec6bcfc1ce151dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c160b633af0a4b0b09dd3192e30550f1ee75677101ae126090709793707227c752b3745d4d044c8cff58286e2d34799992362068b3d2d5a6a6a54398d4390ec9"} 15:00:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:00:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:00:46 INFO - Contents: 15:00:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b16e3d1ada85dec55bdc896bba8e92db53fb108a8e1f7bc7a73275ecaf96ba5971aae77478fda3b522b7768b75f31d53fc0bbdc6442d81fec6bcfc1ce151dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c160b633af0a4b0b09dd3192e30550f1ee75677101ae126090709793707227c752b3745d4d044c8cff58286e2d34799992362068b3d2d5a6a6a54398d4390ec9"} 15:00:46 INFO - Running post-run listener: copy_logs_to_upload_dir 15:00:46 INFO - Copying logs to upload dir... 15:00:46 INFO - mkdir: /builds/slave/test/build/upload/logs 15:00:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.185980 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-18 15:00:46.689381) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 15:00:46.692918) ========= 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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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/6b16e3d1ada85dec55bdc896bba8e92db53fb108a8e1f7bc7a73275ecaf96ba5971aae77478fda3b522b7768b75f31d53fc0bbdc6442d81fec6bcfc1ce151dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c160b633af0a4b0b09dd3192e30550f1ee75677101ae126090709793707227c752b3745d4d044c8cff58286e2d34799992362068b3d2d5a6a6a54398d4390ec9"} build_url:https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/TNjYQ4QjQsefyUqFmQYU1w/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/6b16e3d1ada85dec55bdc896bba8e92db53fb108a8e1f7bc7a73275ecaf96ba5971aae77478fda3b522b7768b75f31d53fc0bbdc6442d81fec6bcfc1ce151dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c160b633af0a4b0b09dd3192e30550f1ee75677101ae126090709793707227c752b3745d4d044c8cff58286e2d34799992362068b3d2d5a6a6a54398d4390ec9"}' ========= master_lag: 0.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 15:00:47.009308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 15:00:47.009647) ========= 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.whZQxFIh6L/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.0vbAmhlO8V/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005326 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 15:00:47.063082) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 15:00:47.063392) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 15:00:47.063761) ========= ========= Total master_lag: 1.09 =========