builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1457023513.59 results: success (0) buildid: 20160303065935 builduid: 9b3645557a79406a88671634586cae2b revision: 48199a0c1e54d75528ee860c425a2235c4df1fee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.587746) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.588179) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.588472) ========= 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.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005926 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.612069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.612457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.629212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.629487) ========= 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.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005425 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.677554) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.677853) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.678228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.678503) ========= 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.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-03 08:45:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-03-03 08:45:13 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115538 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.808543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.808860) ========= 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.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.026690 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.856430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:13.856854) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48199a0c1e54d75528ee860c425a2235c4df1fee --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 48199a0c1e54d75528ee860c425a2235c4df1fee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-03 08:45:13,930 truncating revision to first 12 chars 2016-03-03 08:45:13,930 Setting DEBUG logging. 2016-03-03 08:45:13,930 attempt 1/10 2016-03-03 08:45:13,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48199a0c1e54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 08:45:14,566 unpacking tar archive at: fx-team-48199a0c1e54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.872437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:14.744323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:14.744640) ========= echo 48199a0c1e54d75528ee860c425a2235c4df1fee in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'48199a0c1e54d75528ee860c425a2235c4df1fee'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 48199a0c1e54d75528ee860c425a2235c4df1fee program finished with exit code 0 elapsedTime=0.005432 script_repo_revision: '48199a0c1e54d75528ee860c425a2235c4df1fee' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:14.793100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:14.793381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 08:45:14.806377) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-03 08:45:14.806651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:14 INFO - MultiFileLogger online at 20160303 08:45:14 in /builds/slave/test 08:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:14 INFO - {'append_to_log': False, 08:45:14 INFO - 'base_work_dir': '/builds/slave/test', 08:45:14 INFO - 'blob_upload_branch': 'Fx-Team', 08:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:14 INFO - 'branch': 'Fx-Team', 08:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:14 INFO - 'config_files': ('talos/mac_config.py',), 08:45:14 INFO - 'default_actions': ('clobber', 08:45:14 INFO - 'read-buildbot-config', 08:45:14 INFO - 'download-and-extract', 08:45:14 INFO - 'populate-webroot', 08:45:14 INFO - 'create-virtualenv', 08:45:14 INFO - 'install', 08:45:14 INFO - 'run-tests'), 08:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:14 INFO - 'download_minidump_stackwalk': True, 08:45:14 INFO - 'download_symbols': 'ondemand', 08:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:14 INFO - 'installer_path': 'installer.exe', 08:45:14 INFO - 'log_level': 'info', 08:45:14 INFO - 'log_name': 'talos', 08:45:15 INFO - 'log_to_console': True, 08:45:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:45:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:45:15 INFO - 'opt_config_files': (), 08:45:15 INFO - 'pip_index': False, 08:45:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:45:15 INFO - 'cmd': ('bash', 08:45:15 INFO - '-c', 08:45:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:45:15 INFO - 'enabled': True, 08:45:15 INFO - 'halt_on_failure': False, 08:45:15 INFO - 'name': 'check_screen_resolution'},), 08:45:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:45:15 INFO - 'cmd': ('bash', 08:45:15 INFO - '-c', 08:45:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:45:15 INFO - 'enabled': True, 08:45:15 INFO - 'halt_on_failure': False, 08:45:15 INFO - 'name': 'check_screen_resolution'},), 08:45:15 INFO - 'run_cmd_checks_enabled': True, 08:45:15 INFO - 'sps_profile': False, 08:45:15 INFO - 'sps_profile_interval': 0, 08:45:15 INFO - 'suite': 'dromaeojs', 08:45:15 INFO - 'system_bits': '32', 08:45:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:15 INFO - 'title': 't-yosemite-r7-0013', 08:45:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:15 INFO - 'use_talos_json': True, 08:45:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:15 INFO - 'work_dir': 'build'} 08:45:15 INFO - ##### 08:45:15 INFO - ##### Running clobber step. 08:45:15 INFO - ##### 08:45:15 INFO - Running pre-action listener: _resource_record_pre_action 08:45:15 INFO - Running main action method: clobber 08:45:15 INFO - rmtree: /builds/slave/test/build 08:45:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - ##### 08:45:16 INFO - ##### Running read-buildbot-config step. 08:45:16 INFO - ##### 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: read_buildbot_config 08:45:16 INFO - Using buildbot properties: 08:45:16 INFO - { 08:45:16 INFO - "project": "", 08:45:16 INFO - "product": "firefox", 08:45:16 INFO - "script_repo_revision": "production", 08:45:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:45:16 INFO - "repository": "", 08:45:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:45:16 INFO - "buildid": "20160303065935", 08:45:16 INFO - "pgo_build": "False", 08:45:16 INFO - "basedir": "/builds/slave/test", 08:45:16 INFO - "buildnumber": 447, 08:45:16 INFO - "slavename": "t-yosemite-r7-0013", 08:45:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:45:16 INFO - "platform": "yosemite_r7", 08:45:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:45:16 INFO - "branch": "fx-team", 08:45:16 INFO - "repo_path": "integration/fx-team", 08:45:16 INFO - "revision": "48199a0c1e54d75528ee860c425a2235c4df1fee", 08:45:16 INFO - "stage_platform": "macosx64", 08:45:16 INFO - "builduid": "9b3645557a79406a88671634586cae2b", 08:45:16 INFO - "slavebuilddir": "test" 08:45:16 INFO - } 08:45:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - ##### 08:45:16 INFO - ##### Running download-and-extract step. 08:45:16 INFO - ##### 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: download_and_extract 08:45:16 INFO - mkdir: /builds/slave/test/build/tests 08:45: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')]} 08:45:16 INFO - https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 08:45:18 INFO - Downloaded 1277 bytes. 08:45:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:45:18 INFO - Using the following test package requirements: 08:45:18 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:45:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:45:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:45:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'jsshell-mac.zip'], 08:45:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:45:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:45:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:45:18 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:45:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:45:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:45:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:45:18 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:45:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:18 INFO - https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:45:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:45:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:45:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:19 INFO - Downloaded 17855114 bytes. 08:45:19 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'] 08:45:19 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 08:45:22 INFO - Return code: 0 08:45:22 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 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:22 INFO - https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:45:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:45:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:45:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:25 INFO - Downloaded 17855114 bytes. 08:45:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:45:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:45:28 INFO - Return code: 0 08:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:28 INFO - https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:45:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:45:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:45:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:29 INFO - Downloaded 10808282 bytes. 08:45:29 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'] 08:45:29 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 08:45:29 INFO - Return code: 0 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:29 INFO - https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EKJo8bOARgmpPb3U9blYUw/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 08:45:32 INFO - Downloaded 110946567 bytes. 08:45:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:45:32 INFO - mkdir: /builds/slave/test/properties 08:45:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:32 INFO - Contents: 08:45:32 INFO - build_url:https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:45:33 INFO - Running post-action listener: _resource_record_post_action 08:45:33 INFO - Running post-action listener: set_extra_try_arguments 08:45:33 INFO - ##### 08:45:33 INFO - ##### Running populate-webroot step. 08:45:33 INFO - ##### 08:45:33 INFO - Running pre-action listener: _resource_record_pre_action 08:45:33 INFO - Running main action method: populate_webroot 08:45:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:33 INFO - '--tppagecycles', 08:45:33 INFO - '7'], 08:45:33 INFO - 'tests': ['tsvgm']}}, 08:45:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:45:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:45:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'tests': ['damp', 'tps']}, 08:45:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['damp', 'tps']}, 08:45:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:45:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:33 INFO - 'other': {'tests': ['a11yr', 08:45:33 INFO - 'ts_paint', 08:45:33 INFO - 'tpaint', 08:45:33 INFO - 'sessionrestore', 08:45:33 INFO - 'sessionrestore_no_auto_restore']}, 08:45:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['a11yr', 08:45:33 INFO - 'ts_paint', 08:45:33 INFO - 'tpaint', 08:45:33 INFO - 'sessionrestore', 08:45:33 INFO - 'sessionrestore_no_auto_restore']}, 08:45:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['a11yr', 08:45:33 INFO - 'ts_paint', 08:45:33 INFO - 'tpaint', 08:45:33 INFO - 'sessionrestore', 08:45:33 INFO - 'sessionrestore_no_auto_restore']}, 08:45:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['a11yr', 08:45:33 INFO - 'ts_paint', 08:45:33 INFO - 'tpaint', 08:45:33 INFO - 'sessionrestore', 08:45:33 INFO - 'sessionrestore_no_auto_restore']}, 08:45:33 INFO - 'other_l64': {'tests': ['a11yr', 08:45:33 INFO - 'ts_paint', 08:45:33 INFO - 'tpaint', 08:45:33 INFO - 'sessionrestore', 08:45:33 INFO - 'sessionrestore_no_auto_restore']}, 08:45:33 INFO - 'other_nol64': {'tests': ['a11yr', 08:45:33 INFO - 'ts_paint', 08:45:33 INFO - 'tpaint', 08:45:33 INFO - 'sessionrestore', 08:45:33 INFO - 'sessionrestore_no_auto_restore']}, 08:45:33 INFO - 'svgr': {'tests': ['tsvgx', 08:45:33 INFO - 'tsvgr_opacity', 08:45:33 INFO - 'tart', 08:45:33 INFO - 'tscrollx', 08:45:33 INFO - 'cart']}, 08:45:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['tsvgx', 08:45:33 INFO - 'tsvgr_opacity', 08:45:33 INFO - 'tart', 08:45:33 INFO - 'tscrollx', 08:45:33 INFO - 'cart']}, 08:45:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'tests': ['tp5o']}, 08:45:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'talos_options': ['--e10s'], 08:45:33 INFO - 'tests': ['tp5o']}, 08:45:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'talos_options': ['--xperf_path', 08:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:33 INFO - 'tests': ['tp5n']}, 08:45:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:33 INFO - 'talos_options': ['--e10s', 08:45:33 INFO - '--xperf_path', 08:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:33 INFO - 'tests': ['tp5n']}}, 08:45:33 INFO - 'talos.zip': {'path': '', 08:45:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:33 INFO - Running post-action listener: _resource_record_post_action 08:45:33 INFO - ##### 08:45:33 INFO - ##### Running create-virtualenv step. 08:45:33 INFO - ##### 08:45:33 INFO - Running pre-action listener: _resource_record_pre_action 08:45:33 INFO - Running main action method: create_virtualenv 08:45:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:33 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 08:45:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:34 INFO - Using real prefix '/tools/python27' 08:45:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:37 INFO - Installing pip.................done. 08:45:37 INFO - Return code: 0 08:45:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:37 INFO - 'HOME': '/Users/cltbld', 08:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:37 INFO - 'LOGNAME': 'cltbld', 08:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:37 INFO - 'MOZ_NO_REMOTE': '1', 08:45:37 INFO - 'NO_EM_RESTART': '1', 08:45:37 INFO - 'PAGER': '/bin/cat', 08:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:37 INFO - 'PWD': '/builds/slave/test', 08:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:37 INFO - 'SHELL': '/bin/bash', 08:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:37 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:37 INFO - 'USER': 'cltbld', 08:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:37 INFO - 'XPC_FLAGS': '0x0', 08:45:37 INFO - 'XPC_SERVICE_NAME': '0', 08:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:37 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 08:45:37 INFO - Cleaning up... 08:45:37 INFO - Return code: 0 08:45:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:37 INFO - 'HOME': '/Users/cltbld', 08:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:37 INFO - 'LOGNAME': 'cltbld', 08:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:37 INFO - 'MOZ_NO_REMOTE': '1', 08:45:37 INFO - 'NO_EM_RESTART': '1', 08:45:37 INFO - 'PAGER': '/bin/cat', 08:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:37 INFO - 'PWD': '/builds/slave/test', 08:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:37 INFO - 'SHELL': '/bin/bash', 08:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:37 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:37 INFO - 'USER': 'cltbld', 08:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:37 INFO - 'XPC_FLAGS': '0x0', 08:45:37 INFO - 'XPC_SERVICE_NAME': '0', 08:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:38 INFO - Downloading/unpacking psutil>=0.7.1 08:45:38 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 08:45:38 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 08:45:38 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 08:45:38 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 08:45:38 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 08:45:38 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 08:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:40 INFO - Installing collected packages: psutil 08:45:40 INFO - Running setup.py install for psutil 08:45:41 INFO - building 'psutil._psutil_osx' extension 08:45:41 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 08:45:41 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 08:45:41 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 08:45:41 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 08:45:41 INFO - building 'psutil._psutil_posix' extension 08:45:41 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 08:45:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:45:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:45:41 INFO - ^ 08:45:41 INFO - 1 warning generated. 08:45:41 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 08:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:42 INFO - Successfully installed psutil 08:45:42 INFO - Cleaning up... 08:45:42 INFO - Return code: 0 08:45:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:42 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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:42 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 08:45:42 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 08:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:42 INFO - 'HOME': '/Users/cltbld', 08:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:42 INFO - 'LOGNAME': 'cltbld', 08:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:42 INFO - 'MOZ_NO_REMOTE': '1', 08:45:42 INFO - 'NO_EM_RESTART': '1', 08:45:42 INFO - 'PAGER': '/bin/cat', 08:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:42 INFO - 'PWD': '/builds/slave/test', 08:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:42 INFO - 'SHELL': '/bin/bash', 08:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:42 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:42 INFO - 'USER': 'cltbld', 08:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:42 INFO - 'XPC_FLAGS': '0x0', 08:45:42 INFO - 'XPC_SERVICE_NAME': '0', 08:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:45:42 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 08:45:42 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 08:45:42 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 08:45:42 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 08:45:42 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 08:45:42 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 08:45:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:45:44 INFO - Installing collected packages: mozsystemmonitor 08:45:44 INFO - Running setup.py install for mozsystemmonitor 08:45:44 INFO - Successfully installed mozsystemmonitor 08:45:44 INFO - Cleaning up... 08:45:45 INFO - Return code: 0 08:45:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:45 INFO - 'HOME': '/Users/cltbld', 08:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:45 INFO - 'LOGNAME': 'cltbld', 08:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:45 INFO - 'MOZ_NO_REMOTE': '1', 08:45:45 INFO - 'NO_EM_RESTART': '1', 08:45:45 INFO - 'PAGER': '/bin/cat', 08:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:45 INFO - 'PWD': '/builds/slave/test', 08:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:45 INFO - 'SHELL': '/bin/bash', 08:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:45 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:45 INFO - 'USER': 'cltbld', 08:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:45 INFO - 'XPC_FLAGS': '0x0', 08:45:45 INFO - 'XPC_SERVICE_NAME': '0', 08:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:45 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:47 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:47 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 08:45:47 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 08:45:47 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 08:45:47 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 08:45:47 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 08:45:47 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 08:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:48 INFO - Downloading docopt-0.6.1.tar.gz 08:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:48 INFO - Running setup.py install for blobuploader 08:45:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:49 INFO - Running setup.py install for requests 08:45:49 INFO - Running setup.py install for docopt 08:45:49 INFO - Successfully installed blobuploader requests docopt 08:45:49 INFO - Cleaning up... 08:45:49 INFO - Return code: 0 08:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:49 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')]} 08:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:49 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')]} 08:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:49 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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:49 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 08:45:49 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 08:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:49 INFO - 'HOME': '/Users/cltbld', 08:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:49 INFO - 'LOGNAME': 'cltbld', 08:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:49 INFO - 'MOZ_NO_REMOTE': '1', 08:45:49 INFO - 'NO_EM_RESTART': '1', 08:45:49 INFO - 'PAGER': '/bin/cat', 08:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:49 INFO - 'PWD': '/builds/slave/test', 08:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:49 INFO - 'SHELL': '/bin/bash', 08:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:49 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:49 INFO - 'USER': 'cltbld', 08:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:49 INFO - 'XPC_FLAGS': '0x0', 08:45:49 INFO - 'XPC_SERVICE_NAME': '0', 08:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-JiSATb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rmgLCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-76xfV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-cM9Lmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-9h7yWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hrUdiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1djZlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-QhDRdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-aaK7Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:50 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-cb2Ooo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YuNozk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-TTCfvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xaxp9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Y4A4av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xqw7Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-N2ikbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:51 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-FfgnWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:51 INFO - Running setup.py install for manifestparser 08:45:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:51 INFO - Running setup.py install for mozcrash 08:45:52 INFO - Running setup.py install for mozdebug 08:45:52 INFO - Running setup.py install for mozdevice 08:45:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Running setup.py install for mozfile 08:45:52 INFO - Running setup.py install for mozhttpd 08:45:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Running setup.py install for mozinfo 08:45:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Running setup.py install for mozInstall 08:45:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:52 INFO - Running setup.py install for mozleak 08:45:53 INFO - Running setup.py install for mozlog 08:45:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:53 INFO - Running setup.py install for moznetwork 08:45:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:53 INFO - Running setup.py install for mozprocess 08:45:53 INFO - Running setup.py install for mozprofile 08:45:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:53 INFO - Running setup.py install for mozrunner 08:45:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:53 INFO - Running setup.py install for mozscreenshot 08:45:54 INFO - Running setup.py install for moztest 08:45:54 INFO - Running setup.py install for mozversion 08:45:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:54 INFO - Cleaning up... 08:45:54 INFO - Return code: 0 08:45:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:54 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')]} 08:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:54 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')]} 08:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:54 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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:54 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 08:45:54 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 08:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:54 INFO - 'HOME': '/Users/cltbld', 08:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:54 INFO - 'LOGNAME': 'cltbld', 08:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:54 INFO - 'MOZ_NO_REMOTE': '1', 08:45:54 INFO - 'NO_EM_RESTART': '1', 08:45:54 INFO - 'PAGER': '/bin/cat', 08:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:54 INFO - 'PWD': '/builds/slave/test', 08:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:54 INFO - 'SHELL': '/bin/bash', 08:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:54 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:54 INFO - 'USER': 'cltbld', 08:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:54 INFO - 'XPC_FLAGS': '0x0', 08:45:54 INFO - 'XPC_SERVICE_NAME': '0', 08:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:54 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-bDJGkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:54 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)) 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:54 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-OTPfS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:54 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)) 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:54 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-sHtv1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:54 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)) 08:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:54 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-QEFSNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Tto3Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-EpWZgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-G8SNl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6OscTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-zHRe5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-vBjhHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-O8fRCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-dxJIJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:55 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-w0x2Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Fa3aWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-t7tY6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-a04F3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:56 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mafObG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:56 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 08:45:56 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 08:45:56 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 08:45:56 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 08:45:56 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 08:45:56 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 08:45:58 INFO - Downloading blessings-1.6.tar.gz 08:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:58 INFO - Installing collected packages: blessings 08:45:58 INFO - Running setup.py install for blessings 08:45:58 INFO - Successfully installed blessings 08:45:58 INFO - Cleaning up... 08:45:59 INFO - Return code: 0 08:45:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:59 INFO - Reading from file tmpfile_stdout 08:45:59 INFO - Current package versions: 08:45:59 INFO - blessings == 1.6 08:45:59 INFO - blobuploader == 1.2.4 08:45:59 INFO - docopt == 0.6.1 08:45:59 INFO - manifestparser == 1.1 08:45:59 INFO - mozInstall == 1.12 08:45:59 INFO - mozcrash == 0.16 08:45:59 INFO - mozdebug == 0.1 08:45:59 INFO - mozdevice == 0.48 08:45:59 INFO - mozfile == 1.2 08:45:59 INFO - mozhttpd == 0.7 08:45:59 INFO - mozinfo == 0.9 08:45:59 INFO - mozleak == 0.1 08:45:59 INFO - mozlog == 3.1 08:45:59 INFO - moznetwork == 0.27 08:45:59 INFO - mozprocess == 0.22 08:45:59 INFO - mozprofile == 0.28 08:45:59 INFO - mozrunner == 6.11 08:45:59 INFO - mozscreenshot == 0.1 08:45:59 INFO - mozsystemmonitor == 0.0 08:45:59 INFO - moztest == 0.7 08:45:59 INFO - mozversion == 1.4 08:45:59 INFO - psutil == 3.1.1 08:45:59 INFO - requests == 1.2.3 08:45:59 INFO - wsgiref == 0.1.2 08:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:59 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')]} 08:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 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')]} 08:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:59 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 08:45:59 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 08:45:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:59 INFO - 'HOME': '/Users/cltbld', 08:45:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:59 INFO - 'LOGNAME': 'cltbld', 08:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:59 INFO - 'MOZ_NO_REMOTE': '1', 08:45:59 INFO - 'NO_EM_RESTART': '1', 08:45:59 INFO - 'PAGER': '/bin/cat', 08:45:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:59 INFO - 'PWD': '/builds/slave/test', 08:45:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:59 INFO - 'SHELL': '/bin/bash', 08:45:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:59 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:59 INFO - 'USER': 'cltbld', 08:45:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:59 INFO - 'XPC_FLAGS': '0x0', 08:45:59 INFO - 'XPC_SERVICE_NAME': '0', 08:45:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 INFO - Cleaning up... 08:45:59 INFO - Return code: 0 08:45:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:59 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')]} 08:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 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')]} 08:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:45:59 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 08:45:59 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 08:45:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:45:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:59 INFO - 'HOME': '/Users/cltbld', 08:45:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:59 INFO - 'LOGNAME': 'cltbld', 08:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:59 INFO - 'MOZ_NO_REMOTE': '1', 08:45:59 INFO - 'NO_EM_RESTART': '1', 08:45:59 INFO - 'PAGER': '/bin/cat', 08:45:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:59 INFO - 'PWD': '/builds/slave/test', 08:45:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:59 INFO - 'SHELL': '/bin/bash', 08:45:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:45:59 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:45:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:59 INFO - 'USER': 'cltbld', 08:45:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:59 INFO - 'XPC_FLAGS': '0x0', 08:45:59 INFO - 'XPC_SERVICE_NAME': '0', 08:45:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:59 INFO - Downloading/unpacking jsonschema 08:45:59 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 08:45:59 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 08:45:59 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 08:45:59 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 08:45:59 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 08:45:59 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 08:46:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:02 INFO - Downloading/unpacking functools32 (from jsonschema) 08:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:02 INFO - warning: no files found matching '*.txt' 08:46:02 INFO - no previously-included directories found matching 'build' 08:46:02 INFO - no previously-included directories found matching 'dist' 08:46:02 INFO - no previously-included directories found matching '.git*' 08:46:02 INFO - Installing collected packages: jsonschema, functools32 08:46:02 INFO - Running setup.py install for functools32 08:46:02 INFO - warning: no files found matching '*.txt' 08:46:02 INFO - no previously-included directories found matching 'build' 08:46:02 INFO - no previously-included directories found matching 'dist' 08:46:02 INFO - no previously-included directories found matching '.git*' 08:46:02 INFO - Successfully installed jsonschema functools32 08:46:02 INFO - Cleaning up... 08:46:02 INFO - Return code: 0 08:46:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:46:02 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')]} 08:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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')]} 08:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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 0x100846a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10084e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaa24a0a00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, '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.6DloIEK2uE/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.1vhNCqW9B0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 08:46:02 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 08:46:02 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 08:46:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:46:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:02 INFO - 'HOME': '/Users/cltbld', 08:46:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:02 INFO - 'LOGNAME': 'cltbld', 08:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:02 INFO - 'MOZ_NO_REMOTE': '1', 08:46:02 INFO - 'NO_EM_RESTART': '1', 08:46:02 INFO - 'PAGER': '/bin/cat', 08:46:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:02 INFO - 'PWD': '/builds/slave/test', 08:46:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:02 INFO - 'SHELL': '/bin/bash', 08:46:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:46:02 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:46:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:02 INFO - 'USER': 'cltbld', 08:46:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:02 INFO - 'XPC_FLAGS': '0x0', 08:46:02 INFO - 'XPC_SERVICE_NAME': '0', 08:46:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:03 INFO - Downloading/unpacking flake8 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:46:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:46:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:46:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:06 INFO - no previously-included directories found matching 'docs/_build' 08:46:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:46:07 INFO - Running setup.py install for pep8 08:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:07 INFO - no previously-included directories found matching 'docs/_build' 08:46:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:46:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:46:07 INFO - Cleaning up... 08:46:07 INFO - Return code: 0 08:46:07 INFO - Running post-action listener: _resource_record_post_action 08:46:07 INFO - Running post-action listener: _start_resource_monitoring 08:46:07 INFO - Starting resource monitoring. 08:46:07 INFO - ##### 08:46:07 INFO - ##### Running install step. 08:46:07 INFO - ##### 08:46:07 INFO - Running pre-action listener: _resource_record_pre_action 08:46:07 INFO - Running main action method: install 08:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:07 INFO - Reading from file tmpfile_stdout 08:46:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:07 INFO - Reading from file tmpfile_stdout 08:46:07 INFO - Output received: 08:46:07 INFO - Usage: mozinstall [options] installer 08:46:07 INFO - Options: 08:46:07 INFO - -h, --help show this help message and exit 08:46:07 INFO - -d DEST, --destination=DEST 08:46:07 INFO - Directory to install application into. [default: 08:46:07 INFO - "/builds/slave/test"] 08:46:07 INFO - --app=APP Application being installed. [default: firefox] 08:46:07 INFO - mkdir: /builds/slave/test/build/application 08:46:07 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'] 08:46:07 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 08:46:41 INFO - Reading from file tmpfile_stdout 08:46:41 INFO - Output received: 08:46:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:46:41 INFO - Running post-action listener: _resource_record_post_action 08:46:41 INFO - ##### 08:46:41 INFO - ##### Running run-tests step. 08:46:41 INFO - ##### 08:46:41 INFO - Running pre-action listener: _resource_record_pre_action 08:46:41 INFO - Running main action method: run_tests 08:46:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:41 INFO - 2016-03-03 08:46:41.654 screenresolution[1640:7389] starting screenresolution argv=screenresolution get 08:46:41 INFO - 2016-03-03 08:46:41.657 screenresolution[1640:7389] Display 0: 1600x1200x32@60 08:46:41 INFO - 2016-03-03 08:46:41.663 screenresolution[1641:7392] starting screenresolution argv=screenresolution list 08:46:41 INFO - Available Modes on Display 0 08:46:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:41 INFO - Intel Iris: 08:46:41 INFO - Chipset Model: Intel Iris 08:46:41 INFO - Type: GPU 08:46:41 INFO - Bus: Built-In 08:46:41 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:41 INFO - Vendor: Intel (0x8086) 08:46:41 INFO - Device ID: 0x0a2e 08:46:41 INFO - Revision ID: 0x0009 08:46:41 INFO - Displays: 08:46:41 INFO - Display: 08:46:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:41 INFO - Display Serial Number: 1600x1200 60 08:46:41 INFO - Main Display: Yes 08:46:41 INFO - Mirror: Off 08:46:41 INFO - Online: Yes 08:46:41 INFO - Rotation: Supported 08:46:41 INFO - Return code: 0 08:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:41 INFO - Python 2.7.3 08:46:41 INFO - Return code: 0 08:46:41 INFO - grabbing minidump binary from tooltool 08:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:41 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 0x1006ead30>, '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 0x10050edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:41 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 08:46:41 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 08:46:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:41 INFO - Return code: 0 08:46:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:46:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:46:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:46:43 INFO - Return code: 0 08:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DloIEK2uE/Render', 08:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:43 INFO - 'HOME': '/Users/cltbld', 08:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:43 INFO - 'LOGNAME': 'cltbld', 08:46:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:43 INFO - 'MOZ_NO_REMOTE': '1', 08:46:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:43 INFO - 'NO_EM_RESTART': '1', 08:46:43 INFO - 'PAGER': '/bin/cat', 08:46:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:43 INFO - 'PWD': '/builds/slave/test', 08:46:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:43 INFO - 'SHELL': '/bin/bash', 08:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1vhNCqW9B0/Listeners', 08:46:43 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 08:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:43 INFO - 'USER': 'cltbld', 08:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:43 INFO - 'XPC_FLAGS': '0x0', 08:46:43 INFO - 'XPC_SERVICE_NAME': '0', 08:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:46:43 INFO - mozversion application_buildid: 20160303065935 08:46:43 INFO - mozversion application_changeset: 48199a0c1e54d75528ee860c425a2235c4df1fee 08:46:43 INFO - mozversion application_display_name: Nightly 08:46:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:43 INFO - mozversion application_name: Firefox 08:46:43 INFO - mozversion application_remotingname: firefox 08:46:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:46:43 INFO - mozversion application_vendor: Mozilla 08:46:43 INFO - mozversion application_version: 47.0a1 08:46:43 INFO - mozversion platform_buildid: 20160303065935 08:46:43 INFO - mozversion platform_changeset: 48199a0c1e54d75528ee860c425a2235c4df1fee 08:46:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:46:43 INFO - mozversion platform_version: 47.0a1 08:46:43 INFO - using testdate: 1457023603 08:46:43 INFO - actual date: 1457023603 08:46:43 INFO - starting webserver on 'localhost:49270' 08:46:43 INFO - SUITE-START | Running 2 tests 08:46:43 INFO - TEST-START | dromaeo_css 08:46:43 INFO - operating with platform_type : mac_ 08:46:43 INFO - Initialising browser for dromaeo_css test... 08:46:43 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpbBQR58/profile http://localhost:49270/getInfo.html) 08:46:46 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:46:46 INFO - PROCESS | 1659 | colorDepth:24 08:46:46 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:46:46 INFO - PROCESS | 1659 | __metrics 08:46:46 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:46:46 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:46 INFO - TEST-INFO | 1659: exit 0 08:46:46 INFO - Browser initialized. 08:46:46 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpbBQR58/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:58 INFO - PROCESS | 1662 | RSS: Main: 243658752 08:46:58 INFO - PROCESS | 1662 | 08:47:49 INFO - PROCESS | 1662 | 1457023669837 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] 08:49:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 08:50:01 INFO - PROCESS | 1662 | RSS: Main: 335687680 08:50:01 INFO - PROCESS | 1662 | 08:53:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 08:53:04 INFO - PROCESS | 1662 | RSS: Main: 379244544 08:53:04 INFO - PROCESS | 1662 | 08:56:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 08:56:07 INFO - PROCESS | 1662 | RSS: Main: 375021568 08:56:07 INFO - PROCESS | 1662 | 08:59:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 08:59:09 INFO - PROCESS | 1662 | RSS: Main: 329760768 08:59:09 INFO - PROCESS | 1662 | 09:02:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 09:02:13 INFO - PROCESS | 1662 | RSS: Main: 337932288 09:02:13 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:05:16 INFO - PROCESS | 1662 | RSS: Main: 381005824 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | __start_tp_report 09:05:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:05:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:05:16 INFO - PROCESS | 1662 | |i|pagename|runs| 09:05:16 INFO - PROCESS | 1662 | |0;dojo.html;3427.8800241991526;3506.719462443003;3532.116970757311;3536.345776031436;3578.4095624221986;5590.664560126395;5675.801346952858;5694.658320500773;5699;5702.57230707697;5736.2542869427025;5764.423557644233;5781.595288329819;5890.587658863881;5895.469407753301;5089.541941225289;5128.128218202895;5166.457521960197;5178.559822415099;5263.842084737464;5126.30794842697;5259.158534634459;5280.867978300535;5324.494173053573;5344.973275133639;5075.086484432801;5094.439611642716;5166.966606678679;5181.404138524081;5215.895682086375;5180.067587834188;5187.559057480119;5199.4800519948085;5206.427292997767;5223.895522089537;5141.177411614161;5157.896842063138;5166.974165129188;5205.687658740488;5240.397354304266;5539.196816461631;5640.943590564083;5644.379118296984;5651.886962260773;5760.2511673482595;6211.596246244025;6222.253329600431;6222.782202622931;6236.937630623726;6248.0003199487865;6204.906926396107;6249.156363890862;6262.342454042306;6266.749330026793;6274.749010039593;4747.691400058985;5752.2234498342605;5771.220885180489;5833.766649333979;5843.678597677083;6277.748890044347;6282.057691346335;6302.306746257908;6312.621242725451;6313.989761638116;6092.634441933409;6124;6171.783987560414;6185.165002724664;6189.164462797555;6119.502553941423;6167.105769663373;6250.40621141;6273.341299163522;6277;6182.969085154636;6189.412005859436;6200.81397558074;6218.19163508741;6218.409251121137;6096.02463605821;6221.253449585988;6222.471089957314;6234.2830574483605;6245.313015568284;4860.36815214027;4871.780769865364;4897.3878265216845;4901.485344038896;4912.582430493448;3604.7656902301264;4469.329600559942;4470.888227794331;4471.731696098244;4475.082608065339;5669.40471250521;5721.5136713379;5748.942510574924;5756.33802112754;5758.798442054508;6190.473809726133;6262.467690246289;6287.025511045796;6291.370862913764;6298.590591611531;5350.732463376816;5741.224934633855;5754.6547207167705;5765.336986246635;5798.391168927286;4764.8332308369045;5296.3379577552805;5360.16917377807;5367.114426119724;5370.892582148335;6251.218597675291;6294.276158241861;6307.873842523216;6308.495320374451;6312.495000399957;6269.247690277013;6284.3087260402235;6285.025820997753;6291.842703932438;6297.716602752796;6214.1921550198185;6259.812205633838;6261.843453913506;6300.495960323072;6506.902396464152;6135.07973803933;6158.384161583985;6159.692015399301;6160.661163636043;6173.629582225081;4798.592119669727;6242.250929888442;6249.437550620284;6250.812475625738;6267.529935254783;5901.970490147522;6014.548908831767;6056.091586262096;6114.724837382418;6142.140100386039;6031.276246850406;6034.849128771816;6042.335343112166;6053.545984051126;6062.454379105725;5926.318473375617;5935.109733540004;5938.406159384027;5947.256592925884;5955.67243801595;5973.432523910222;6029.457348838626;6104.633721976696;6114.998630375669;6145.340757995227;5792.565557583114;5801.216835727291;5810.01229790945;5814.186013957965;5848.830233953311 09:05:16 INFO - PROCESS | 1662 | |1;ext.html;490.03218643179747;574.1559906936801;585.4526018173009;631.5042691487183;638.2787450181295;38024.23951520968;38519.229615407676;38634;38654.806725966366;38754.80622596883;41188.79405602968;41649.58350416495;41691.58308416915;41716.37425438621;41761;9525.38085024473;9618.855717164213;9694;9748.853767193463;9785.412875227508;9524.571394287274;9667.419954802734;9676.467794271312;9680.273979451535;9689.90310096897;9761.267904907125;9844;9844.852327215098;9848.212143028577;9850.162736167398;9753.90246097537;9803.705888823346;9822.165115965116;9832.26258030647;9855.90144098557;9650.71047868558;9678.70963871085;9783.0706082922;9800;9823.066808653166;40018.59981400178;40383.39424908629;40389.79805100985;40434.191316173805;40453.78638640846;3143.5599016137758;3334.1164591383304;3573.249617580311;3750.306193354238;3791.1659434924272;28259.434811303658;29154.562681559793;29463.70536294631;29641.07178564296;29663.70336296631;2757.655293088364;2782.846943418111;2796.6644002719804;2838.9290267743263;2869.2826793301674;496619.9999999964;498822;499017;499955;500948;62436.687816560625;62520.687396562724;62971.68514157492;63055.6847215761;63109;47458.52541474541;59209.11186332208;68419;69467.65266173737;69564.65217673879;16136.112513811619;16284.267207975432;16322.510324690042;16334.264958076916;16351.018938863706;11509.136814738928;12514.311712855699;12590;12606.243625382323;12613.495460181673;16539.84221104511;19786;20248.392548223575;20270;20290.79709202889;7897.696880014733;8142.715004974797;8409.789755256168;8440.535770532557;8515.659373624985;850.8851305073736;950.2493030505962;990.1830989433602;1009.6420314676748;1093.092733031582;26648.866755666484;28151.71848281491;28603.713962860522;29160.56259156114;29322.413551729274;1094.7482079121846;1095.3097765805792;1126.853509043819;1141.9371934543515;1149.9655010349702;12217.572384966483;13995.720085598434;14418.711625767635;14558.980871339116;14781.482648107265;533251;535870;537144;538625;538993;56206.71896640491;56777.14834277489;56818;56827;56842.715786420806;1337.1575907178415;1422.886169106469;1433.125793266107;1458.4530800949644;1470.1840478534516;25321.100917430897;26658;28302.009429669863;28318.716812831608;28797.84808607716;43805.34291985686;44206.77896610496;44589.331160033275;44607.776961114985;44676.32985505155;319322;321000;322678;322762;323422;28167.43665126727;32374.514382283814;33242.501362479095;33258;33287.83356083204;40115.59884401118;40450;40682.59317406788;40941.38587921243;40980;33654.495182571794;33658.663413366536;33760.15599610029;34315.82842085774;34417.82791086029;33791.662083378855;33912.813051543075;34616.65383346134;34739;34985.300293994485;34683;35068.64931350654;35961.640383595826;36070.639293607775;36104.819475902455;30580;31420.68579314269;31465.8426707865;31480.842595786875;31613.103213807244;23059.769402305763;23726.644100338854;23849.523009539364;24088;24142 09:05:16 INFO - PROCESS | 1662 | |2;jquery.html;347.3799268306074;350.262697022767;354.1429740029129;358.6091160634907;360.11950780342073;19647.70528442073;19939.601207975833;21725.45686357842;21752.456188595293;21763.891180544077;20476;20857.478563035893;21121.47196320089;21135.682964755502;21155.894220528913;5574.665520068788;5819.941800582003;5885.941140588582;5895.4399332063385;5907.527397808187;4163.812628431728;4325.978370108161;5791.652500849962;6377.872442551146;6406.615603063831;6054.485368743662;6311.968440157816;6330.430261276484;6341.778037768679;6384.297727250022;6259.405356491126;6280.591761535486;6315.3684631536935;6315.557910946212;6316.842078948017;3721.218544105741;5253.9474605253845;5369.4630536946;5473.863153421156;5494.395616482184;24968;25034.749652503426;25108.372290692878;25405.74594254052;25410.364740881625;2238.2949370948263;2373.9406514837096;2403.062805505854;2733.6992930777596;2823.901163459269;14465.78301325481;14579.781303280459;14803.555893323217;14845.795606723901;15054.172020538866;1610.4524461682968;1699.0315520153517;1735.0717366209017;1735.5834599695982;1776.413783451458;98350;107040;108410.91589084166;109059;110204.4489777554;10168.440735759455;10250.487475626189;11066.336019838674;11130.662560862147;11176.832347514794;13470;13518.188908665512;13548.864511354957;13566;13596;8197.098319184885;8466.74599762008;8470.703525376583;8549.145085491402;8568.742937711879;8566.48601083937;8570.057293697688;8583.012953510426;8657.956710216535;8678.175573320525;3623.927521449556;4368.978155109267;4432.113577284556;4463.285874260103;4469.396631454777;1593.8884278100654;1727.084645138079;1783.0906237818806;1794.0670851157324;1844.2162081115473;914.7850255190025;916.3814425262921;935.7847695030181;941.4727752458508;948.5826236455937;18889.622207556047;19221.32725354606;19565.902170489342;19665.345178401018;20479.38561843147;890.3233542507741;959.7168835193495;971.6016433262329;1002.8044531316323;1020.9813151472179;10434.791304174027;10644.361338319726;10670.41312727792;10684.679459616069;10917.945410273056;635522;644606;645082;671245;675039;112330;112360;114446.42776786063;115833;115891;917.7659696777413;929.4284015330658;940.4075432477496;942.7266092833139;943.2124176312856;16570.668586628442;16758.413455528997;16866.241019153924;17110.572235694206;17119.48641540756;46752.7662361686;50029.74985125197;50721;51370;51701.48298516967;75962.3361954365;76546;77272.88634693502;77674;78194;6839.487038472234;8047.436679432383;8048.235417635316;8074.515529068275;8358.164183581594;10861.294015888941;11023.393713345522;13199.868001320248;13299.869511091665;13564.86435135636;7683.654235559525;11323.207375483636;11339.036181924628;11794.233374830608;11814.173007889365;10854.891451085388;11067.50196241155;11263.042641375574;11369.913961964807;11513.769724605294;11493;11612.129090318429;11725.941370293094;11792.528298868292;11811.291322520676;7532.623368831427;8084.434089613671;8116.675332986614;8152.184781521801;8349.791255218668;10162.593496260362;11426.2001659883;11684.532618695497;11759.647210583697;11808.82286765682 09:05:16 INFO - PROCESS | 1662 | |3;mootools.html;1379.7378498085357;1503.6616761228724;1530.1201808959847;1770.1591743921638;1958.383109320564;7874.645640946157;8521.957390213049;8672.91327086729;8677.869831952527;8690.435121717084;8434.578271086451;8688;8690.17443342883;8716.564171791417;8716.73849784506;2137.1665050630268;2386.59427897257;2390.988045059772;2419.7943174830116;2448.179859746987;2467.494163696447;2474.987625061872;2478.0707234786955;2478.876056197183;2479.801615870735;2391.309751671683;2407.0853075831246;2435.659007738918;2461.692288463942;2471.1968610201666;2142.2716276466076;2198.4503874031493;2203.768604296558;2427.927162185137;2455.1897873701637;2420.044082587368;2475.4553998120386;2478.3804048987754;2479.6776419065404;2481.8262721609494;8589.098144694779;8669.263112635434;8671.826563468758;8674.132586741338;8677.826443471095;5348.973255133738;5471.945280547184;5474.808381706661;5479.506844383985;5486.094794358926;3518.3842827505086;3520.559930008749;3619.8371073301764;3655.945160822563;3693.7229707772026;1032.102071198055;1051.9789604207872;1054.8734151901745;1057.1384321777803;1075.4022828715104;11803.350815705047;11861.703457413547;11881.821772673416;11898.58354957581;11901.583444579399;4742.288656701522;4773.66584339093;4828.710277383298;4842.6368022398465;4894.241392584155;10096.091351778376;10149.238807089498;10153.441560714084;10157.695269141937;10164.695059148238;5410.458954104637;5417.458254174551;5422.078246698071;5428.430014848384;5428.864278393072;4434.82260709568;4582.450105987303;4779.976100119547;4883.658143929891;4925.901481970341;3479.3737127317327;3791.450239715226;3912.295786758411;3935.74417662851;3947.782871942013;1278.7698214321326;1282.429318953057;1283.36473445645;1292.9224246545236;1293.540793018465;1050.8528805967171;1075.7902209069314;1077.0790973717515;1219.0978675779859;1354.3769865861616;7556.433267504959;7575.734849280248;7619.923800762032;7644.885326720104;7674.194209607911;431.87259758371357;501.19057721779063;508.20973386384526;509.4905094905095;519.6700095439423;5431.94077154951;6153.1693221415435;6229.875402491924;6297.779577714758;6298.401651843067;10217.846732299022;10709;10786.244962852681;10788.622398216181;10814.134869210444;10311.175105991502;10628.893711062945;10675.092617127631;10683.09193718527;10717.78564428707;8173;8286.544240066854;8320.916790832014;8364.665413383518;8379.036410812712;6725.9663701681175;7730.7680769577;7846.097698764487;7910.248526389983;7929.841403172019;9067.591958361758;9381.859272110787;9433.481158536071;9647.517624118625;9677.22582193437;9374.390664606779;9632.518374081128;9747.317687762072;9751.268654851056;9798.412095274307;5968.880622387441;6848.623325717133;7023.122109736283;7033.648317584202;7085.326893945067;8202.17978202175;8208.973878265217;8246.422750407413;8262.256396924306;8264.586770661323;6764.661766911733;6846.349596788297;6895.379415852597;6934.029235906876;7042.894356584758;7118.679659415235;7135.143782746104;7221.6750246238;7273.9636301818155;7285.23505031964;7437.070366204224;7581.203973582695;7710.653020614198;7710.92289077102;7723.691052358067;6972.616506092214;6989.825254368681;7037;7040.0847889774;7051.400630946427;7069.787906362817;7113.039739635083;7115.928840711526;7138.964305178441;7159.713611455483 09:05:16 INFO - PROCESS | 1662 | |4;prototype.html;273.90550260160245;314.67745560800176;322.1286420233268;325.81265772181;330.39042965728225;5810.941890581093;5980.25246844145;6392.296847346794;6696.296888826676;6748.156480439945;6514.41370276675;6531.379518945704;6595.868082638344;6596.439302659268;6625.50308726845;4537.591616754491;4617.607503362218;4632.536746325357;4648.395708557883;4829.661923665345;3798.772073675588;4664.486906440289;4666.183417901871;4713.952860471403;4717.551832575899;3947.54603220629;4461.107778444308;4649.674522783406;4661.836835710751;4666.4400271967415;4508.317551057115;4663.743494107823;4670.392848929634;4672.813087476497;4696.38946936896;3918.45141680165;3942.073612701013;3955.259685738266;3957.584453632385;3981.3430783920617;6219.40915613016;6259.155014073087;6266.342034086447;6283.905741413882;6325.588836725644;4424.933625995613;5102.36220472441;5544.833654990357;5546.528545073674;5553.000459917213;6908.896366554506;6911.5853048817235;6915.446764258847;6921.550099243533;6934.861302773917;4281.978590107061;4458.554144585515;4462.799174037176;4473.194824931511;4483.39474170986;6627.801165965029;7165.570065796069;7337.339639432424;7357.926420735777;7361.4846960712775;3981.5023122109737;4485.080558485568;4519.209138400766;4522.66080043998;4531.84138555149;4362.105768317488;4629.745364005012;4633.328167415706;4634.629229661619;4647.697899636512;5498.890022199614;5501.202325662836;5507.531859791962;5511.173324001352;5514.6691198528215;6681;6972.1284839395075;6976.93023069773;6986.860262794818;6986.895196572055;1573.433563916989;1610.3075677458805;1615.0713339829645;1615.668787898478;1615.927283272232;1000.3047881722279;1012.8126296635146;1022.4887556221889;1034.4638212254795;1037.865077539915;6577.177852768404;6588.901166482507;6608.603483790988;6611.7685880994895;6651.534392592569;7087.61018144007;7149.82125446868;7232.0598322217775;7281.381082608038;7300.671469783872;6663.933770596778;6690.096836926952;6698.8995165072565;6705.4970877184405;6710.429613482908;3818.9618103818607;3858.7298889078056;3860.652541271299;3860.9806950965067;3870.767753934773;6584.703688334036;7176.856462870714;7567.167611562723;7607.31534161917;7621.237876212334;7180;7432.479726419098;7438.5536867788105;7450.143233528105;7456.1798202197715;7620.009398778124;7653.005109335751;7673.462857599914;7674.76975690719;7675.808104797425;7156.069710937545;7320.780376588711;7322.670479828314;7327.63361831917;7331.340179383881;6023.849403764941;6899.724011039703;7198.460115491254;7199.71201151948;7207;7601.65792539326;7621.237876212334;7644.503107298008;7697.345725613385;7708.075030996316;4719.528047195253;4773.71357718538;4775.952240477551;4786.16242157614;4788.353572267699;7209.891851622125;7211.819704507429;7211.819704507429;7218.89171662415;7218.927810722035;6783.21992970795;6954.79135625932;6959;6962.094927659372;6967.059446974594;6931.1682598088555;6954.095967524189;6999.090118284794;7002.859942801014;7005.124359455068;6872.896906546306;6917.7232910685025;6918.965405172942;6927.411170050401;6928.411085057826;7090.290970902868;7093.184283807222;7097.858042839218;7098.219195888551;7109.2179860216365;5420.337245906409;6798.558093723892;6913.204981426999;6927.861442771217;6928.861422771617 09:05:16 INFO - PROCESS | 1662 | |5;yui.html;575.7754475754457;708.5713143548155;722.73981366708;724.4602770935651;783.0251337085333;14953.252337383128;15132.470363537279;15135.848641513581;15142.394304227832;15146.015508991908;13809.24049177295;13850.307484625779;13869.306534673276;13880.652983675413;13914.51299204528;695.5756988237172;703.9792301163308;850.7958090058388;852.0074113657613;872.9786150204244;858.2147335188296;864.576357584782;873.8689196620494;874.6632546469623;874.8906386701663;912.8265629530401;923.5751554285036;924.5053896165552;925.1349987761464;926.1525703980849;735.3455424672046;745.8060904164902;746.1046743907306;746.1121265693861;909.8953620333647;666.4401902402005;680.5644387591896;680.9591424514545;683.3883674111643;683.7606837606847;14799.334029968677;14838.925805371013;14843.851561484464;14877.702445951021;14911.552653420415;12640.810387844098;12660.366981650881;12747.704385733003;12967.157134786303;13099.803502947463;9886.752831179207;10013.048760367827;10129.746756331077;10149.188064954786;10389.220808439397;3494.5806503219524;3526.7354948378975;3554.964450355489;3557.928841423183;3631.2011357501306;78298.21701782967;78499.60750196212;78597.21402785956;78661.60669196617;78719;8694.91305086941;9476.678213837517;9624.470654114091;9759.804803903882;9895.208383329316;20420;20677.58644827125;20694.793052069286;20696.79303206979;20703.585928281653;7516.2125163623705;7625.961870190614;7649.541027538366;7660.655270512841;7762.961185194151;4042.3936409538805;4127.876163715094;4143.97928010358;4161.0845613964875;4317.56824317572;3424.417848965682;3448.1552019755322;3458.8962331130106;3463;3465.7920524768597;617.9783707570214;627.6422439209698;628.2335550628226;638.450932198309;639.4756299834185;528.875714207161;579.4668904607771;588.9028310328748;610.118378942424;627.4917316973266;7963.203679632106;8072.192780721881;8204.15143824446;8233.752987410388;8289.171082891784;536.7772374464554;564.2495481010328;582.1645938078785;589.9587028907936;606.2088973889029;2871.956920646192;3744.2324323513612;3745.2135051638916;3847.5382954045135;3955.8417663293144;89247.21505569853;91072;91582;91949.5402522983;93465;70150.64924675446;72602.63698681473;72628.63685681538;74881.87677184846;76119.47761044749;63989.68005159945;67262.99105513422;67435.32564674389;68652.656736716;69029;8454.915450845412;8499.660013599387;8549.358798090043;8594.31245500371;8716.825663486821;48012.03975920532;49085.2637210435;49171;49178;50892.236616451526;61338.38661613327;66061.66969165123;69565.30434695588;70469;74059.62970185114;10859.945700271448;10935;10982.780344393228;11150.275232109887;11346.489407976496;11829.003147120557;11963;12010.159288849696;12407.813882791585;12435.44040518197;11179.496922638338;11304;11403.372814495282;11548.25306516952;11711.297322160697;11358.375289359165;11391.829122563335;11726.94136529312;11839.763204735686;11855.525778968744;11272.549098036316;11311.208215424842;11358.60244891425;12174.634760957186;12219.327936963553;9395.342326037111;9401.798423775475;9472.668456603986;9726.70819875405;9734.123928846439;8794;9199.35604507678;9542.666006689733;9767.462789546644;10041.748956276151 09:05:16 INFO - PROCESS | 1662 | __end_tp_report 09:05:16 INFO - PROCESS | 1662 | __start_cc_report 09:05:16 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1183 09:05:16 INFO - PROCESS | 1662 | __end_cc_report 09:05:16 INFO - PROCESS | 1662 | __startTimestamp1457024716614__endTimestamp 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:05:16 INFO - PROCESS | 1662 | Number of tests: 6 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5720.57 Median:5926.32 stddev:647.24 (10.9%) stddev-sans-first:623.74 09:05:16 INFO - PROCESS | 1662 | Values: 3427.9 3506.7 3532.1 3536.3 3578.4 5590.7 5675.8 5694.7 5699.0 5702.6 5736.3 5764.4 5781.6 5890.6 5895.5 5089.5 5128.1 5166.5 5178.6 5263.8 5126.3 5259.2 5280.9 5324.5 5345.0 5075.1 5094.4 5167.0 5181.4 5215.9 5180.1 5187.6 5199.5 5206.4 5223.9 5141.2 5157.9 5167.0 5205.7 5240.4 5539.2 5640.9 5644.4 5651.9 5760.3 6211.6 6222.3 6222.8 6236.9 6248.0 6204.9 6249.2 6262.3 6266.7 6274.7 4747.7 5752.2 5771.2 5833.8 5843.7 6277.7 6282.1 6302.3 6312.6 6314.0 6092.6 6124.0 6171.8 6185.2 6189.2 6119.5 6167.1 6250.4 6273.3 6277.0 6183.0 6189.4 6200.8 6218.2 6218.4 6096.0 6221.3 6222.5 6234.3 6245.3 4860.4 4871.8 4897.4 4901.5 4912.6 3604.8 4469.3 4470.9 4471.7 4475.1 5669.4 5721.5 5748.9 5756.3 5758.8 6190.5 6262.5 6287.0 6291.4 6298.6 5350.7 5741.2 5754.7 5765.3 5798.4 4764.8 5296.3 5360.2 5367.1 5370.9 6251.2 6294.3 6307.9 6308.5 6312.5 6269.2 6284.3 6285.0 6291.8 6297.7 6214.2 6259.8 6261.8 6300.5 6506.9 6135.1 6158.4 6159.7 6160.7 6173.6 4798.6 6242.3 6249.4 6250.8 6267.5 5902.0 6014.5 6056.1 6114.7 6142.1 6031.3 6034.8 6042.3 6053.5 6062.5 5926.3 5935.1 5938.4 5947.3 5955.7 5973.4 6029.5 6104.6 6115.0 6145.3 5792.6 5801.2 5810.0 5814.2 5848.8 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59755.16 Median:3770.74 stddev:123049.21 (3263.3%) stddev-sans-first:123313.94 09:05:16 INFO - PROCESS | 1662 | Values: 490.0 574.2 585.5 631.5 638.3 38024.2 38519.2 38634.0 38654.8 38754.8 41188.8 41649.6 41691.6 41716.4 41761.0 9525.4 9618.9 9694.0 9748.9 9785.4 9524.6 9667.4 9676.5 9680.3 9689.9 9761.3 9844.0 9844.9 9848.2 9850.2 9753.9 9803.7 9822.2 9832.3 9855.9 9650.7 9678.7 9783.1 9800.0 9823.1 40018.6 40383.4 40389.8 40434.2 40453.8 3143.6 3334.1 3573.2 3750.3 3791.2 28259.4 29154.6 29463.7 29641.1 29663.7 2757.7 2782.8 2796.7 2838.9 2869.3 496620.0 498822.0 499017.0 499955.0 500948.0 62436.7 62520.7 62971.7 63055.7 63109.0 47458.5 59209.1 68419.0 69467.7 69564.7 16136.1 16284.3 16322.5 16334.3 16351.0 11509.1 12514.3 12590.0 12606.2 12613.5 16539.8 19786.0 20248.4 20270.0 20290.8 7897.7 8142.7 8409.8 8440.5 8515.7 850.9 950.2 990.2 1009.6 1093.1 26648.9 28151.7 28603.7 29160.6 29322.4 1094.7 1095.3 1126.9 1141.9 1150.0 12217.6 13995.7 14418.7 14559.0 14781.5 533251.0 535870.0 537144.0 538625.0 538993.0 56206.7 56777.1 56818.0 56827.0 56842.7 1337.2 1422.9 1433.1 1458.5 1470.2 25321.1 26658.0 28302.0 28318.7 28797.8 43805.3 44206.8 44589.3 44607.8 44676.3 319322.0 321000.0 322678.0 322762.0 323422.0 28167.4 32374.5 33242.5 33258.0 33287.8 40115.6 40450.0 40682.6 40941.4 40980.0 33654.5 33658.7 33760.2 34315.8 34417.8 33791.7 33912.8 34616.7 34739.0 34985.3 34683.0 35068.6 35961.6 36070.6 36104.8 30580.0 31420.7 31465.8 31480.8 31613.1 23059.8 23726.6 23849.5 24088.0 24142.0 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35787.20 Median:25257.06 stddev:108196.40 (428.4%) stddev-sans-first:108467.19 09:05:16 INFO - PROCESS | 1662 | Values: 347.4 350.3 354.1 358.6 360.1 19647.7 19939.6 21725.5 21752.5 21763.9 20476.0 20857.5 21121.5 21135.7 21155.9 5574.7 5819.9 5885.9 5895.4 5907.5 4163.8 4326.0 5791.7 6377.9 6406.6 6054.5 6312.0 6330.4 6341.8 6384.3 6259.4 6280.6 6315.4 6315.6 6316.8 3721.2 5253.9 5369.5 5473.9 5494.4 24968.0 25034.7 25108.4 25405.7 25410.4 2238.3 2373.9 2403.1 2733.7 2823.9 14465.8 14579.8 14803.6 14845.8 15054.2 1610.5 1699.0 1735.1 1735.6 1776.4 98350.0 107040.0 108410.9 109059.0 110204.4 10168.4 10250.5 11066.3 11130.7 11176.8 13470.0 13518.2 13548.9 13566.0 13596.0 8197.1 8466.7 8470.7 8549.1 8568.7 8566.5 8570.1 8583.0 8658.0 8678.2 3623.9 4369.0 4432.1 4463.3 4469.4 1593.9 1727.1 1783.1 1794.1 1844.2 914.8 916.4 935.8 941.5 948.6 18889.6 19221.3 19565.9 19665.3 20479.4 890.3 959.7 971.6 1002.8 1021.0 10434.8 10644.4 10670.4 10684.7 10917.9 635522.0 644606.0 645082.0 671245.0 675039.0 112330.0 112360.0 114446.4 115833.0 115891.0 917.8 929.4 940.4 942.7 943.2 16570.7 16758.4 16866.2 17110.6 17119.5 46752.8 50029.7 50721.0 51370.0 51701.5 75962.3 76546.0 77272.9 77674.0 78194.0 6839.5 8047.4 8048.2 8074.5 8358.2 10861.3 11023.4 13199.9 13299.9 13564.9 7683.7 11323.2 11339.0 11794.2 11814.2 10854.9 11067.5 11263.0 11369.9 11513.8 11493.0 11612.1 11725.9 11792.5 11811.3 7532.6 8084.4 8116.7 8152.2 8349.8 10162.6 11426.2 11684.5 11759.6 11808.8 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5949.21 Median:5379.72 stddev:3183.51 (59.2%) stddev-sans-first:3173.91 09:05:16 INFO - PROCESS | 1662 | Values: 1379.7 1503.7 1530.1 1770.2 1958.4 7874.6 8522.0 8672.9 8677.9 8690.4 8434.6 8688.0 8690.2 8716.6 8716.7 2137.2 2386.6 2391.0 2419.8 2448.2 2467.5 2475.0 2478.1 2478.9 2479.8 2391.3 2407.1 2435.7 2461.7 2471.2 2142.3 2198.5 2203.8 2427.9 2455.2 2420.0 2475.5 2478.4 2479.7 2481.8 8589.1 8669.3 8671.8 8674.1 8677.8 5349.0 5471.9 5474.8 5479.5 5486.1 3518.4 3520.6 3619.8 3655.9 3693.7 1032.1 1052.0 1054.9 1057.1 1075.4 11803.4 11861.7 11881.8 11898.6 11901.6 4742.3 4773.7 4828.7 4842.6 4894.2 10096.1 10149.2 10153.4 10157.7 10164.7 5410.5 5417.5 5422.1 5428.4 5428.9 4434.8 4582.5 4780.0 4883.7 4925.9 3479.4 3791.5 3912.3 3935.7 3947.8 1278.8 1282.4 1283.4 1292.9 1293.5 1050.9 1075.8 1077.1 1219.1 1354.4 7556.4 7575.7 7619.9 7644.9 7674.2 431.9 501.2 508.2 509.5 519.7 5431.9 6153.2 6229.9 6297.8 6298.4 10217.8 10709.0 10786.2 10788.6 10814.1 10311.2 10628.9 10675.1 10683.1 10717.8 8173.0 8286.5 8320.9 8364.7 8379.0 6726.0 7730.8 7846.1 7910.2 7929.8 9067.6 9381.9 9433.5 9647.5 9677.2 9374.4 9632.5 9747.3 9751.3 9798.4 5968.9 6848.6 7023.1 7033.6 7085.3 8202.2 8209.0 8246.4 8262.3 8264.6 6764.7 6846.3 6895.4 6934.0 7042.9 7118.7 7135.1 7221.7 7274.0 7285.2 7437.1 7581.2 7710.7 7710.9 7723.7 6972.6 6989.8 7037.0 7040.1 7051.4 7069.8 7113.0 7115.9 7139.0 7159.7 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5683.15 Median:6596.15 stddev:1859.78 (28.2%) stddev-sans-first:1820.14 09:05:16 INFO - PROCESS | 1662 | Values: 273.9 314.7 322.1 325.8 330.4 5810.9 5980.3 6392.3 6696.3 6748.2 6514.4 6531.4 6595.9 6596.4 6625.5 4537.6 4617.6 4632.5 4648.4 4829.7 3798.8 4664.5 4666.2 4714.0 4717.6 3947.5 4461.1 4649.7 4661.8 4666.4 4508.3 4663.7 4670.4 4672.8 4696.4 3918.5 3942.1 3955.3 3957.6 3981.3 6219.4 6259.2 6266.3 6283.9 6325.6 4424.9 5102.4 5544.8 5546.5 5553.0 6908.9 6911.6 6915.4 6921.6 6934.9 4282.0 4458.6 4462.8 4473.2 4483.4 6627.8 7165.6 7337.3 7357.9 7361.5 3981.5 4485.1 4519.2 4522.7 4531.8 4362.1 4629.7 4633.3 4634.6 4647.7 5498.9 5501.2 5507.5 5511.2 5514.7 6681.0 6972.1 6976.9 6986.9 6986.9 1573.4 1610.3 1615.1 1615.7 1615.9 1000.3 1012.8 1022.5 1034.5 1037.9 6577.2 6588.9 6608.6 6611.8 6651.5 7087.6 7149.8 7232.1 7281.4 7300.7 6663.9 6690.1 6698.9 6705.5 6710.4 3819.0 3858.7 3860.7 3861.0 3870.8 6584.7 7176.9 7567.2 7607.3 7621.2 7180.0 7432.5 7438.6 7450.1 7456.2 7620.0 7653.0 7673.5 7674.8 7675.8 7156.1 7320.8 7322.7 7327.6 7331.3 6023.8 6899.7 7198.5 7199.7 7207.0 7601.7 7621.2 7644.5 7697.3 7708.1 4719.5 4773.7 4776.0 4786.2 4788.4 7209.9 7211.8 7211.8 7218.9 7218.9 6783.2 6954.8 6959.0 6962.1 6967.1 6931.2 6954.1 6999.1 7002.9 7005.1 6872.9 6917.7 6919.0 6927.4 6928.4 7090.3 7093.2 7097.9 7098.2 7109.2 5420.3 6798.6 6913.2 6927.9 6928.9 09:05:16 INFO - PROCESS | 1662 | 09:05:16 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17990.17 Median:30978.18 stddev:25034.20 (80.8%) stddev-sans-first:25070.27 09:05:16 INFO - PROCESS | 1662 | Values: 575.8 708.6 722.7 724.5 783.0 14953.3 15132.5 15135.8 15142.4 15146.0 13809.2 13850.3 13869.3 13880.7 13914.5 695.6 704.0 850.8 852.0 873.0 858.2 864.6 873.9 874.7 874.9 912.8 923.6 924.5 925.1 926.2 735.3 745.8 746.1 746.1 909.9 666.4 680.6 681.0 683.4 683.8 14799.3 14838.9 14843.9 14877.7 14911.6 12640.8 12660.4 12747.7 12967.2 13099.8 9886.8 10013.0 10129.7 10149.2 10389.2 3494.6 3526.7 3555.0 3557.9 3631.2 78298.2 78499.6 78597.2 78661.6 78719.0 8694.9 9476.7 9624.5 9759.8 9895.2 20420.0 20677.6 20694.8 20696.8 20703.6 7516.2 7626.0 7649.5 7660.7 7763.0 4042.4 4127.9 4144.0 4161.1 4317.6 3424.4 3448.2 3458.9 3463.0 3465.8 618.0 627.6 628.2 638.5 639.5 528.9 579.5 588.9 610.1 627.5 7963.2 8072.2 8204.2 8233.8 8289.2 536.8 564.2 582.2 590.0 606.2 2872.0 3744.2 3745.2 3847.5 3955.8 89247.2 91072.0 91582.0 91949.5 93465.0 70150.6 72602.6 72628.6 74881.9 76119.5 63989.7 67263.0 67435.3 68652.7 69029.0 8454.9 8499.7 8549.4 8594.3 8716.8 48012.0 49085.3 49171.0 49178.0 50892.2 61338.4 66061.7 69565.3 70469.0 74059.6 10859.9 10935.0 10982.8 11150.3 11346.5 11829.0 11963.0 12010.2 12407.8 12435.4 11179.5 11304.0 11403.4 11548.3 11711.3 11358.4 11391.8 11726.9 11839.8 11855.5 11272.5 11311.2 11358.6 12174.6 12219.3 9395.3 9401.8 9472.7 9726.7 9734.1 8794.0 9199.4 9542.7 9767.5 10041.7 09:05:16 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:05:16 INFO - PROCESS | 1662 | 09:05:17 INFO - TEST-INFO | 1662: exit 0 09:05:17 INFO - TEST-OK | dromaeo_css | took 1113438ms 09:05:17 INFO - TEST-START | kraken 09:05:17 INFO - operating with platform_type : mac_ 09:05:17 INFO - Initialising browser for kraken test... 09:05:17 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpVJRo3g/profile http://localhost:49270/getInfo.html) 09:05:19 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 09:05:19 INFO - PROCESS | 1671 | colorDepth:24 09:05:19 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 09:05:19 INFO - PROCESS | 1671 | __metrics 09:05:19 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:05:19 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:20 INFO - TEST-INFO | 1671: exit 0 09:05:20 INFO - Browser initialized. 09:05:20 INFO - Running cycle 1/1 for kraken test... 09:05:20 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpVJRo3g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:32 INFO - PROCESS | 1673 | RSS: Main: 242274304 09:05:32 INFO - PROCESS | 1673 | 09:05:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:35 INFO - PROCESS | 1673 | RSS: Main: 289480704 09:05:35 INFO - PROCESS | 1673 | 09:05:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:05:38 INFO - PROCESS | 1673 | RSS: Main: 299118592 09:05:38 INFO - PROCESS | 1673 | 09:05:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:05:42 INFO - PROCESS | 1673 | RSS: Main: 284610560 09:05:42 INFO - PROCESS | 1673 | 09:05:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:05:44 INFO - PROCESS | 1673 | RSS: Main: 286511104 09:05:44 INFO - PROCESS | 1673 | 09:05:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:47 INFO - PROCESS | 1673 | RSS: Main: 287256576 09:05:47 INFO - PROCESS | 1673 | 09:05:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:50 INFO - PROCESS | 1673 | RSS: Main: 287145984 09:05:50 INFO - PROCESS | 1673 | 09:05:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:54 INFO - PROCESS | 1673 | RSS: Main: 287035392 09:05:54 INFO - PROCESS | 1673 | 09:05:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:05:57 INFO - PROCESS | 1673 | RSS: Main: 288256000 09:05:57 INFO - PROCESS | 1673 | 09:05:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:59 INFO - PROCESS | 1673 | RSS: Main: 321802240 09:05:59 INFO - PROCESS | 1673 | 09:06:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:02 INFO - PROCESS | 1673 | RSS: Main: 322662400 09:06:02 INFO - PROCESS | 1673 | 09:06:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:04 INFO - PROCESS | 1673 | RSS: Main: 331571200 09:06:04 INFO - PROCESS | 1673 | 09:06:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:07 INFO - PROCESS | 1673 | RSS: Main: 331964416 09:06:07 INFO - PROCESS | 1673 | 09:06:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:11 INFO - PROCESS | 1673 | RSS: Main: 333275136 09:06:11 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:06:12 INFO - PROCESS | 1673 | RSS: Main: 393494528 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | __start_tp_report 09:06:12 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 09:06:12 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 09:06:12 INFO - PROCESS | 1673 | |i|pagename|runs| 09:06:12 INFO - PROCESS | 1673 | |0;ai-astar;110;106;110;108;111;108;114;110;115;123 09:06:12 INFO - PROCESS | 1673 | |1;audio-beat-detection;175;147;142;158;117;144;139;121;159;120 09:06:12 INFO - PROCESS | 1673 | |2;audio-dft;183;184;182;184;185;184;183;184;181;182 09:06:12 INFO - PROCESS | 1673 | |3;audio-fft;79;75;86;77;57;58;57;85;96;85 09:06:12 INFO - PROCESS | 1673 | |4;audio-oscillator;92;93;125;80;78;94;112;75;79;110 09:06:12 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;87;89;88;90;86;90;88;89;87 09:06:12 INFO - PROCESS | 1673 | |6;imaging-darkroom;94;94;95;95;93;94;94;94;94;94 09:06:12 INFO - PROCESS | 1673 | |7;imaging-desaturate;84;84;86;85;86;85;85;88;86;97 09:06:12 INFO - PROCESS | 1673 | |8;json-parse-financial;58;56;56;53;55;54;54;61;55;52 09:06:12 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;63;65;78;79;70;68;67;68;69;66 09:06:12 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;80;82;82;82;81;83;82;80;84;81 09:06:12 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;135;127;125;122;126;117;128;135;123;123 09:06:12 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;140;125;139;138;137;126;139;140;138;138 09:06:12 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;67;67;64;66;66;66;65;66;67;68 09:06:12 INFO - PROCESS | 1673 | __end_tp_report 09:06:12 INFO - PROCESS | 1673 | __start_cc_report 09:06:12 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1273 09:06:12 INFO - PROCESS | 1673 | __end_cc_report 09:06:12 INFO - PROCESS | 1673 | __startTimestamp1457024772969__endTimestamp 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | ------- Summary: start ------- 09:06:12 INFO - PROCESS | 1673 | Number of tests: 14 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:111.50 Median:110.50 stddev:4.86 (4.4%) stddev-sans-first:5.12 09:06:12 INFO - PROCESS | 1673 | Values: 110.0 106.0 110.0 108.0 111.0 108.0 114.0 110.0 115.0 123.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:145.50 stddev:18.92 (13.0%) stddev-sans-first:15.91 09:06:12 INFO - PROCESS | 1673 | Values: 175.0 147.0 142.0 158.0 117.0 144.0 139.0 121.0 159.0 120.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 09:06:12 INFO - PROCESS | 1673 | Values: 183.0 184.0 182.0 184.0 185.0 184.0 183.0 184.0 181.0 182.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:75.50 Median:82.00 stddev:13.81 (16.8%) stddev-sans-first:14.59 09:06:12 INFO - PROCESS | 1673 | Values: 79.0 75.0 86.0 77.0 57.0 58.0 57.0 85.0 96.0 85.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:79.50 stddev:16.94 (21.3%) stddev-sans-first:17.96 09:06:12 INFO - PROCESS | 1673 | Values: 92.0 93.0 125.0 80.0 78.0 94.0 112.0 75.0 79.0 110.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.34 (1.5%) stddev-sans-first:1.39 09:06:12 INFO - PROCESS | 1673 | Values: 89.0 87.0 89.0 88.0 90.0 86.0 90.0 88.0 89.0 87.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:06:12 INFO - PROCESS | 1673 | Values: 94.0 94.0 95.0 95.0 93.0 94.0 94.0 94.0 94.0 94.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:86.00 stddev:3.84 (4.5%) stddev-sans-first:3.95 09:06:12 INFO - PROCESS | 1673 | Values: 84.0 84.0 86.0 85.0 86.0 85.0 85.0 88.0 86.0 97.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.59 (4.7%) stddev-sans-first:2.57 09:06:12 INFO - PROCESS | 1673 | Values: 58.0 56.0 56.0 53.0 55.0 54.0 54.0 61.0 55.0 52.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:68.50 stddev:5.25 (7.7%) stddev-sans-first:5.05 09:06:12 INFO - PROCESS | 1673 | Values: 63.0 65.0 78.0 79.0 70.0 68.0 67.0 68.0 69.0 66.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.25 (1.5%) stddev-sans-first:1.17 09:06:12 INFO - PROCESS | 1673 | Values: 80.0 82.0 82.0 82.0 81.0 83.0 82.0 80.0 84.0 81.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.50 stddev:5.61 (4.4%) stddev-sans-first:4.94 09:06:12 INFO - PROCESS | 1673 | Values: 135.0 127.0 125.0 122.0 126.0 117.0 128.0 135.0 123.0 123.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:138.50 stddev:5.62 (4.1%) stddev-sans-first:5.77 09:06:12 INFO - PROCESS | 1673 | Values: 140.0 125.0 139.0 138.0 137.0 126.0 139.0 140.0 138.0 138.0 09:06:12 INFO - PROCESS | 1673 | 09:06:12 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 09:06:12 INFO - PROCESS | 1673 | Values: 67.0 67.0 64.0 66.0 66.0 66.0 65.0 66.0 67.0 68.0 09:06:12 INFO - PROCESS | 1673 | -------- Summary: end -------- 09:06:12 INFO - PROCESS | 1673 | 09:06:13 INFO - TEST-INFO | 1673: exit 0 09:06:13 INFO - TEST-OK | kraken | took 56425ms 09:06:13 INFO - SUITE-END | took 1169s 09:06:14 INFO - Completed test suite (00:19:30) 09:06:14 INFO - Working with test: dromaeo_css 09:06:14 INFO - Generating results file: dromaeo_css 09:06:14 INFO - Working with test: kraken 09:06:14 INFO - Generating results file: kraken 09:06:14 INFO - javascript benchmark 09:06:14 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 09:06:14 INFO - process_Request line: dromaeo_css 7437.60 graph.html#tests=[[72,64,59]] 09:06:14 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:14 INFO - process_Request line: kraken 1409.90 graph.html#tests=[[232,64,59]] 09:06:14 INFO - RETURN: dromaeo_css: 7437.60 09:06:14 INFO - RETURN: kraken: 1409.90 09:06:14 INFO - javascript benchmark 09:06:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3427.8800241991526, 3506.719462443003, 3532.116970757311, 3536.345776031436, 3578.4095624221986, 5590.664560126395, 5675.801346952858, 5694.658320500773, 5699.0, 5702.57230707697, 5736.2542869427025, 5764.423557644233, 5781.595288329819, 5890.587658863881, 5895.469407753301, 5089.541941225289, 5128.128218202895, 5166.457521960197, 5178.559822415099, 5263.842084737464, 5126.30794842697, 5259.158534634459, 5280.867978300535, 5324.494173053573, 5344.973275133639, 5075.086484432801, 5094.439611642716, 5166.966606678679, 5181.404138524081, 5215.895682086375, 5180.067587834188, 5187.559057480119, 5199.4800519948085, 5206.427292997767, 5223.895522089537, 5141.177411614161, 5157.896842063138, 5166.974165129188, 5205.687658740488, 5240.397354304266, 5539.196816461631, 5640.943590564083, 5644.379118296984, 5651.886962260773, 5760.2511673482595, 6211.596246244025, 6222.253329600431, 6222.782202622931, 6236.937630623726, 6248.0003199487865, 6204.906926396107, 6249.156363890862, 6262.342454042306, 6266.749330026793, 6274.749010039593, 4747.691400058985, 5752.2234498342605, 5771.220885180489, 5833.766649333979, 5843.678597677083, 6277.748890044347, 6282.057691346335, 6302.306746257908, 6312.621242725451, 6313.989761638116, 6092.634441933409, 6124.0, 6171.783987560414, 6185.165002724664, 6189.164462797555, 6119.502553941423, 6167.105769663373, 6250.40621141, 6273.341299163522, 6277.0, 6182.969085154636, 6189.412005859436, 6200.81397558074, 6218.19163508741, 6218.409251121137, 6096.02463605821, 6221.253449585988, 6222.471089957314, 6234.2830574483605, 6245.313015568284, 4860.36815214027, 4871.780769865364, 4897.3878265216845, 4901.485344038896, 4912.582430493448, 3604.7656902301264, 4469.329600559942, 4470.888227794331, 4471.731696098244, 4475.082608065339, 5669.40471250521, 5721.5136713379, 5748.942510574924, 5756.33802112754, 5758.798442054508, 6190.473809726133, 6262.467690246289, 6287.025511045796, 6291.370862913764, 6298.590591611531, 5350.732463376816, 5741.224934633855, 5754.6547207167705, 5765.336986246635, 5798.391168927286, 4764.8332308369045, 5296.3379577552805, 5360.16917377807, 5367.114426119724, 5370.892582148335, 6251.218597675291, 6294.276158241861, 6307.873842523216, 6308.495320374451, 6312.495000399957, 6269.247690277013, 6284.3087260402235, 6285.025820997753, 6291.842703932438, 6297.716602752796, 6214.1921550198185, 6259.812205633838, 6261.843453913506, 6300.495960323072, 6506.902396464152, 6135.07973803933, 6158.384161583985, 6159.692015399301, 6160.661163636043, 6173.629582225081, 4798.592119669727, 6242.250929888442, 6249.437550620284, 6250.812475625738, 6267.529935254783, 5901.970490147522, 6014.548908831767, 6056.091586262096, 6114.724837382418, 6142.140100386039, 6031.276246850406, 6034.849128771816, 6042.335343112166, 6053.545984051126, 6062.454379105725, 5926.318473375617, 5935.109733540004, 5938.406159384027, 5947.256592925884, 5955.67243801595, 5973.432523910222, 6029.457348838626, 6104.633721976696, 6114.998630375669, 6145.340757995227, 5792.565557583114, 5801.216835727291, 5810.01229790945, 5814.186013957965, 5848.830233953311], "unit": "score", "name": "dojo.html", "value": 5680.655507541509}, {"lowerIsBetter": false, "replicates": [490.03218643179747, 574.1559906936801, 585.4526018173009, 631.5042691487183, 638.2787450181295, 38024.23951520968, 38519.229615407676, 38634.0, 38654.806725966366, 38754.80622596883, 41188.79405602968, 41649.58350416495, 41691.58308416915, 41716.37425438621, 41761.0, 9525.38085024473, 9618.855717164213, 9694.0, 9748.853767193463, 9785.412875227508, 9524.571394287274, 9667.419954802734, 9676.467794271312, 9680.273979451535, 9689.90310096897, 9761.267904907125, 9844.0, 9844.852327215098, 9848.212143028577, 9850.162736167398, 9753.90246097537, 9803.705888823346, 9822.165115965116, 9832.26258030647, 9855.90144098557, 9650.71047868558, 9678.70963871085, 9783.0706082922, 9800.0, 9823.066808653166, 40018.59981400178, 40383.39424908629, 40389.79805100985, 40434.191316173805, 40453.78638640846, 3143.5599016137758, 3334.1164591383304, 3573.249617580311, 3750.306193354238, 3791.1659434924272, 28259.434811303658, 29154.562681559793, 29463.70536294631, 29641.07178564296, 29663.70336296631, 2757.655293088364, 2782.846943418111, 2796.6644002719804, 2838.9290267743263, 2869.2826793301674, 496619.9999999964, 498822.0, 499017.0, 499955.0, 500948.0, 62436.687816560625, 62520.687396562724, 62971.68514157492, 63055.6847215761, 63109.0, 47458.52541474541, 59209.11186332208, 68419.0, 69467.65266173737, 69564.65217673879, 16136.112513811619, 16284.267207975432, 16322.510324690042, 16334.264958076916, 16351.018938863706, 11509.136814738928, 12514.311712855699, 12590.0, 12606.243625382323, 12613.495460181673, 16539.84221104511, 19786.0, 20248.392548223575, 20270.0, 20290.79709202889, 7897.696880014733, 8142.715004974797, 8409.789755256168, 8440.535770532557, 8515.659373624985, 850.8851305073736, 950.2493030505962, 990.1830989433602, 1009.6420314676748, 1093.092733031582, 26648.866755666484, 28151.71848281491, 28603.713962860522, 29160.56259156114, 29322.413551729274, 1094.7482079121846, 1095.3097765805792, 1126.853509043819, 1141.9371934543515, 1149.9655010349702, 12217.572384966483, 13995.720085598434, 14418.711625767635, 14558.980871339116, 14781.482648107265, 533251.0, 535870.0, 537144.0, 538625.0, 538993.0, 56206.71896640491, 56777.14834277489, 56818.0, 56827.0, 56842.715786420806, 1337.1575907178415, 1422.886169106469, 1433.125793266107, 1458.4530800949644, 1470.1840478534516, 25321.100917430897, 26658.0, 28302.009429669863, 28318.716812831608, 28797.84808607716, 43805.34291985686, 44206.77896610496, 44589.331160033275, 44607.776961114985, 44676.32985505155, 319322.0, 321000.0, 322678.0, 322762.0, 323422.0, 28167.43665126727, 32374.514382283814, 33242.501362479095, 33258.0, 33287.83356083204, 40115.59884401118, 40450.0, 40682.59317406788, 40941.38587921243, 40980.0, 33654.495182571794, 33658.663413366536, 33760.15599610029, 34315.82842085774, 34417.82791086029, 33791.662083378855, 33912.813051543075, 34616.65383346134, 34739.0, 34985.300293994485, 34683.0, 35068.64931350654, 35961.640383595826, 36070.639293607775, 36104.819475902455, 30580.0, 31420.68579314269, 31465.8426707865, 31480.842595786875, 31613.103213807244, 23059.769402305763, 23726.644100338854, 23849.523009539364, 24088.0, 24142.0], "unit": "score", "name": "ext.html", "value": 19279.767437192997}, {"lowerIsBetter": false, "replicates": [347.3799268306074, 350.262697022767, 354.1429740029129, 358.6091160634907, 360.11950780342073, 19647.70528442073, 19939.601207975833, 21725.45686357842, 21752.456188595293, 21763.891180544077, 20476.0, 20857.478563035893, 21121.47196320089, 21135.682964755502, 21155.894220528913, 5574.665520068788, 5819.941800582003, 5885.941140588582, 5895.4399332063385, 5907.527397808187, 4163.812628431728, 4325.978370108161, 5791.652500849962, 6377.872442551146, 6406.615603063831, 6054.485368743662, 6311.968440157816, 6330.430261276484, 6341.778037768679, 6384.297727250022, 6259.405356491126, 6280.591761535486, 6315.3684631536935, 6315.557910946212, 6316.842078948017, 3721.218544105741, 5253.9474605253845, 5369.4630536946, 5473.863153421156, 5494.395616482184, 24968.0, 25034.749652503426, 25108.372290692878, 25405.74594254052, 25410.364740881625, 2238.2949370948263, 2373.9406514837096, 2403.062805505854, 2733.6992930777596, 2823.901163459269, 14465.78301325481, 14579.781303280459, 14803.555893323217, 14845.795606723901, 15054.172020538866, 1610.4524461682968, 1699.0315520153517, 1735.0717366209017, 1735.5834599695982, 1776.413783451458, 98350.0, 107040.0, 108410.91589084166, 109059.0, 110204.4489777554, 10168.440735759455, 10250.487475626189, 11066.336019838674, 11130.662560862147, 11176.832347514794, 13470.0, 13518.188908665512, 13548.864511354957, 13566.0, 13596.0, 8197.098319184885, 8466.74599762008, 8470.703525376583, 8549.145085491402, 8568.742937711879, 8566.48601083937, 8570.057293697688, 8583.012953510426, 8657.956710216535, 8678.175573320525, 3623.927521449556, 4368.978155109267, 4432.113577284556, 4463.285874260103, 4469.396631454777, 1593.8884278100654, 1727.084645138079, 1783.0906237818806, 1794.0670851157324, 1844.2162081115473, 914.7850255190025, 916.3814425262921, 935.7847695030181, 941.4727752458508, 948.5826236455937, 18889.622207556047, 19221.32725354606, 19565.902170489342, 19665.345178401018, 20479.38561843147, 890.3233542507741, 959.7168835193495, 971.6016433262329, 1002.8044531316323, 1020.9813151472179, 10434.791304174027, 10644.361338319726, 10670.41312727792, 10684.679459616069, 10917.945410273056, 635522.0, 644606.0, 645082.0, 671245.0, 675039.0, 112330.0, 112360.0, 114446.42776786063, 115833.0, 115891.0, 917.7659696777413, 929.4284015330658, 940.4075432477496, 942.7266092833139, 943.2124176312856, 16570.668586628442, 16758.413455528997, 16866.241019153924, 17110.572235694206, 17119.48641540756, 46752.7662361686, 50029.74985125197, 50721.0, 51370.0, 51701.48298516967, 75962.3361954365, 76546.0, 77272.88634693502, 77674.0, 78194.0, 6839.487038472234, 8047.436679432383, 8048.235417635316, 8074.515529068275, 8358.164183581594, 10861.294015888941, 11023.393713345522, 13199.868001320248, 13299.869511091665, 13564.86435135636, 7683.654235559525, 11323.207375483636, 11339.036181924628, 11794.233374830608, 11814.173007889365, 10854.891451085388, 11067.50196241155, 11263.042641375574, 11369.913961964807, 11513.769724605294, 11493.0, 11612.129090318429, 11725.941370293094, 11792.528298868292, 11811.291322520676, 7532.623368831427, 8084.434089613671, 8116.675332986614, 8152.184781521801, 8349.791255218668, 10162.593496260362, 11426.2001659883, 11684.532618695497, 11759.647210583697, 11808.82286765682], "unit": "score", "name": "jquery.html", "value": 9476.649981976232}, {"lowerIsBetter": false, "replicates": [1379.7378498085357, 1503.6616761228724, 1530.1201808959847, 1770.1591743921638, 1958.383109320564, 7874.645640946157, 8521.957390213049, 8672.91327086729, 8677.869831952527, 8690.435121717084, 8434.578271086451, 8688.0, 8690.17443342883, 8716.564171791417, 8716.73849784506, 2137.1665050630268, 2386.59427897257, 2390.988045059772, 2419.7943174830116, 2448.179859746987, 2467.494163696447, 2474.987625061872, 2478.0707234786955, 2478.876056197183, 2479.801615870735, 2391.309751671683, 2407.0853075831246, 2435.659007738918, 2461.692288463942, 2471.1968610201666, 2142.2716276466076, 2198.4503874031493, 2203.768604296558, 2427.927162185137, 2455.1897873701637, 2420.044082587368, 2475.4553998120386, 2478.3804048987754, 2479.6776419065404, 2481.8262721609494, 8589.098144694779, 8669.263112635434, 8671.826563468758, 8674.132586741338, 8677.826443471095, 5348.973255133738, 5471.945280547184, 5474.808381706661, 5479.506844383985, 5486.094794358926, 3518.3842827505086, 3520.559930008749, 3619.8371073301764, 3655.945160822563, 3693.7229707772026, 1032.102071198055, 1051.9789604207872, 1054.8734151901745, 1057.1384321777803, 1075.4022828715104, 11803.350815705047, 11861.703457413547, 11881.821772673416, 11898.58354957581, 11901.583444579399, 4742.288656701522, 4773.66584339093, 4828.710277383298, 4842.6368022398465, 4894.241392584155, 10096.091351778376, 10149.238807089498, 10153.441560714084, 10157.695269141937, 10164.695059148238, 5410.458954104637, 5417.458254174551, 5422.078246698071, 5428.430014848384, 5428.864278393072, 4434.82260709568, 4582.450105987303, 4779.976100119547, 4883.658143929891, 4925.901481970341, 3479.3737127317327, 3791.450239715226, 3912.295786758411, 3935.74417662851, 3947.782871942013, 1278.7698214321326, 1282.429318953057, 1283.36473445645, 1292.9224246545236, 1293.540793018465, 1050.8528805967171, 1075.7902209069314, 1077.0790973717515, 1219.0978675779859, 1354.3769865861616, 7556.433267504959, 7575.734849280248, 7619.923800762032, 7644.885326720104, 7674.194209607911, 431.87259758371357, 501.19057721779063, 508.20973386384526, 509.4905094905095, 519.6700095439423, 5431.94077154951, 6153.1693221415435, 6229.875402491924, 6297.779577714758, 6298.401651843067, 10217.846732299022, 10709.0, 10786.244962852681, 10788.622398216181, 10814.134869210444, 10311.175105991502, 10628.893711062945, 10675.092617127631, 10683.09193718527, 10717.78564428707, 8173.0, 8286.544240066854, 8320.916790832014, 8364.665413383518, 8379.036410812712, 6725.9663701681175, 7730.7680769577, 7846.097698764487, 7910.248526389983, 7929.841403172019, 9067.591958361758, 9381.859272110787, 9433.481158536071, 9647.517624118625, 9677.22582193437, 9374.390664606779, 9632.518374081128, 9747.317687762072, 9751.268654851056, 9798.412095274307, 5968.880622387441, 6848.623325717133, 7023.122109736283, 7033.648317584202, 7085.326893945067, 8202.17978202175, 8208.973878265217, 8246.422750407413, 8262.256396924306, 8264.586770661323, 6764.661766911733, 6846.349596788297, 6895.379415852597, 6934.029235906876, 7042.894356584758, 7118.679659415235, 7135.143782746104, 7221.6750246238, 7273.9636301818155, 7285.23505031964, 7437.070366204224, 7581.203973582695, 7710.653020614198, 7710.92289077102, 7723.691052358067, 6972.616506092214, 6989.825254368681, 7037.0, 7040.0847889774, 7051.400630946427, 7069.787906362817, 7113.039739635083, 7115.928840711526, 7138.964305178441, 7159.713611455483], "unit": "score", "name": "mootools.html", "value": 4749.966452909322}, {"lowerIsBetter": false, "replicates": [273.90550260160245, 314.67745560800176, 322.1286420233268, 325.81265772181, 330.39042965728225, 5810.941890581093, 5980.25246844145, 6392.296847346794, 6696.296888826676, 6748.156480439945, 6514.41370276675, 6531.379518945704, 6595.868082638344, 6596.439302659268, 6625.50308726845, 4537.591616754491, 4617.607503362218, 4632.536746325357, 4648.395708557883, 4829.661923665345, 3798.772073675588, 4664.486906440289, 4666.183417901871, 4713.952860471403, 4717.551832575899, 3947.54603220629, 4461.107778444308, 4649.674522783406, 4661.836835710751, 4666.4400271967415, 4508.317551057115, 4663.743494107823, 4670.392848929634, 4672.813087476497, 4696.38946936896, 3918.45141680165, 3942.073612701013, 3955.259685738266, 3957.584453632385, 3981.3430783920617, 6219.40915613016, 6259.155014073087, 6266.342034086447, 6283.905741413882, 6325.588836725644, 4424.933625995613, 5102.36220472441, 5544.833654990357, 5546.528545073674, 5553.000459917213, 6908.896366554506, 6911.5853048817235, 6915.446764258847, 6921.550099243533, 6934.861302773917, 4281.978590107061, 4458.554144585515, 4462.799174037176, 4473.194824931511, 4483.39474170986, 6627.801165965029, 7165.570065796069, 7337.339639432424, 7357.926420735777, 7361.4846960712775, 3981.5023122109737, 4485.080558485568, 4519.209138400766, 4522.66080043998, 4531.84138555149, 4362.105768317488, 4629.745364005012, 4633.328167415706, 4634.629229661619, 4647.697899636512, 5498.890022199614, 5501.202325662836, 5507.531859791962, 5511.173324001352, 5514.6691198528215, 6681.0, 6972.1284839395075, 6976.93023069773, 6986.860262794818, 6986.895196572055, 1573.433563916989, 1610.3075677458805, 1615.0713339829645, 1615.668787898478, 1615.927283272232, 1000.3047881722279, 1012.8126296635146, 1022.4887556221889, 1034.4638212254795, 1037.865077539915, 6577.177852768404, 6588.901166482507, 6608.603483790988, 6611.7685880994895, 6651.534392592569, 7087.61018144007, 7149.82125446868, 7232.0598322217775, 7281.381082608038, 7300.671469783872, 6663.933770596778, 6690.096836926952, 6698.8995165072565, 6705.4970877184405, 6710.429613482908, 3818.9618103818607, 3858.7298889078056, 3860.652541271299, 3860.9806950965067, 3870.767753934773, 6584.703688334036, 7176.856462870714, 7567.167611562723, 7607.31534161917, 7621.237876212334, 7180.0, 7432.479726419098, 7438.5536867788105, 7450.143233528105, 7456.1798202197715, 7620.009398778124, 7653.005109335751, 7673.462857599914, 7674.76975690719, 7675.808104797425, 7156.069710937545, 7320.780376588711, 7322.670479828314, 7327.63361831917, 7331.340179383881, 6023.849403764941, 6899.724011039703, 7198.460115491254, 7199.71201151948, 7207.0, 7601.65792539326, 7621.237876212334, 7644.503107298008, 7697.345725613385, 7708.075030996316, 4719.528047195253, 4773.71357718538, 4775.952240477551, 4786.16242157614, 4788.353572267699, 7209.891851622125, 7211.819704507429, 7211.819704507429, 7218.89171662415, 7218.927810722035, 6783.21992970795, 6954.79135625932, 6959.0, 6962.094927659372, 6967.059446974594, 6931.1682598088555, 6954.095967524189, 6999.090118284794, 7002.859942801014, 7005.124359455068, 6872.896906546306, 6917.7232910685025, 6918.965405172942, 6927.411170050401, 6928.411085057826, 7090.290970902868, 7093.184283807222, 7097.858042839218, 7098.219195888551, 7109.2179860216365, 5420.337245906409, 6798.558093723892, 6913.204981426999, 6927.861442771217, 6928.861422771617], "unit": "score", "name": "prototype.html", "value": 5055.681377164505}, {"lowerIsBetter": false, "replicates": [575.7754475754457, 708.5713143548155, 722.73981366708, 724.4602770935651, 783.0251337085333, 14953.252337383128, 15132.470363537279, 15135.848641513581, 15142.394304227832, 15146.015508991908, 13809.24049177295, 13850.307484625779, 13869.306534673276, 13880.652983675413, 13914.51299204528, 695.5756988237172, 703.9792301163308, 850.7958090058388, 852.0074113657613, 872.9786150204244, 858.2147335188296, 864.576357584782, 873.8689196620494, 874.6632546469623, 874.8906386701663, 912.8265629530401, 923.5751554285036, 924.5053896165552, 925.1349987761464, 926.1525703980849, 735.3455424672046, 745.8060904164902, 746.1046743907306, 746.1121265693861, 909.8953620333647, 666.4401902402005, 680.5644387591896, 680.9591424514545, 683.3883674111643, 683.7606837606847, 14799.334029968677, 14838.925805371013, 14843.851561484464, 14877.702445951021, 14911.552653420415, 12640.810387844098, 12660.366981650881, 12747.704385733003, 12967.157134786303, 13099.803502947463, 9886.752831179207, 10013.048760367827, 10129.746756331077, 10149.188064954786, 10389.220808439397, 3494.5806503219524, 3526.7354948378975, 3554.964450355489, 3557.928841423183, 3631.2011357501306, 78298.21701782967, 78499.60750196212, 78597.21402785956, 78661.60669196617, 78719.0, 8694.91305086941, 9476.678213837517, 9624.470654114091, 9759.804803903882, 9895.208383329316, 20420.0, 20677.58644827125, 20694.793052069286, 20696.79303206979, 20703.585928281653, 7516.2125163623705, 7625.961870190614, 7649.541027538366, 7660.655270512841, 7762.961185194151, 4042.3936409538805, 4127.876163715094, 4143.97928010358, 4161.0845613964875, 4317.56824317572, 3424.417848965682, 3448.1552019755322, 3458.8962331130106, 3463.0, 3465.7920524768597, 617.9783707570214, 627.6422439209698, 628.2335550628226, 638.450932198309, 639.4756299834185, 528.875714207161, 579.4668904607771, 588.9028310328748, 610.118378942424, 627.4917316973266, 7963.203679632106, 8072.192780721881, 8204.15143824446, 8233.752987410388, 8289.171082891784, 536.7772374464554, 564.2495481010328, 582.1645938078785, 589.9587028907936, 606.2088973889029, 2871.956920646192, 3744.2324323513612, 3745.2135051638916, 3847.5382954045135, 3955.8417663293144, 89247.21505569853, 91072.0, 91582.0, 91949.5402522983, 93465.0, 70150.64924675446, 72602.63698681473, 72628.63685681538, 74881.87677184846, 76119.47761044749, 63989.68005159945, 67262.99105513422, 67435.32564674389, 68652.656736716, 69029.0, 8454.915450845412, 8499.660013599387, 8549.358798090043, 8594.31245500371, 8716.825663486821, 48012.03975920532, 49085.2637210435, 49171.0, 49178.0, 50892.236616451526, 61338.38661613327, 66061.66969165123, 69565.30434695588, 70469.0, 74059.62970185114, 10859.945700271448, 10935.0, 10982.780344393228, 11150.275232109887, 11346.489407976496, 11829.003147120557, 11963.0, 12010.159288849696, 12407.813882791585, 12435.44040518197, 11179.496922638338, 11304.0, 11403.372814495282, 11548.25306516952, 11711.297322160697, 11358.375289359165, 11391.829122563335, 11726.94136529312, 11839.763204735686, 11855.525778968744, 11272.549098036316, 11311.208215424842, 11358.60244891425, 12174.634760957186, 12219.327936963553, 9395.342326037111, 9401.798423775475, 9472.668456603986, 9726.70819875405, 9734.123928846439, 8794.0, 9199.35604507678, 9542.666006689733, 9767.462789546644, 10041.748956276151], "unit": "score", "name": "yui.html", "value": 6790.996316803805}], "name": "dromaeo_css", "value": 7437.5932637504075}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 108.0, 111.0, 108.0, 114.0, 110.0, 115.0, 123.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [175.0, 147.0, 142.0, 158.0, 117.0, 144.0, 139.0, 121.0, 159.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 182.0, 184.0, 185.0, 184.0, 183.0, 184.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 86.0, 77.0, 57.0, 58.0, 57.0, 85.0, 96.0, 85.0], "unit": "score", "name": "audio-fft", "value": 75.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 125.0, 80.0, 78.0, 94.0, 112.0, 75.0, 79.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 88.0, 90.0, 86.0, 90.0, 88.0, 89.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 85.0, 86.0, 85.0, 85.0, 88.0, 86.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 53.0, 55.0, 54.0, 54.0, 61.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 78.0, 79.0, 70.0, 68.0, 67.0, 68.0, 69.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 82.0, 81.0, 83.0, 82.0, 80.0, 84.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [135.0, 127.0, 125.0, 122.0, 126.0, 117.0, 128.0, 135.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [140.0, 125.0, 139.0, 138.0, 137.0, 126.0, 139.0, 140.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 64.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1409.8999999999999}]} 09:06:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1409.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7437.60"}}} 09:06:14 INFO - Return code: 0 09:06:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:06:14 INFO - # TBPL SUCCESS # 09:06:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:14 INFO - 2016-03-03 09:06:14.859 screenresolution[1677:9665] starting screenresolution argv=screenresolution get 09:06:14 INFO - 2016-03-03 09:06:14.862 screenresolution[1677:9665] Display 0: 1600x1200x32@60 09:06:14 INFO - 2016-03-03 09:06:14.868 screenresolution[1678:9668] starting screenresolution argv=screenresolution list 09:06:14 INFO - Available Modes on Display 0 09:06:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:15 INFO - Intel Iris: 09:06:15 INFO - Chipset Model: Intel Iris 09:06:15 INFO - Type: GPU 09:06:15 INFO - Bus: Built-In 09:06:15 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:15 INFO - Vendor: Intel (0x8086) 09:06:15 INFO - Device ID: 0x0a2e 09:06:15 INFO - Revision ID: 0x0009 09:06:15 INFO - Displays: 09:06:15 INFO - Display: 09:06:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:15 INFO - Display Serial Number: 1600x1200 60 09:06:15 INFO - Main Display: Yes 09:06:15 INFO - Mirror: Off 09:06:15 INFO - Online: Yes 09:06:15 INFO - Rotation: Supported 09:06:15 INFO - Return code: 0 09:06:15 INFO - Running post-action listener: _resource_record_post_action 09:06:15 INFO - Running post-run listener: _resource_record_post_run 09:06:16 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39626240; Write bytes: 703888384; Read time: 420; Write time: 2447 09:06:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396579328; Write bytes: 390983168; Read time: 29952; Write time: 809 09:06:16 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37799424; Write bytes: 299212288; Read time: 400; Write time: 1605 09:06:16 INFO - Running post-run listener: _upload_blobber_files 09:06:16 INFO - Blob upload gear active. 09:06:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:16 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 09:06:16 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'] 09:06:16 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 09:06:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:06:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:06:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:17 INFO - (blobuploader) - INFO - Done attempting. 09:06:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:06:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:06:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:18 INFO - (blobuploader) - INFO - Done attempting. 09:06:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:18 INFO - Return code: 0 09:06:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a39b8c22c2f449fb9cf73160366a373c02d48301d724ed5dac038a476e11532f3f761b4b703ea768c90031f470c129425b53c8347cab8c5698d17a1f86b4be9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a40dd7be4024988e0ae2556b0a761786b6f62c316f474e858075de72b0416a89af14383e16639fad10fe47fa897bd9f12b9ccce6f6c1253ea6e421e48d40bd3"} 09:06:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:18 INFO - Contents: 09:06:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a39b8c22c2f449fb9cf73160366a373c02d48301d724ed5dac038a476e11532f3f761b4b703ea768c90031f470c129425b53c8347cab8c5698d17a1f86b4be9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a40dd7be4024988e0ae2556b0a761786b6f62c316f474e858075de72b0416a89af14383e16639fad10fe47fa897bd9f12b9ccce6f6c1253ea6e421e48d40bd3"} 09:06:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:18 INFO - Copying logs to upload dir... 09:06:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.165341 ========= master_lag: 5.84 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-03 09:06:24.813492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 9 secs) (at 2016-03-03 09:06:24.817202) ========= 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.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a39b8c22c2f449fb9cf73160366a373c02d48301d724ed5dac038a476e11532f3f761b4b703ea768c90031f470c129425b53c8347cab8c5698d17a1f86b4be9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a40dd7be4024988e0ae2556b0a761786b6f62c316f474e858075de72b0416a89af14383e16639fad10fe47fa897bd9f12b9ccce6f6c1253ea6e421e48d40bd3"} build_url:https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/EKJo8bOARgmpPb3U9blYUw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a39b8c22c2f449fb9cf73160366a373c02d48301d724ed5dac038a476e11532f3f761b4b703ea768c90031f470c129425b53c8347cab8c5698d17a1f86b4be9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a40dd7be4024988e0ae2556b0a761786b6f62c316f474e858075de72b0416a89af14383e16639fad10fe47fa897bd9f12b9ccce6f6c1253ea6e421e48d40bd3"}' ========= master_lag: 9.64 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 9 secs) (at 2016-03-03 09:06:34.467254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 16 secs) (at 2016-03-03 09:06:34.467540) ========= 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.6DloIEK2uE/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.1vhNCqW9B0/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005290 ========= master_lag: 16.75 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 16 secs) (at 2016-03-03 09:06:51.223512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:06:51.223819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 09:06:51.371987) ========= ========= Total master_lag: 32.38 =========