builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0136 starttime: 1455101277.34 results: success (0) buildid: 20160208164823 builduid: 30a40c8c361641e58b7426d55eb90c1e revision: 49945e5fe79e6cf2b083f56fd49d917ca886db0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.343138) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.343508) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.343791) ========= 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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005481 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.381846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.382120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.415553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.415823) ========= 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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005749 ========= master_lag: 0.29 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.715928) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.716188) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.716503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:57.716772) ========= 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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-10 02:47:57-- 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% 9.99M=0.001s 2016-02-10 02:47:58 (9.99 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.463701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.198195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.198510) ========= 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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.025908 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:58.247536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:47:58.247891) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 49945e5fe79e6cf2b083f56fd49d917ca886db0b --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 49945e5fe79e6cf2b083f56fd49d917ca886db0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-10 02:47:58,326 truncating revision to first 12 chars 2016-02-10 02:47:58,326 Setting DEBUG logging. 2016-02-10 02:47:58,326 attempt 1/10 2016-02-10 02:47:58,326 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/49945e5fe79e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 02:47:59,588 unpacking tar archive at: fx-team-49945e5fe79e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.510027 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 02:47:59.773047) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.773352) ========= echo 49945e5fe79e6cf2b083f56fd49d917ca886db0b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49945e5fe79e6cf2b083f56fd49d917ca886db0b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 49945e5fe79e6cf2b083f56fd49d917ca886db0b program finished with exit code 0 elapsedTime=0.005952 script_repo_revision: '49945e5fe79e6cf2b083f56fd49d917ca886db0b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.828352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.828659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 02:47:59.842355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-10 02:47:59.842690) ========= /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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:00 INFO - MultiFileLogger online at 20160210 02:48:00 in /builds/slave/test 02:48:00 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 02:48:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:00 INFO - {'append_to_log': False, 02:48:00 INFO - 'base_work_dir': '/builds/slave/test', 02:48:00 INFO - 'blob_upload_branch': 'Fx-Team', 02:48:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:00 INFO - 'branch': 'Fx-Team', 02:48:00 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:00 INFO - 'config_files': ('talos/mac_config.py',), 02:48:00 INFO - 'default_actions': ('clobber', 02:48:00 INFO - 'read-buildbot-config', 02:48:00 INFO - 'download-and-extract', 02:48:00 INFO - 'populate-webroot', 02:48:00 INFO - 'create-virtualenv', 02:48:00 INFO - 'install', 02:48:00 INFO - 'run-tests'), 02:48:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:00 INFO - 'download_minidump_stackwalk': True, 02:48:00 INFO - 'download_symbols': 'ondemand', 02:48:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:00 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:00 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:00 INFO - 'installer_path': 'installer.exe', 02:48:00 INFO - 'log_level': 'info', 02:48:00 INFO - 'log_name': 'talos', 02:48:00 INFO - 'log_to_console': True, 02:48:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:00 INFO - 'opt_config_files': (), 02:48:00 INFO - 'pip_index': False, 02:48:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:00 INFO - 'cmd': ('bash', 02:48:00 INFO - '-c', 02:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:00 INFO - 'enabled': True, 02:48:00 INFO - 'halt_on_failure': False, 02:48:00 INFO - 'name': 'check_screen_resolution'},), 02:48:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:00 INFO - 'cmd': ('bash', 02:48:00 INFO - '-c', 02:48:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:00 INFO - 'enabled': True, 02:48:00 INFO - 'halt_on_failure': False, 02:48:00 INFO - 'name': 'check_screen_resolution'},), 02:48:00 INFO - 'run_cmd_checks_enabled': True, 02:48:00 INFO - 'sps_profile': False, 02:48:00 INFO - 'sps_profile_interval': 0, 02:48:00 INFO - 'suite': 'dromaeojs', 02:48:00 INFO - 'system_bits': '32', 02:48:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:00 INFO - 'title': 't-yosemite-r7-0136', 02:48:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:00 INFO - 'use_talos_json': True, 02:48:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:00 INFO - 'work_dir': 'build'} 02:48:00 INFO - ##### 02:48:00 INFO - ##### Running clobber step. 02:48:00 INFO - ##### 02:48:00 INFO - Running pre-action listener: _resource_record_pre_action 02:48:00 INFO - Running main action method: clobber 02:48:00 INFO - rmtree: /builds/slave/test/build 02:48:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:01 INFO - Running post-action listener: _resource_record_post_action 02:48:01 INFO - ##### 02:48:01 INFO - ##### Running read-buildbot-config step. 02:48:01 INFO - ##### 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: read_buildbot_config 02:48:01 INFO - Using buildbot properties: 02:48:01 INFO - { 02:48:01 INFO - "project": "", 02:48:01 INFO - "product": "firefox", 02:48:01 INFO - "script_repo_revision": "production", 02:48:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:48:01 INFO - "repository": "", 02:48:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:48:01 INFO - "buildid": "20160208164823", 02:48:01 INFO - "pgo_build": "False", 02:48:01 INFO - "basedir": "/builds/slave/test", 02:48:01 INFO - "buildnumber": 361, 02:48:01 INFO - "slavename": "t-yosemite-r7-0136", 02:48:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:48:01 INFO - "platform": "yosemite_r7", 02:48:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:48:01 INFO - "branch": "fx-team", 02:48:01 INFO - "repo_path": "integration/fx-team", 02:48:01 INFO - "revision": "49945e5fe79e6cf2b083f56fd49d917ca886db0b", 02:48:01 INFO - "stage_platform": "macosx64", 02:48:01 INFO - "builduid": "30a40c8c361641e58b7426d55eb90c1e", 02:48:01 INFO - "slavebuilddir": "test" 02:48:01 INFO - } 02:48:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:48:01 INFO - Running post-action listener: _resource_record_post_action 02:48:01 INFO - ##### 02:48:01 INFO - ##### Running download-and-extract step. 02:48:01 INFO - ##### 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: download_and_extract 02:48:01 INFO - mkdir: /builds/slave/test/build/tests 02:48:01 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')]} 02:48:01 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:48:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:48:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json 02:48:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:48:02 INFO - Downloaded 1277 bytes. 02:48:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:48:02 INFO - Using the following test package requirements: 02:48:02 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:48:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:48:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:48:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'jsshell-mac.zip'], 02:48:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:48:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:48:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:48:02 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:48:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:48:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:48:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:48:02 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:48:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:48: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')]} 02:48:02 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:03 INFO - Downloaded 17753849 bytes. 02:48:03 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'] 02:48:03 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 02:48:06 INFO - Return code: 0 02:48:06 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 02:48:06 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')]} 02:48:06 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:07 INFO - Downloaded 17753849 bytes. 02:48:07 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'] 02:48:07 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 02:48:11 INFO - Return code: 0 02:48:11 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')]} 02:48:11 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:12 INFO - Downloaded 10706547 bytes. 02:48:12 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'] 02:48:12 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 02:48:12 INFO - Return code: 0 02:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:12 INFO - https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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 02:48:16 INFO - Downloaded 111836573 bytes. 02:48:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:16 INFO - mkdir: /builds/slave/test/properties 02:48:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:16 INFO - Contents: 02:48:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:48:17 INFO - Running post-action listener: _resource_record_post_action 02:48:17 INFO - Running post-action listener: set_extra_try_arguments 02:48:17 INFO - ##### 02:48:17 INFO - ##### Running populate-webroot step. 02:48:17 INFO - ##### 02:48:17 INFO - Running pre-action listener: _resource_record_pre_action 02:48:17 INFO - Running main action method: populate_webroot 02:48:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:17 INFO - '--tppagecycles', 02:48:17 INFO - '7'], 02:48:17 INFO - 'tests': ['tsvgm']}}, 02:48:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:48:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:48:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'tests': ['damp', 'tps']}, 02:48:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['damp', 'tps']}, 02:48:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:48:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:17 INFO - 'other': {'tests': ['a11yr', 02:48:17 INFO - 'ts_paint', 02:48:17 INFO - 'tpaint', 02:48:17 INFO - 'sessionrestore', 02:48:17 INFO - 'sessionrestore_no_auto_restore']}, 02:48:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['a11yr', 02:48:17 INFO - 'ts_paint', 02:48:17 INFO - 'tpaint', 02:48:17 INFO - 'sessionrestore', 02:48:17 INFO - 'sessionrestore_no_auto_restore']}, 02:48:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['a11yr', 02:48:17 INFO - 'ts_paint', 02:48:17 INFO - 'tpaint', 02:48:17 INFO - 'sessionrestore', 02:48:17 INFO - 'sessionrestore_no_auto_restore']}, 02:48:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['a11yr', 02:48:17 INFO - 'ts_paint', 02:48:17 INFO - 'tpaint', 02:48:17 INFO - 'sessionrestore', 02:48:17 INFO - 'sessionrestore_no_auto_restore']}, 02:48:17 INFO - 'other_l64': {'tests': ['a11yr', 02:48:17 INFO - 'ts_paint', 02:48:17 INFO - 'tpaint', 02:48:17 INFO - 'sessionrestore', 02:48:17 INFO - 'sessionrestore_no_auto_restore']}, 02:48:17 INFO - 'other_nol64': {'tests': ['a11yr', 02:48:17 INFO - 'ts_paint', 02:48:17 INFO - 'tpaint', 02:48:17 INFO - 'sessionrestore', 02:48:17 INFO - 'sessionrestore_no_auto_restore']}, 02:48:17 INFO - 'svgr': {'tests': ['tsvgx', 02:48:17 INFO - 'tsvgr_opacity', 02:48:17 INFO - 'tart', 02:48:17 INFO - 'tscrollx', 02:48:17 INFO - 'cart']}, 02:48:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['tsvgx', 02:48:17 INFO - 'tsvgr_opacity', 02:48:17 INFO - 'tart', 02:48:17 INFO - 'tscrollx', 02:48:17 INFO - 'cart']}, 02:48:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'tests': ['tp5o']}, 02:48:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'talos_options': ['--e10s'], 02:48:17 INFO - 'tests': ['tp5o']}, 02:48:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'talos_options': ['--xperf_path', 02:48:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:17 INFO - 'tests': ['tp5n']}, 02:48:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:17 INFO - 'talos_options': ['--e10s', 02:48:17 INFO - '--xperf_path', 02:48:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:17 INFO - 'tests': ['tp5n']}}, 02:48:17 INFO - 'talos.zip': {'path': '', 02:48:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:17 INFO - Running post-action listener: _resource_record_post_action 02:48:17 INFO - ##### 02:48:17 INFO - ##### Running create-virtualenv step. 02:48:17 INFO - ##### 02:48:17 INFO - Running pre-action listener: _resource_record_pre_action 02:48:17 INFO - Running main action method: create_virtualenv 02:48:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:17 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 02:48:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:17 INFO - Using real prefix '/tools/python27' 02:48:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:20 INFO - Installing pip.................done. 02:48:20 INFO - Return code: 0 02:48:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:20 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')]} 02:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:20 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')]} 02:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:20 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:20 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 02:48:20 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 02:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:20 INFO - 'HOME': '/Users/cltbld', 02:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:20 INFO - 'LOGNAME': 'cltbld', 02:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:20 INFO - 'MOZ_NO_REMOTE': '1', 02:48:20 INFO - 'NO_EM_RESTART': '1', 02:48:20 INFO - 'PAGER': '/bin/cat', 02:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:20 INFO - 'PWD': '/builds/slave/test', 02:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:20 INFO - 'SHELL': '/bin/bash', 02:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:20 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:20 INFO - 'USER': 'cltbld', 02:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:20 INFO - 'XPC_FLAGS': '0x0', 02:48:20 INFO - 'XPC_SERVICE_NAME': '0', 02:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:21 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 02:48:21 INFO - Cleaning up... 02:48:21 INFO - Return code: 0 02:48:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:21 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:21 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 02:48:21 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 02:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:21 INFO - 'HOME': '/Users/cltbld', 02:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:21 INFO - 'LOGNAME': 'cltbld', 02:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:21 INFO - 'MOZ_NO_REMOTE': '1', 02:48:21 INFO - 'NO_EM_RESTART': '1', 02:48:21 INFO - 'PAGER': '/bin/cat', 02:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:21 INFO - 'PWD': '/builds/slave/test', 02:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:21 INFO - 'SHELL': '/bin/bash', 02:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:21 INFO - 'USER': 'cltbld', 02:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:21 INFO - 'XPC_FLAGS': '0x0', 02:48:21 INFO - 'XPC_SERVICE_NAME': '0', 02:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:21 INFO - Downloading/unpacking psutil>=0.7.1 02:48:21 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 02:48:21 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 02:48:21 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 02:48:21 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 02:48:21 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 02:48:21 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 02:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:24 INFO - Installing collected packages: psutil 02:48:24 INFO - Running setup.py install for psutil 02:48:24 INFO - building 'psutil._psutil_osx' extension 02:48:24 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 02:48:25 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 02:48:25 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 02:48:25 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 02:48:25 INFO - building 'psutil._psutil_posix' extension 02:48:25 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 02:48:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:25 INFO - ^ 02:48:25 INFO - 1 warning generated. 02:48:25 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 02:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:25 INFO - Successfully installed psutil 02:48:25 INFO - Cleaning up... 02:48:25 INFO - Return code: 0 02:48:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:48:25 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')]} 02:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:25 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')]} 02:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:25 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:25 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 02:48:25 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 02:48:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:25 INFO - 'HOME': '/Users/cltbld', 02:48:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:25 INFO - 'LOGNAME': 'cltbld', 02:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:25 INFO - 'MOZ_NO_REMOTE': '1', 02:48:25 INFO - 'NO_EM_RESTART': '1', 02:48:25 INFO - 'PAGER': '/bin/cat', 02:48:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:25 INFO - 'PWD': '/builds/slave/test', 02:48:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:25 INFO - 'SHELL': '/bin/bash', 02:48:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:25 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:25 INFO - 'USER': 'cltbld', 02:48:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:25 INFO - 'XPC_FLAGS': '0x0', 02:48:25 INFO - 'XPC_SERVICE_NAME': '0', 02:48:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:48:28 INFO - Installing collected packages: mozsystemmonitor 02:48:28 INFO - Running setup.py install for mozsystemmonitor 02:48:28 INFO - Successfully installed mozsystemmonitor 02:48:28 INFO - Cleaning up... 02:48:28 INFO - Return code: 0 02:48:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:28 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 02:48:28 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 02:48:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:28 INFO - 'HOME': '/Users/cltbld', 02:48:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:28 INFO - 'LOGNAME': 'cltbld', 02:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:28 INFO - 'MOZ_NO_REMOTE': '1', 02:48:28 INFO - 'NO_EM_RESTART': '1', 02:48:28 INFO - 'PAGER': '/bin/cat', 02:48:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:28 INFO - 'PWD': '/builds/slave/test', 02:48:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:28 INFO - 'SHELL': '/bin/bash', 02:48:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:28 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:28 INFO - 'USER': 'cltbld', 02:48:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:28 INFO - 'XPC_FLAGS': '0x0', 02:48:28 INFO - 'XPC_SERVICE_NAME': '0', 02:48:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:28 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 02:48:28 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 02:48:28 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 02:48:28 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 02:48:28 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 02:48:28 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 02:48:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:32 INFO - Downloading docopt-0.6.1.tar.gz 02:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:32 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:32 INFO - Running setup.py install for blobuploader 02:48:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:32 INFO - Running setup.py install for requests 02:48:32 INFO - Running setup.py install for docopt 02:48:33 INFO - Successfully installed blobuploader requests docopt 02:48:33 INFO - Cleaning up... 02:48:33 INFO - Return code: 0 02:48:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:33 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:33 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 02:48:33 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 02:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:33 INFO - 'HOME': '/Users/cltbld', 02:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:33 INFO - 'LOGNAME': 'cltbld', 02:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:33 INFO - 'MOZ_NO_REMOTE': '1', 02:48:33 INFO - 'NO_EM_RESTART': '1', 02:48:33 INFO - 'PAGER': '/bin/cat', 02:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:33 INFO - 'PWD': '/builds/slave/test', 02:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:33 INFO - 'SHELL': '/bin/bash', 02:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:33 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:33 INFO - 'USER': 'cltbld', 02:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:33 INFO - 'XPC_FLAGS': '0x0', 02:48:33 INFO - 'XPC_SERVICE_NAME': '0', 02:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-idgDha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-fMR1D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-GG2q2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-xmFIaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-BwhKlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:33 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-zbqm1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-XOfKdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ObTKFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-xCdmWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EPo4X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-cAJAmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-_oEjNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-pGRcpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-tKxBf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-6195yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:34 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-CilNo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:35 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vnN4X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:35 INFO - Running setup.py install for manifestparser 02:48:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:35 INFO - Running setup.py install for mozcrash 02:48:35 INFO - Running setup.py install for mozdebug 02:48:35 INFO - Running setup.py install for mozdevice 02:48:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:35 INFO - Running setup.py install for mozfile 02:48:35 INFO - Running setup.py install for mozhttpd 02:48:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozinfo 02:48:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozInstall 02:48:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozleak 02:48:36 INFO - Running setup.py install for mozlog 02:48:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for moznetwork 02:48:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:36 INFO - Running setup.py install for mozprocess 02:48:36 INFO - Running setup.py install for mozprofile 02:48:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozrunner 02:48:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Running setup.py install for mozscreenshot 02:48:37 INFO - Running setup.py install for moztest 02:48:37 INFO - Running setup.py install for mozversion 02:48:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:37 INFO - Cleaning up... 02:48:37 INFO - Return code: 0 02:48:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:37 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:37 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 02:48:37 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 02:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:37 INFO - 'HOME': '/Users/cltbld', 02:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:37 INFO - 'LOGNAME': 'cltbld', 02:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:37 INFO - 'MOZ_NO_REMOTE': '1', 02:48:37 INFO - 'NO_EM_RESTART': '1', 02:48:37 INFO - 'PAGER': '/bin/cat', 02:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:37 INFO - 'PWD': '/builds/slave/test', 02:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:37 INFO - 'SHELL': '/bin/bash', 02:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:37 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:37 INFO - 'USER': 'cltbld', 02:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:37 INFO - 'XPC_FLAGS': '0x0', 02:48:37 INFO - 'XPC_SERVICE_NAME': '0', 02:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-0r6Ykr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-NFXBAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Kcwt3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-oxstF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-rZweCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LHqY4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Oopzpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-43QkMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Zh1awk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:38 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)) 02:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:38 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-rjfB0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-dIYw4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-1Dcrer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-DmGayR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vcsowF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EZ_y2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-rOPJh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:39 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)) 02:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Dh93eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:39 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)) 02:48:39 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)) 02:48:39 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)) 02:48:39 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)) 02:48:39 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)) 02:48:39 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)) 02:48:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:42 INFO - Downloading blessings-1.6.tar.gz 02:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:42 INFO - Installing collected packages: blessings 02:48:42 INFO - Running setup.py install for blessings 02:48:42 INFO - Successfully installed blessings 02:48:42 INFO - Cleaning up... 02:48:42 INFO - Return code: 0 02:48:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:42 INFO - Reading from file tmpfile_stdout 02:48:42 INFO - Current package versions: 02:48:42 INFO - blessings == 1.6 02:48:42 INFO - blobuploader == 1.2.4 02:48:42 INFO - docopt == 0.6.1 02:48:42 INFO - manifestparser == 1.1 02:48:42 INFO - mozInstall == 1.12 02:48:42 INFO - mozcrash == 0.16 02:48:42 INFO - mozdebug == 0.1 02:48:42 INFO - mozdevice == 0.48 02:48:42 INFO - mozfile == 1.2 02:48:42 INFO - mozhttpd == 0.7 02:48:42 INFO - mozinfo == 0.9 02:48:42 INFO - mozleak == 0.1 02:48:42 INFO - mozlog == 3.1 02:48:42 INFO - moznetwork == 0.27 02:48:42 INFO - mozprocess == 0.22 02:48:42 INFO - mozprofile == 0.28 02:48:42 INFO - mozrunner == 6.11 02:48:42 INFO - mozscreenshot == 0.1 02:48:42 INFO - mozsystemmonitor == 0.0 02:48:42 INFO - moztest == 0.7 02:48:42 INFO - mozversion == 1.4 02:48:42 INFO - psutil == 3.1.1 02:48:42 INFO - requests == 1.2.3 02:48:42 INFO - wsgiref == 0.1.2 02:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:42 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:42 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 02:48:42 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 02:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:42 INFO - 'HOME': '/Users/cltbld', 02:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PAGER': '/bin/cat', 02:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:42 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - 'XPC_FLAGS': '0x0', 02:48:42 INFO - 'XPC_SERVICE_NAME': '0', 02:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 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)) 02:48:42 INFO - Cleaning up... 02:48:42 INFO - Return code: 0 02:48:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48: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', 'jsonschema'] in /builds/slave/test/build 02:48: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 jsonschema 02:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:42 INFO - 'HOME': '/Users/cltbld', 02:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:42 INFO - 'LOGNAME': 'cltbld', 02:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:42 INFO - 'MOZ_NO_REMOTE': '1', 02:48:42 INFO - 'NO_EM_RESTART': '1', 02:48:42 INFO - 'PAGER': '/bin/cat', 02:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:42 INFO - 'PWD': '/builds/slave/test', 02:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:42 INFO - 'SHELL': '/bin/bash', 02:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:42 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:42 INFO - 'USER': 'cltbld', 02:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:42 INFO - 'XPC_FLAGS': '0x0', 02:48:42 INFO - 'XPC_SERVICE_NAME': '0', 02:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:43 INFO - Downloading/unpacking jsonschema 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:45 INFO - Downloading/unpacking functools32 (from jsonschema) 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:45 INFO - warning: no files found matching '*.txt' 02:48:45 INFO - no previously-included directories found matching 'build' 02:48:45 INFO - no previously-included directories found matching 'dist' 02:48:45 INFO - no previously-included directories found matching '.git*' 02:48:45 INFO - Installing collected packages: jsonschema, functools32 02:48:45 INFO - Running setup.py install for functools32 02:48:46 INFO - warning: no files found matching '*.txt' 02:48:46 INFO - no previously-included directories found matching 'build' 02:48:46 INFO - no previously-included directories found matching 'dist' 02:48:46 INFO - no previously-included directories found matching '.git*' 02:48:46 INFO - Successfully installed jsonschema functools32 02:48:46 INFO - Cleaning up... 02:48:46 INFO - Return code: 0 02:48:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:46 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 0x10eb3ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb434c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0385af460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, '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.zFfAwmEnzI/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.m1tjPOUwel/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 02:48:46 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 02:48:46 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 02:48:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:48:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:46 INFO - 'HOME': '/Users/cltbld', 02:48:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:46 INFO - 'LOGNAME': 'cltbld', 02:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:46 INFO - 'MOZ_NO_REMOTE': '1', 02:48:46 INFO - 'NO_EM_RESTART': '1', 02:48:46 INFO - 'PAGER': '/bin/cat', 02:48:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:46 INFO - 'PWD': '/builds/slave/test', 02:48:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:46 INFO - 'SHELL': '/bin/bash', 02:48:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:48:46 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:48:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:46 INFO - 'USER': 'cltbld', 02:48:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:46 INFO - 'XPC_FLAGS': '0x0', 02:48:46 INFO - 'XPC_SERVICE_NAME': '0', 02:48:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:46 INFO - Downloading/unpacking flake8 02:48:46 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 02:48:46 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 02:48:46 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 02:48:46 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 02:48:46 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 02:48:46 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 02:48:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:48:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:48:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 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 02:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:48:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:49 INFO - no previously-included directories found matching 'docs/_build' 02:48:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:48:50 INFO - Running setup.py install for pep8 02:48:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:48:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:48:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:48:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:48:50 INFO - no previously-included directories found matching 'docs/_build' 02:48:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:48:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:48:50 INFO - Cleaning up... 02:48:50 INFO - Return code: 0 02:48:50 INFO - Running post-action listener: _resource_record_post_action 02:48:50 INFO - Running post-action listener: _start_resource_monitoring 02:48:50 INFO - Starting resource monitoring. 02:48:50 INFO - ##### 02:48:50 INFO - ##### Running install step. 02:48:50 INFO - ##### 02:48:50 INFO - Running pre-action listener: _resource_record_pre_action 02:48:50 INFO - Running main action method: install 02:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:50 INFO - Reading from file tmpfile_stdout 02:48:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:50 INFO - Reading from file tmpfile_stdout 02:48:50 INFO - Output received: 02:48:50 INFO - Usage: mozinstall [options] installer 02:48:50 INFO - Options: 02:48:50 INFO - -h, --help show this help message and exit 02:48:50 INFO - -d DEST, --destination=DEST 02:48:50 INFO - Directory to install application into. [default: 02:48:50 INFO - "/builds/slave/test"] 02:48:50 INFO - --app=APP Application being installed. [default: firefox] 02:48:50 INFO - mkdir: /builds/slave/test/build/application 02:48:50 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'] 02:48:50 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 02:49:24 INFO - Reading from file tmpfile_stdout 02:49:24 INFO - Output received: 02:49:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:24 INFO - Running post-action listener: _resource_record_post_action 02:49:24 INFO - ##### 02:49:24 INFO - ##### Running run-tests step. 02:49:24 INFO - ##### 02:49:24 INFO - Running pre-action listener: _resource_record_pre_action 02:49:24 INFO - Running main action method: run_tests 02:49:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:24 INFO - 2016-02-10 02:49:24.982 screenresolution[1657:7909] starting screenresolution argv=screenresolution get 02:49:24 INFO - 2016-02-10 02:49:24.985 screenresolution[1657:7909] Display 0: 1600x1200x32@60 02:49:24 INFO - 2016-02-10 02:49:24.990 screenresolution[1658:7911] starting screenresolution argv=screenresolution list 02:49:24 INFO - Available Modes on Display 0 02:49:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:25 INFO - Intel Iris: 02:49:25 INFO - Chipset Model: Intel Iris 02:49:25 INFO - Type: GPU 02:49:25 INFO - Bus: Built-In 02:49:25 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:25 INFO - Vendor: Intel (0x8086) 02:49:25 INFO - Device ID: 0x0a2e 02:49:25 INFO - Revision ID: 0x0009 02:49:25 INFO - Displays: 02:49:25 INFO - Display: 02:49:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:25 INFO - Display Serial Number: 1600x1200 60 02:49:25 INFO - Main Display: Yes 02:49:25 INFO - Mirror: Off 02:49:25 INFO - Online: Yes 02:49:25 INFO - Rotation: Supported 02:49:25 INFO - Return code: 0 02:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:25 INFO - Python 2.7.3 02:49:25 INFO - Return code: 0 02:49:25 INFO - grabbing minidump binary from tooltool 02:49:25 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')]} 02:49:25 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 0x10e9dfd30>, '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 0x10e803db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9d6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:25 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 02:49:25 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 02:49:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:25 INFO - Return code: 0 02:49:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:49:26 INFO - Return code: 0 02:49:26 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 02:49:26 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 02:49:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zFfAwmEnzI/Render', 02:49:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:26 INFO - 'HOME': '/Users/cltbld', 02:49:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:26 INFO - 'LOGNAME': 'cltbld', 02:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:26 INFO - 'MOZ_NO_REMOTE': '1', 02:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:26 INFO - 'NO_EM_RESTART': '1', 02:49:26 INFO - 'PAGER': '/bin/cat', 02:49:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:26 INFO - 'PWD': '/builds/slave/test', 02:49:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:26 INFO - 'SHELL': '/bin/bash', 02:49:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1tjPOUwel/Listeners', 02:49:26 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 02:49:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:26 INFO - 'USER': 'cltbld', 02:49:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:26 INFO - 'XPC_FLAGS': '0x0', 02:49:26 INFO - 'XPC_SERVICE_NAME': '0', 02:49:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:26 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/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 02:49:26 INFO - mozversion application_buildid: 20160208164823 02:49:26 INFO - mozversion application_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:49:26 INFO - mozversion application_display_name: Nightly 02:49:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:26 INFO - mozversion application_name: Firefox 02:49:26 INFO - mozversion application_remotingname: firefox 02:49:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:49:26 INFO - mozversion application_vendor: Mozilla 02:49:26 INFO - mozversion application_version: 47.0a1 02:49:26 INFO - mozversion platform_buildid: 20160208164823 02:49:26 INFO - mozversion platform_changeset: 49945e5fe79e6cf2b083f56fd49d917ca886db0b 02:49:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:49:26 INFO - mozversion platform_version: 47.0a1 02:49:26 INFO - using testdate: 1455101366 02:49:26 INFO - actual date: 1455101366 02:49:26 INFO - starting webserver on 'localhost:49276' 02:49:26 INFO - SUITE-START | Running 2 tests 02:49:26 INFO - TEST-START | dromaeo_css 02:49:26 INFO - operating with platform_type : mac_ 02:49:26 INFO - Initialising browser for dromaeo_css test... 02:49:26 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp3fZRZE/profile http://localhost:49276/getInfo.html) 02:49:29 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 02:49:29 INFO - PROCESS | 1676 | colorDepth:24 02:49:29 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 02:49:29 INFO - PROCESS | 1676 | __metrics 02:49:29 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:49:29 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:29 INFO - TEST-INFO | 1676: exit 0 02:49:29 INFO - Browser initialized. 02:49:29 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:29 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp3fZRZE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:41 INFO - PROCESS | 1680 | RSS: Main: 245358592 02:49:41 INFO - PROCESS | 1680 | 02:50:32 INFO - PROCESS | 1680 | 1455101432676 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] 02:52:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:52:45 INFO - PROCESS | 1680 | RSS: Main: 362942464 02:52:45 INFO - PROCESS | 1680 | 02:55:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:55:48 INFO - PROCESS | 1680 | RSS: Main: 375984128 02:55:48 INFO - PROCESS | 1680 | 02:58:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:58:51 INFO - PROCESS | 1680 | RSS: Main: 379293696 02:58:51 INFO - PROCESS | 1680 | 03:01:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:01:54 INFO - PROCESS | 1680 | RSS: Main: 373989376 03:01:54 INFO - PROCESS | 1680 | 03:04:57 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:04:57 INFO - PROCESS | 1680 | RSS: Main: 338894848 03:04:57 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:08:00 INFO - PROCESS | 1680 | RSS: Main: 387375104 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | __start_tp_report 03:08:00 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 03:08:00 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 03:08:00 INFO - PROCESS | 1680 | |i|pagename|runs| 03:08:00 INFO - PROCESS | 1680 | |0;dojo.html;3350.614679311879;3436.707879830214;3477.2697733475975;3482.564679415073;3531.1701750088723;5528.695921724314;5621.072523033699;5626.606137570372;5638.605297629162;5646.74589643466;5592.105263157896;5648.661080335183;5650.350209725882;5654.095344744842;5681.573881958849;5113.795448182068;5116.334876466054;5121.718305493197;5127.794888204486;5212.687238765668;5200.453952335007;5206.843794686166;5208.062548741225;5210.296609957664;5220.008198442303;4846.079244943449;5195.818146364878;5205.947940520603;5209.348831396075;5209.895802083956;4758.928616070762;5200.635955483099;5209.60927930403;5212.139996900507;5214.713190774506;5070.923936140961;5121.84634460963;5190.71451070191;5209.270702101709;5231.058409486291;5573.052581061229;5573.777048918038;5610.85972850682;5626.606137570331;5664.093745000821;6170.907436388457;6190.783322583733;6193.411625895533;6193.752249910043;6199.287081985584;5697.487226149667;6140;6212.534059945477;6276.654783986879;6299.433051025384;5727.99713848539;5749.13762935563;5785.450382213683;5795.101759227368;5824.271966004249;6199.163112979781;6292.748290068437;6343.365663433619;6343.524235682342;6344.936550634527;5991.161237426763;6034.064719968412;6124.877502449926;6140.478059364915;6146.139540464339;5218.373795144607;6244.406781355764;6254.499640028786;6285.811425657238;6294.622322660655;6012.188354572164;6071.939280607226;6205.317415084337;6206;6224.719887605069;6120.477608373095;6129.756146212572;6135.355158799479;6137.683438940261;6139.308154112039;4174.4364510791265;4893.755312234374;4897.755112244445;4898.681585696918;4908.877278068006;4360.084382279693;4363.890902727458;4381.255186618218;4398.120375924827;4408.911821763547;5487.862803429866;5540.475731371454;5601.075822489325;5644.520215781705;5681.744321505542;6178.691065446799;6181.876362472815;6216.44052035319;6217.409346112112;6244.531660125509;5597.496225339658;5621.353544342453;5623.718814059281;5632.915506267409;5724.398938111522;5311.734413279398;5344.973275133677;5348.812791552277;5351.170568561879;5354.303940487712;6306.306306306303;6310.432061114522;6313.779017734358;6327.778527751599;6333.65164915934;6125.540694081788;6144.003198960445;6244.968775156095;6258.561900667091;6259.906101408574;6261.060840873905;6292.465140463112;6294.779682711083;6315.652639104894;6316.115743795965;6156.507479401726;6159.6612186330185;6182.783602573888;6183.96908015457;6198.752049918133;5078.162103253069;6129.816105516842;6207.81376558704;6255.31191568918;6296.5592408530965;5584.93886161628;5804.1874137619925;5989.940100598938;6019.24044578853;6052.485538729081;5858.384869588632;5896.764129434775;6005.129256257906;6027.36712645166;6037.849053773691;5836.124581312667;5851.678157701197;5906.852328691817;5943.732532036155;5989.311229208697;5075.28945947575;6020.578559500793;6068.6358818471035;6077.149199112217;6086.087086936818;5764.682942438206;5804.622699524517;5891.1752354671235;5912.408759124225;5915 03:08:00 INFO - PROCESS | 1680 | |1;ext.html;467.4530798965213;529.7245432375167;554.8155884973986;591.6036255708676;634.9142865713128;22560.88719556402;37387.06532336693;37868;37920.620793792055;37989.81005094974;40424.797876010576;40740.59259407405;40775.388369174485;40779.38830917539;40896.59103408965;9406.15344618984;9617.855732164024;9642.180414664763;9642.90357096427;9652.083052110038;8353.791155221137;9577.760555986086;9716.56275467602;9746.512674366253;9774.266929980244;9640.325177237597;9882.703518894408;9900;9901.306908516406;9905.306628536006;9797.559109840075;9880.209583233396;9881.703548893545;9885.75285617858;9896.406215627085;9600.375975561636;9733.853992190123;9739.56171972263;9751.17115045222;9753.707388778348;38936.415953760436;39212.411813822815;39343.80328098341;39370;39397;2802.453521563296;3200.4079245339685;3366.9899030290817;3721.813909304524;3778.5465744110606;28206.576901346496;28395.57406638902;28596.428071438662;28630.85684571564;29292.560611590845;2690.7847372210176;2795.4688609164195;2806.7052959439375;2835.5746638004257;2867.569864520318;440544;441187.9999999968;441462;443066;444106;53702.92594148095;54733;60368;60774.08838867421;60998.78002440015;65420;65600.34399656038;65949.01076483856;66363.34546618178;66561;15616.609584760245;15840.76238856418;15844.970076944961;15847.52457426279;15856.762148567781;11008;11186.16103792219;12049.578264760692;12104.757904841854;12280.14039017278;19363.031848407805;19367.418977430698;19426.028698565297;19518.70721939172;19564.510887227934;6663.800085997428;7585.279398457138;7917.2874441300555;7966;7993.760187194393;941.8163458125737;991.0733464210986;1005.854151148094;1017.4353233955226;1176.7881781279282;27618;28575.856965721137;28578.28554286118;29102.417951640848;30384.54423183654;1060.2472244706191;1088.2110469909253;1093.9890601093887;1136.4431428599926;1152.9250598711058;12560.623181304576;12586.81119783204;12678.366081695878;12766.297853617954;13095.148815327164;405649;431407;432161;432896;433806;52880.47119528832;53531.46468535265;53587;53602.7319863406;53625.731871340395;1271.8664540223328;1432.5917113622568;1447.3993292783377;1449.862263084984;1575.818780840218;28171.57742633903;28766.712332876403;28898;29186.978455753946;29734;48274;48796.26805597848;48837.267440989126;48847;48909.75545122252;483266;486985;490420;501415;621178.8941055447;28963.565546517242;28964;29242.268943276587;29363;29448.558271625516;31773.523397148598;39736.2052758949;40328;40613.59386406098;41044.58955410407;27879;33334.99995000154;34694.82652586721;34703.826480867436;34990.47514287339;27275.181744547695;27481.17556473309;31970.68029319677;33727.66272337343;34040.48939265864;33407.49888751719;33519.329613407106;33976.15059623529;33977.98066058022;34001.14997125092;29256.26859328534;29279.85360073186;31556.842215788773;31746;31824.04527864075;24037.639435408833;24804;27908.86045569759;31052.844735776176;31083.222919427197 03:08:00 INFO - PROCESS | 1680 | |2;jquery.html;361.3207170519425;361.5859840482647;363.25532658051;368.6571488515681;370.3833117858765;14489.78265326021;14822.703545929102;18487.075646217687;19003.904980475094;19898.70151947722;18088;18455.630887382278;18709.438716838482;19924.900375498102;19963;5801.0428279333855;5986.191864098357;6014;6015.789447369343;6025.15647809307;4199.223143718406;4361.454818147731;4442.533533978934;5942.6434413935085;6025.638461692312;6366.586171898835;6535.607863528204;6541.672916354187;6543.803685889431;6548.476121910236;6257.874842503147;6418.550701450877;6423.7430502779835;6424.582402143869;6434.485241180694;4520.457545094577;5585.916211256835;5614.045612245887;5615.073512870372;5620.522255608237;12413.131080824345;13039.54361597349;19802.405927822187;20059.1976320947;22818.77181228183;2185.9781402185936;2196.560687862418;2239.283429302624;2264.445210923318;2308.249818808894;7398.593077380742;8550.52972086535;9769.51152442375;9835.950820245924;9997.900020999843;1781.1628534588722;1793.84752296055;1796.9011704356255;1805.0884303426817;1829.2957211473545;92769.53615231949;94691;94778.52610736972;95667;95764.04235957621;10673.466326683634;10776.568937242579;10776.67669969902;10801.351918884891;10897.291676041032;12768.445726109172;12826.102172847812;12889.097763156677;12889.291088990196;12932.67668308281;8130.674773009014;8141.1451797561585;8161.67353305873;8229.25936665703;8250.504969701717;7084.539504932163;8130.918690813134;8133.349332053422;8133.918660813316;8192.672293108328;4238.703290769617;4304.4834619845815;4309.676774241944;4351.08627188294;4355.73865568067;1694.7627332173506;1745.694503461889;1768.7170052791748;1808.2586139682667;1836.6510363030982;394.1879727760765;399.5185801109656;429.5511190805616;449.86054323159925;875.6672464463463;9220.723378298662;11163.330200188015;11505.309681419141;11518.94240528792;11575.536978520933;444.7109378903738;444.86431638350615;447.1080195010974;449.8043351142264;454.96132828709267;6049.546284028627;6118.78584249558;8241.299489543457;10781.946090269656;10801;634942;701546;735541;740396;755555;108633.76612987826;108941;108992;110131;111972.44013780043;1138.2885696439726;1167.6030149749126;1193.176708071428;1199.3703305764368;1204.2894692131508;17840.732389014436;18196.545086372946;18286.359977400727;18295.54261143482;18374.540636484195;49026.509734902196;49607.503924960285;49960.25059624036;50702.492975071254;50978;68030.65984670045;70786.58426831538;71575.64212178906;72248.63875680589;72727.63636181786;7498.475106742694;7641.388688904985;7719.884201736866;7728.149903510722;7820.569868657051;4604.194266003503;10592.629257975934;11653.669266146635;11976.820347694966;12050.480120704546;10147.695569132939;10350.5342259597;10447.738806529898;10527.263091583516;10572.629957951434;6539.939918925524;10295.279330446796;10316.793664126526;10336.534855931652;10481.528331225265;9860;10205.642802501878;10541.31481453703;10731.570737170427;10769.299995500267;7611.809704757426;7667.769966901002;7671.309582137635;7681.807954801175;7702.691892324468;9760.658376956773;10550.314229575053;10636.361818290927;10715.41065241388;10722.839157412802 03:08:00 INFO - PROCESS | 1680 | |3;mootools.html;1242.9440675169617;1529.831718510964;1572.992135039325;1795.1831916477995;1953.501857026459;7880.881786773203;8618.827623447527;8761.95619021904;8777.60500777465;8785.165409286115;8414.83170336593;8683.43557668751;8692.217700406962;8702.738917832476;8713.651453941851;2200.5378870437225;2254.9436264093447;2256.142665787007;2464.6813954534373;2496.5755821510297;2261.2650888461317;2263.954720905581;2449;2512.7612876776675;2517.509085728284;2440.8169387296025;2467.90128394864;2472.6538284640164;2472.7279999200073;2485.9378515537164;2445.6087026075743;2461.729209786922;2468.456939473313;2474.9752502474926;2476.3313905245573;2427.0898413095088;2460.852348859074;2464.827462077655;2475.740047295026;2489.6887889013874;8777.253933415668;8835.160659737314;8843.425177363451;8846.557672116369;8855.424397414148;4470.26240670289;5441.938821929725;5449.618526703132;5472.835814925519;5492.258545096441;3588.2105936693883;3642.1258897864586;3697.4453831925157;3718.1819999600316;3726.60252405348;1056.4823236614081;1069.4385447639972;1076.364944682641;1101.7906597746403;1104.7072525780675;12001.819972700416;12040.939795301056;12051.216670916363;12054.578089766905;12115.333656648882;4860.8298709545;4878.195097808893;4952.860842006358;4958.776855041532;4965.230389289666;10203;10222.386656800616;10230.437325946996;10230.59077636901;10240.641577544899;5491.176323551419;5498.202760599691;5508.779648814083;5511.448855114537;5512.3660779010925;4893.559579637849;4939.802407903716;4954.9752251238515;4959.876003099879;5015.949840501621;3488.63369346215;3539.185987222953;3905.511811023622;3929.2337994090876;3990.2817492851564;1219.6402061391912;1244.5208594690928;1246.6384748422856;1285.7042880137622;1311.731095125497;1293.8512071111943;1310.3644732304824;1339.4240476594962;1340.2561578324123;1341.275711116006;7957.920420795834;8048.074471435742;8063.637136328879;8067.152948940394;8110.594470276463;1153.7288737146764;1166.6616681162368;1171.1801738782885;1179.5930404010603;1190.220405634311;6212.937870621236;6225.097360882737;6311.053341998645;6311.116443697886;6319.24169099711;9001.819963600692;10239.385636861813;10730.946345268223;10756.247062705692;10864.728381790519;9423.952880235693;10597.099246563974;10694.62568810088;10726.678199654023;10793.29843560166;8146.674133034612;8184.099749027602;8199.672013119527;8212.876806847782;8287.171282871665;8041.316488098577;8053.194680532134;8115.7565273039545;8147.511149331059;8171.387145963958;9443.386179898285;9497.145256926633;9664.081912218327;9702.9029709702;9786.559604817943;9592.76018099553;9791.510424478605;9960.701178964642;10062.798744025225;10233.283670143019;7575.053118360205;7609.505382150142;7627.733029343946;7632.5038872473115;7716.807079823049;8229.177082291722;8309.459885107448;8311.792205194919;8314.376421768271;8335.95832020836;6856.908642863775;7081.973113898559;7696.037995250594;7803.102643196105;7956.721514746956;7114.21743608213;7462.514936529108;7464.626768661654;7565.470417070752;7586.24137586237;7471.252874712485;7606.163322034461;7669;7675;7703.961480192564;6983.6857341418745;7026.683799229149;7046.577205367695;7046.647667616496;7052.0832291801735;7072.71709131629;7116.537425067354;7117.857642847218;7142.9999800027;7175.533590316612 03:08:00 INFO - PROCESS | 1680 | |4;prototype.html;320.7257794585629;326.580344257629;327.34857633309707;330.93381323735247;335.7381242630747;6171.197744293241;6564.179477565304;6658.633775142372;6671.999999999994;6713.784451131127;6473.967630161843;6580;6675.933240667592;6682.264950855402;6684.966575167117;4138.772367519785;4811.30236115763;4892.681975671588;4910.312556242129;4920.97539512302;4907.2884431757375;4924.4583095859425;4925.48282430345;4928.211486162215;4945.950540494603;4684.227102528079;4767.856964291077;4777.80888764449;4788.664793464459;4812.302216178669;4767;4792.161371759928;4796.640251981098;4807.78364973577;4810.903781924342;4071.2875246831686;4081.632653061209;4086.9182616347803;4091.243120022805;4102.220578090183;5501.9174712379345;6180.258368995705;6407.775727849549;6432.388923052303;6454.838629034265;5055.721935293557;5446;5719.571032172562;5724.96950548901;5738.167965644958;7135.643217839139;7145.821354466128;7147.785566433015;7151.570905745672;7158.391536719385;4621.676482646216;4622.399088118523;4626.236670949289;4629.074185162947;4634.420697412824;6188.597741146811;6524.282328943812;7278.708851645928;7411.036565246537;7532.698692052311;4652.3951886255245;4688.835890743876;4702.200625893606;4717.009428020154;4721.622270218374;4756.8097276108565;4774.379330686988;4777.761111944458;4792;4796.088743138793;5483.862903427366;5721.4278572143285;5723.227364305765;5730.656160630292;5734.856628584235;7119.71521139159;7193.5324203926575;7221.638918054076;7223.674934627954;7231.89152162718;1557.8052743407075;1605.6146524833955;1613.362721724912;1643.6219669476088;1649.9505014849574;873.785922449004;946.1910066892846;1009.9242556808268;1057.5611121384538;1072.855164552791;6500.252470965899;6501.642409667514;6548.770793022221;6559.311272316433;6605.30644282353;7320.1215854097845;7326.267373262631;7327.963360183165;7331.193568707438;7347.008153899155;6387.393197646216;6549.508786841006;6549.508786841006;6562.409383155539;6581.736730530725;3194.904152875371;3889.8833035008997;3941.960580394217;3946.743461674982;3947.6644485218503;6273;7670;7677.961610191914;7689.538627682357;7704.191059938737;7419.925800742031;7595.3164215220895;7617.69529218825;7627.618619069024;7693;7806.258405451473;7823.921760782319;7835.294823465915;7906.090799558125;7947.721829735931;6165.907511387243;7521.924780752122;7536.8492630148185;7553.32020118192;7561.810954726176;7223.2819760332595;7345.934839448143;7424.183339832722;7437.107547094383;7444.441666874898;7883.763487095396;7884.21157884207;8093.919060809317;8128.349732021542;8144.063432705315;4044.1102957349335;4673.485916549245;4683.976580117078;4720.291956206596;4727.57451829337;7150.821229469305;7183.20984691694;7349.228331025379;7474.065741782278;7511.9624401877645;6019.247594050744;7072.752453664097;7258.056452661121;7271.490995630255;7284.417246620152;7242.804937185516;7259.52813067149;7259.745908893164;7272.05463289769;7274;5809;6795.762148324982;7063.929360706533;7067.57594544329;7146.928530714834;7269.600171990592;7270.163931147986;7278.09023872016;7293.744718934812;7294.635268236673;6948.683826475993;7016.473764467583;7098.503104782616;7112.786616401516;7141.9642901785155 03:08:00 INFO - PROCESS | 1680 | |5;yui.html;664.2759392262433;691.5263044814301;698.8043347862593;719.4100837313404;747.2004954698475;14809;14954.32705528251;14973.625659358535;14994.925025374885;15000.324985375657;13605.591832245049;13622.114562553426;13641.386137623806;13657.72684546311;13664.38510267038;667.4993754683975;684.6816230452838;692.3595674001554;838.1241602525375;838.7357982235607;830.6552780596045;838.9119142490011;840.8024114333127;841.20506121715;841.4488510025943;707.769974758203;722.3751454991448;888.6001299415257;891.6656253904786;892.1791951404723;862.211076864668;891.9331050171198;892.9464232146092;893.9553022348922;894.1505569708738;670.4033410264868;670.6847781542716;670.792054463118;670.8859493886051;671.9059331693518;14527.418903243857;14579;14607.415703371853;14629.707405851823;14644.92677536616;12389.256644601353;12452.626421207378;12501.93749031249;12611.117221794479;12823.294718790463;10091.444970526618;10105.242106841943;10108.342957707726;10180.949095254477;10790.082842958358;3558.8077993872084;3580.516630254934;3588.461062275597;3600.5859326177565;3634.582023067355;76702;76818.84771728428;76889;76947.61526192389;77398.2260177391;9306.044930904338;9421.717348479557;9425.198858097001;9454.716358509255;10143.594256229815;19225.903870480837;19814.811111333365;21511.032003559878;21522;21541.461463463227;7497.1003479581705;7546.584937828362;7694.538327700356;7748.690052397841;7900.012498437695;4139.627433530996;4189.455370801777;4189.6438802701505;4194.706370554032;4196.349565817303;3565.6612621800887;3611.115276757159;3611.5124458197806;3617.9276414471565;3620.6922411594783;657.6580178307254;662.3111963557942;662.5196732368994;662.5329142954206;682.0383259603934;524.609166171205;581.4156772443667;600.5885968111858;610.8729443679898;618.1716499890168;8533.615987280587;8638.265747411415;8665.17680820321;8954.373193876496;9254.583543740548;573.7160105747598;600.798732424634;613.6655522740117;614.7264467312093;623.4512835761757;3786.5077539919635;3963.405489176589;4041.2725709372007;4091.1204091120553;4094.5905409458815;88831.55584222038;89117;90213;90263.19473610491;90417;77978.6101069491;78081.60959195168;78508.6074569635;79695;80110.19889801028;65838;67039;67340.3164920871;67376.6631166841;68410.9738353925;7953.602319883867;8020.679172833022;8087.555184464911;8142.592870356577;8210.384221183554;47664.52335476601;47739.76130119327;48880.0223995511;49002.26496602483;49063;50870;71387.64306178436;72837;73940;77619.79041676539;11185.66443006711;11491.195616307112;11491.885081149081;11717.238379505305;12191.817122742988;11987.400629968291;11990.460429280878;12011;12080.335581543099;12487.375631218585;10283.691489255334;10956.6347408153;11124.479223633145;11273.267237629529;11367.943160284476;11984.64046078619;11993.82009269879;12012.459439325077;12226.083043771574;12243.510259589517;9562.95218523903;11300.208985371273;11576.88423115758;11616.303021818718;11679.357635329798;9412.294077944045;9467.384619999679;9818.607255709978;9827.754306142404;9837.704868853945;9858.014198580084;10092;10093.19254459656;10098.545565449425;10103.393796372242 03:08:00 INFO - PROCESS | 1680 | __end_tp_report 03:08:00 INFO - PROCESS | 1680 | __start_cc_report 03:08:00 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1004 03:08:00 INFO - PROCESS | 1680 | __end_cc_report 03:08:00 INFO - PROCESS | 1680 | __startTimestamp1455102480944__endTimestamp 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | ------- Summary: start ------- 03:08:00 INFO - PROCESS | 1680 | Number of tests: 6 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5675.77 Median:5824.27 stddev:637.94 (11.0%) stddev-sans-first:613.27 03:08:00 INFO - PROCESS | 1680 | Values: 3350.6 3436.7 3477.3 3482.6 3531.2 5528.7 5621.1 5626.6 5638.6 5646.7 5592.1 5648.7 5650.4 5654.1 5681.6 5113.8 5116.3 5121.7 5127.8 5212.7 5200.5 5206.8 5208.1 5210.3 5220.0 4846.1 5195.8 5205.9 5209.3 5209.9 4758.9 5200.6 5209.6 5212.1 5214.7 5070.9 5121.8 5190.7 5209.3 5231.1 5573.1 5573.8 5610.9 5626.6 5664.1 6170.9 6190.8 6193.4 6193.8 6199.3 5697.5 6140.0 6212.5 6276.7 6299.4 5728.0 5749.1 5785.5 5795.1 5824.3 6199.2 6292.7 6343.4 6343.5 6344.9 5991.2 6034.1 6124.9 6140.5 6146.1 5218.4 6244.4 6254.5 6285.8 6294.6 6012.2 6071.9 6205.3 6206.0 6224.7 6120.5 6129.8 6135.4 6137.7 6139.3 4174.4 4893.8 4897.8 4898.7 4908.9 4360.1 4363.9 4381.3 4398.1 4408.9 5487.9 5540.5 5601.1 5644.5 5681.7 6178.7 6181.9 6216.4 6217.4 6244.5 5597.5 5621.4 5623.7 5632.9 5724.4 5311.7 5345.0 5348.8 5351.2 5354.3 6306.3 6310.4 6313.8 6327.8 6333.7 6125.5 6144.0 6245.0 6258.6 6259.9 6261.1 6292.5 6294.8 6315.7 6316.1 6156.5 6159.7 6182.8 6184.0 6198.8 5078.2 6129.8 6207.8 6255.3 6296.6 5584.9 5804.2 5989.9 6019.2 6052.5 5858.4 5896.8 6005.1 6027.4 6037.8 5836.1 5851.7 5906.9 5943.7 5989.3 5075.3 6020.6 6068.6 6077.1 6086.1 5764.7 5804.6 5891.2 5912.4 5915.0 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:60100.64 Median:20823.27 stddev:123539.66 (593.3%) stddev-sans-first:123805.08 03:08:00 INFO - PROCESS | 1680 | Values: 467.5 529.7 554.8 591.6 634.9 22560.9 37387.1 37868.0 37920.6 37989.8 40424.8 40740.6 40775.4 40779.4 40896.6 9406.2 9617.9 9642.2 9642.9 9652.1 8353.8 9577.8 9716.6 9746.5 9774.3 9640.3 9882.7 9900.0 9901.3 9905.3 9797.6 9880.2 9881.7 9885.8 9896.4 9600.4 9733.9 9739.6 9751.2 9753.7 38936.4 39212.4 39343.8 39370.0 39397.0 2802.5 3200.4 3367.0 3721.8 3778.5 28206.6 28395.6 28596.4 28630.9 29292.6 2690.8 2795.5 2806.7 2835.6 2867.6 440544.0 441188.0 441462.0 443066.0 444106.0 53702.9 54733.0 60368.0 60774.1 60998.8 65420.0 65600.3 65949.0 66363.3 66561.0 15616.6 15840.8 15845.0 15847.5 15856.8 11008.0 11186.2 12049.6 12104.8 12280.1 19363.0 19367.4 19426.0 19518.7 19564.5 6663.8 7585.3 7917.3 7966.0 7993.8 941.8 991.1 1005.9 1017.4 1176.8 27618.0 28575.9 28578.3 29102.4 30384.5 1060.2 1088.2 1094.0 1136.4 1152.9 12560.6 12586.8 12678.4 12766.3 13095.1 405649.0 431407.0 432161.0 432896.0 433806.0 52880.5 53531.5 53587.0 53602.7 53625.7 1271.9 1432.6 1447.4 1449.9 1575.8 28171.6 28766.7 28898.0 29187.0 29734.0 48274.0 48796.3 48837.3 48847.0 48909.8 483266.0 486985.0 490420.0 501415.0 621178.9 28963.6 28964.0 29242.3 29363.0 29448.6 31773.5 39736.2 40328.0 40613.6 41044.6 27879.0 33335.0 34694.8 34703.8 34990.5 27275.2 27481.2 31970.7 33727.7 34040.5 33407.5 33519.3 33976.2 33978.0 34001.1 29256.3 29279.9 31556.8 31746.0 31824.0 24037.6 24804.0 27908.9 31052.8 31083.2 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:35776.73 Median:2334.13 stddev:117760.06 (5045.1%) stddev-sans-first:118060.38 03:08:00 INFO - PROCESS | 1680 | Values: 361.3 361.6 363.3 368.7 370.4 14489.8 14822.7 18487.1 19003.9 19898.7 18088.0 18455.6 18709.4 19924.9 19963.0 5801.0 5986.2 6014.0 6015.8 6025.2 4199.2 4361.5 4442.5 5942.6 6025.6 6366.6 6535.6 6541.7 6543.8 6548.5 6257.9 6418.6 6423.7 6424.6 6434.5 4520.5 5585.9 5614.0 5615.1 5620.5 12413.1 13039.5 19802.4 20059.2 22818.8 2186.0 2196.6 2239.3 2264.4 2308.2 7398.6 8550.5 9769.5 9836.0 9997.9 1781.2 1793.8 1796.9 1805.1 1829.3 92769.5 94691.0 94778.5 95667.0 95764.0 10673.5 10776.6 10776.7 10801.4 10897.3 12768.4 12826.1 12889.1 12889.3 12932.7 8130.7 8141.1 8161.7 8229.3 8250.5 7084.5 8130.9 8133.3 8133.9 8192.7 4238.7 4304.5 4309.7 4351.1 4355.7 1694.8 1745.7 1768.7 1808.3 1836.7 394.2 399.5 429.6 449.9 875.7 9220.7 11163.3 11505.3 11518.9 11575.5 444.7 444.9 447.1 449.8 455.0 6049.5 6118.8 8241.3 10781.9 10801.0 634942.0 701546.0 735541.0 740396.0 755555.0 108633.8 108941.0 108992.0 110131.0 111972.4 1138.3 1167.6 1193.2 1199.4 1204.3 17840.7 18196.5 18286.4 18295.5 18374.5 49026.5 49607.5 49960.3 50702.5 50978.0 68030.7 70786.6 71575.6 72248.6 72727.6 7498.5 7641.4 7719.9 7728.1 7820.6 4604.2 10592.6 11653.7 11976.8 12050.5 10147.7 10350.5 10447.7 10527.3 10572.6 6539.9 10295.3 10316.8 10336.5 10481.5 9860.0 10205.6 10541.3 10731.6 10769.3 7611.8 7667.8 7671.3 7681.8 7702.7 9760.7 10550.3 10636.4 10715.4 10722.8 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:6071.68 Median:5228.94 stddev:3185.84 (60.9%) stddev-sans-first:3174.09 03:08:00 INFO - PROCESS | 1680 | Values: 1242.9 1529.8 1573.0 1795.2 1953.5 7880.9 8618.8 8762.0 8777.6 8785.2 8414.8 8683.4 8692.2 8702.7 8713.7 2200.5 2254.9 2256.1 2464.7 2496.6 2261.3 2264.0 2449.0 2512.8 2517.5 2440.8 2467.9 2472.7 2472.7 2485.9 2445.6 2461.7 2468.5 2475.0 2476.3 2427.1 2460.9 2464.8 2475.7 2489.7 8777.3 8835.2 8843.4 8846.6 8855.4 4470.3 5441.9 5449.6 5472.8 5492.3 3588.2 3642.1 3697.4 3718.2 3726.6 1056.5 1069.4 1076.4 1101.8 1104.7 12001.8 12040.9 12051.2 12054.6 12115.3 4860.8 4878.2 4952.9 4958.8 4965.2 10203.0 10222.4 10230.4 10230.6 10240.6 5491.2 5498.2 5508.8 5511.4 5512.4 4893.6 4939.8 4955.0 4959.9 5015.9 3488.6 3539.2 3905.5 3929.2 3990.3 1219.6 1244.5 1246.6 1285.7 1311.7 1293.9 1310.4 1339.4 1340.3 1341.3 7957.9 8048.1 8063.6 8067.2 8110.6 1153.7 1166.7 1171.2 1179.6 1190.2 6212.9 6225.1 6311.1 6311.1 6319.2 9001.8 10239.4 10730.9 10756.2 10864.7 9424.0 10597.1 10694.6 10726.7 10793.3 8146.7 8184.1 8199.7 8212.9 8287.2 8041.3 8053.2 8115.8 8147.5 8171.4 9443.4 9497.1 9664.1 9702.9 9786.6 9592.8 9791.5 9960.7 10062.8 10233.3 7575.1 7609.5 7627.7 7632.5 7716.8 8229.2 8309.5 8311.8 8314.4 8336.0 6856.9 7082.0 7696.0 7803.1 7956.7 7114.2 7462.5 7464.6 7565.5 7586.2 7471.3 7606.2 7669.0 7675.0 7704.0 6983.7 7026.7 7046.6 7046.6 7052.1 7072.7 7116.5 7117.9 7143.0 7175.5 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:5812.35 Median:6549.51 stddev:1898.35 (29.0%) stddev-sans-first:1858.39 03:08:00 INFO - PROCESS | 1680 | Values: 320.7 326.6 327.3 330.9 335.7 6171.2 6564.2 6658.6 6672.0 6713.8 6474.0 6580.0 6675.9 6682.3 6685.0 4138.8 4811.3 4892.7 4910.3 4921.0 4907.3 4924.5 4925.5 4928.2 4946.0 4684.2 4767.9 4777.8 4788.7 4812.3 4767.0 4792.2 4796.6 4807.8 4810.9 4071.3 4081.6 4086.9 4091.2 4102.2 5501.9 6180.3 6407.8 6432.4 6454.8 5055.7 5446.0 5719.6 5725.0 5738.2 7135.6 7145.8 7147.8 7151.6 7158.4 4621.7 4622.4 4626.2 4629.1 4634.4 6188.6 6524.3 7278.7 7411.0 7532.7 4652.4 4688.8 4702.2 4717.0 4721.6 4756.8 4774.4 4777.8 4792.0 4796.1 5483.9 5721.4 5723.2 5730.7 5734.9 7119.7 7193.5 7221.6 7223.7 7231.9 1557.8 1605.6 1613.4 1643.6 1650.0 873.8 946.2 1009.9 1057.6 1072.9 6500.3 6501.6 6548.8 6559.3 6605.3 7320.1 7326.3 7328.0 7331.2 7347.0 6387.4 6549.5 6549.5 6562.4 6581.7 3194.9 3889.9 3942.0 3946.7 3947.7 6273.0 7670.0 7678.0 7689.5 7704.2 7419.9 7595.3 7617.7 7627.6 7693.0 7806.3 7823.9 7835.3 7906.1 7947.7 6165.9 7521.9 7536.8 7553.3 7561.8 7223.3 7345.9 7424.2 7437.1 7444.4 7883.8 7884.2 8093.9 8128.3 8144.1 4044.1 4673.5 4684.0 4720.3 4727.6 7150.8 7183.2 7349.2 7474.1 7512.0 6019.2 7072.8 7258.1 7271.5 7284.4 7242.8 7259.5 7259.7 7272.1 7274.0 5809.0 6795.8 7063.9 7067.6 7146.9 7269.6 7270.2 7278.1 7293.7 7294.6 6948.7 7016.5 7098.5 7112.8 7142.0 03:08:00 INFO - PROCESS | 1680 | 03:08:00 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:18083.89 Median:612.27 stddev:25199.72 (4115.8%) stddev-sans-first:25236.47 03:08:00 INFO - PROCESS | 1680 | Values: 664.3 691.5 698.8 719.4 747.2 14809.0 14954.3 14973.6 14994.9 15000.3 13605.6 13622.1 13641.4 13657.7 13664.4 667.5 684.7 692.4 838.1 838.7 830.7 838.9 840.8 841.2 841.4 707.8 722.4 888.6 891.7 892.2 862.2 891.9 892.9 894.0 894.2 670.4 670.7 670.8 670.9 671.9 14527.4 14579.0 14607.4 14629.7 14644.9 12389.3 12452.6 12501.9 12611.1 12823.3 10091.4 10105.2 10108.3 10180.9 10790.1 3558.8 3580.5 3588.5 3600.6 3634.6 76702.0 76818.8 76889.0 76947.6 77398.2 9306.0 9421.7 9425.2 9454.7 10143.6 19225.9 19814.8 21511.0 21522.0 21541.5 7497.1 7546.6 7694.5 7748.7 7900.0 4139.6 4189.5 4189.6 4194.7 4196.3 3565.7 3611.1 3611.5 3617.9 3620.7 657.7 662.3 662.5 662.5 682.0 524.6 581.4 600.6 610.9 618.2 8533.6 8638.3 8665.2 8954.4 9254.6 573.7 600.8 613.7 614.7 623.5 3786.5 3963.4 4041.3 4091.1 4094.6 88831.6 89117.0 90213.0 90263.2 90417.0 77978.6 78081.6 78508.6 79695.0 80110.2 65838.0 67039.0 67340.3 67376.7 68411.0 7953.6 8020.7 8087.6 8142.6 8210.4 47664.5 47739.8 48880.0 49002.3 49063.0 50870.0 71387.6 72837.0 73940.0 77619.8 11185.7 11491.2 11491.9 11717.2 12191.8 11987.4 11990.5 12011.0 12080.3 12487.4 10283.7 10956.6 11124.5 11273.3 11367.9 11984.6 11993.8 12012.5 12226.1 12243.5 9563.0 11300.2 11576.9 11616.3 11679.4 9412.3 9467.4 9818.6 9827.8 9837.7 9858.0 10092.0 10093.2 10098.5 10103.4 03:08:00 INFO - PROCESS | 1680 | -------- Summary: end -------- 03:08:00 INFO - PROCESS | 1680 | 03:08:01 INFO - TEST-INFO | 1680: exit 0 03:08:01 INFO - TEST-OK | dromaeo_css | took 1114618ms 03:08:01 INFO - TEST-START | kraken 03:08:01 INFO - operating with platform_type : mac_ 03:08:01 INFO - Initialising browser for kraken test... 03:08:01 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpB71AXP/profile http://localhost:49276/getInfo.html) 03:08:03 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 03:08:03 INFO - PROCESS | 1685 | colorDepth:24 03:08:03 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 03:08:03 INFO - PROCESS | 1685 | __metrics 03:08:03 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:08:03 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:04 INFO - TEST-INFO | 1685: exit 0 03:08:04 INFO - Browser initialized. 03:08:04 INFO - Running cycle 1/1 for kraken test... 03:08:04 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpB71AXP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:16 INFO - PROCESS | 1687 | RSS: Main: 246149120 03:08:16 INFO - PROCESS | 1687 | 03:08:18 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:19 INFO - PROCESS | 1687 | RSS: Main: 291082240 03:08:19 INFO - PROCESS | 1687 | 03:08:22 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:08:22 INFO - PROCESS | 1687 | RSS: Main: 302739456 03:08:22 INFO - PROCESS | 1687 | 03:08:25 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:08:26 INFO - PROCESS | 1687 | RSS: Main: 288141312 03:08:26 INFO - PROCESS | 1687 | 03:08:28 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:08:29 INFO - PROCESS | 1687 | RSS: Main: 289738752 03:08:29 INFO - PROCESS | 1687 | 03:08:31 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:31 INFO - PROCESS | 1687 | RSS: Main: 291033088 03:08:31 INFO - PROCESS | 1687 | 03:08:34 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:35 INFO - PROCESS | 1687 | RSS: Main: 292016128 03:08:35 INFO - PROCESS | 1687 | 03:08:37 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:38 INFO - PROCESS | 1687 | RSS: Main: 290701312 03:08:38 INFO - PROCESS | 1687 | 03:08:41 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:08:41 INFO - PROCESS | 1687 | RSS: Main: 290877440 03:08:41 INFO - PROCESS | 1687 | 03:08:43 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:44 INFO - PROCESS | 1687 | RSS: Main: 327086080 03:08:44 INFO - PROCESS | 1687 | 03:08:45 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:46 INFO - PROCESS | 1687 | RSS: Main: 325976064 03:08:46 INFO - PROCESS | 1687 | 03:08:48 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:49 INFO - PROCESS | 1687 | RSS: Main: 334934016 03:08:49 INFO - PROCESS | 1687 | 03:08:51 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:52 INFO - PROCESS | 1687 | RSS: Main: 334684160 03:08:52 INFO - PROCESS | 1687 | 03:08:54 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:55 INFO - PROCESS | 1687 | RSS: Main: 334667776 03:08:55 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:08:57 INFO - PROCESS | 1687 | RSS: Main: 395866112 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | __start_tp_report 03:08:57 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 03:08:57 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 03:08:57 INFO - PROCESS | 1687 | |i|pagename|runs| 03:08:57 INFO - PROCESS | 1687 | |0;ai-astar;110;108;115;161;164;111;116;109;110;111 03:08:57 INFO - PROCESS | 1687 | |1;audio-beat-detection;175;146;143;158;119;143;137;122;156;118 03:08:57 INFO - PROCESS | 1687 | |2;audio-dft;185;185;186;186;184;184;184;183;181;180 03:08:57 INFO - PROCESS | 1687 | |3;audio-fft;74;77;84;78;74;82;84;110;95;54 03:08:57 INFO - PROCESS | 1687 | |4;audio-oscillator;92;91;125;78;81;82;108;76;77;111 03:08:57 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;86;91;86;92;86;90;85;91;85;92 03:08:57 INFO - PROCESS | 1687 | |6;imaging-darkroom;93;94;95;93;95;94;94;94;94;93 03:08:57 INFO - PROCESS | 1687 | |7;imaging-desaturate;101;138;85;86;85;88;86;88;85;84 03:08:57 INFO - PROCESS | 1687 | |8;json-parse-financial;57;54;55;54;54;53;53;63;53;52 03:08:57 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;64;63;73;73;70;66;65;67;67;68 03:08:57 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;82;85;82;81;83;70;98;98;108;106 03:08:57 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;121;126;121;126;132;125;123;131;125;121 03:08:57 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;137;124;137;137;134;126;137;138;137;136 03:08:57 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;67;67;65;67;67;67;66;68;66;64 03:08:57 INFO - PROCESS | 1687 | __end_tp_report 03:08:57 INFO - PROCESS | 1687 | __start_cc_report 03:08:57 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1183 03:08:57 INFO - PROCESS | 1687 | __end_cc_report 03:08:57 INFO - PROCESS | 1687 | __startTimestamp1455102537312__endTimestamp 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | ------- Summary: start ------- 03:08:57 INFO - PROCESS | 1687 | Number of tests: 14 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:121.50 Median:113.00 stddev:21.76 (19.3%) stddev-sans-first:22.68 03:08:57 INFO - PROCESS | 1687 | Values: 110.0 108.0 115.0 161.0 164.0 111.0 116.0 109.0 110.0 111.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:144.50 stddev:18.52 (12.8%) stddev-sans-first:15.23 03:08:57 INFO - PROCESS | 1687 | Values: 175.0 146.0 143.0 158.0 119.0 143.0 137.0 122.0 156.0 118.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.99 (1.1%) stddev-sans-first:2.06 03:08:57 INFO - PROCESS | 1687 | Values: 185.0 185.0 186.0 186.0 184.0 184.0 184.0 183.0 181.0 180.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:81.20 Median:80.00 stddev:14.56 (18.2%) stddev-sans-first:15.21 03:08:57 INFO - PROCESS | 1687 | Values: 74.0 77.0 84.0 78.0 74.0 82.0 84.0 110.0 95.0 54.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:79.50 stddev:17.01 (21.4%) stddev-sans-first:18.04 03:08:57 INFO - PROCESS | 1687 | Values: 92.0 91.0 125.0 78.0 81.0 82.0 108.0 76.0 77.0 111.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:90.50 stddev:3.03 (3.3%) stddev-sans-first:3.08 03:08:57 INFO - PROCESS | 1687 | Values: 86.0 91.0 86.0 92.0 86.0 90.0 85.0 91.0 85.0 92.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 03:08:57 INFO - PROCESS | 1687 | Values: 93.0 94.0 95.0 93.0 95.0 94.0 94.0 94.0 94.0 93.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:85.50 stddev:16.69 (19.5%) stddev-sans-first:17.43 03:08:57 INFO - PROCESS | 1687 | Values: 101.0 138.0 85.0 86.0 85.0 88.0 86.0 88.0 85.0 84.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.19 (5.9%) stddev-sans-first:3.28 03:08:57 INFO - PROCESS | 1687 | Values: 57.0 54.0 55.0 54.0 54.0 53.0 53.0 63.0 53.0 52.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:3.47 (5.1%) stddev-sans-first:3.43 03:08:57 INFO - PROCESS | 1687 | Values: 64.0 63.0 73.0 73.0 70.0 66.0 65.0 67.0 67.0 68.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:82.50 stddev:12.41 (15.0%) stddev-sans-first:12.88 03:08:57 INFO - PROCESS | 1687 | Values: 82.0 85.0 82.0 81.0 83.0 70.0 98.0 98.0 108.0 106.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:125.50 stddev:3.93 (3.1%) stddev-sans-first:3.88 03:08:57 INFO - PROCESS | 1687 | Values: 121.0 126.0 121.0 126.0 132.0 125.0 123.0 131.0 125.0 121.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.30 Median:137.00 stddev:5.03 (3.7%) stddev-sans-first:5.24 03:08:57 INFO - PROCESS | 1687 | Values: 137.0 124.0 137.0 137.0 134.0 126.0 137.0 138.0 137.0 136.0 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.17 (1.8%) stddev-sans-first:1.22 03:08:57 INFO - PROCESS | 1687 | Values: 67.0 67.0 65.0 67.0 67.0 67.0 66.0 68.0 66.0 64.0 03:08:57 INFO - PROCESS | 1687 | -------- Summary: end -------- 03:08:57 INFO - PROCESS | 1687 | 03:08:57 INFO - TEST-INFO | 1687: exit 0 03:08:58 INFO - TEST-OK | kraken | took 56579ms 03:08:58 INFO - SUITE-END | took 1171s 03:08:58 INFO - Completed test suite (00:19:31) 03:08:58 INFO - Working with test: dromaeo_css 03:08:58 INFO - Generating results file: dromaeo_css 03:08:58 INFO - Working with test: kraken 03:08:58 INFO - Generating results file: kraken 03:08:58 INFO - javascript benchmark 03:08:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 03:08:58 INFO - process_Request line: dromaeo_css 7364.62 graph.html#tests=[[72,64,59]] 03:08:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:08:58 INFO - process_Request line: kraken 1432.70 graph.html#tests=[[232,64,59]] 03:08:58 INFO - RETURN: dromaeo_css: 7364.62 03:08:58 INFO - RETURN: kraken: 1432.70 03:08:58 INFO - javascript benchmark 03:08:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3350.614679311879, 3436.707879830214, 3477.2697733475975, 3482.564679415073, 3531.1701750088723, 5528.695921724314, 5621.072523033699, 5626.606137570372, 5638.605297629162, 5646.74589643466, 5592.105263157896, 5648.661080335183, 5650.350209725882, 5654.095344744842, 5681.573881958849, 5113.795448182068, 5116.334876466054, 5121.718305493197, 5127.794888204486, 5212.687238765668, 5200.453952335007, 5206.843794686166, 5208.062548741225, 5210.296609957664, 5220.008198442303, 4846.079244943449, 5195.818146364878, 5205.947940520603, 5209.348831396075, 5209.895802083956, 4758.928616070762, 5200.635955483099, 5209.60927930403, 5212.139996900507, 5214.713190774506, 5070.923936140961, 5121.84634460963, 5190.71451070191, 5209.270702101709, 5231.058409486291, 5573.052581061229, 5573.777048918038, 5610.85972850682, 5626.606137570331, 5664.093745000821, 6170.907436388457, 6190.783322583733, 6193.411625895533, 6193.752249910043, 6199.287081985584, 5697.487226149667, 6140.0, 6212.534059945477, 6276.654783986879, 6299.433051025384, 5727.99713848539, 5749.13762935563, 5785.450382213683, 5795.101759227368, 5824.271966004249, 6199.163112979781, 6292.748290068437, 6343.365663433619, 6343.524235682342, 6344.936550634527, 5991.161237426763, 6034.064719968412, 6124.877502449926, 6140.478059364915, 6146.139540464339, 5218.373795144607, 6244.406781355764, 6254.499640028786, 6285.811425657238, 6294.622322660655, 6012.188354572164, 6071.939280607226, 6205.317415084337, 6206.0, 6224.719887605069, 6120.477608373095, 6129.756146212572, 6135.355158799479, 6137.683438940261, 6139.308154112039, 4174.4364510791265, 4893.755312234374, 4897.755112244445, 4898.681585696918, 4908.877278068006, 4360.084382279693, 4363.890902727458, 4381.255186618218, 4398.120375924827, 4408.911821763547, 5487.862803429866, 5540.475731371454, 5601.075822489325, 5644.520215781705, 5681.744321505542, 6178.691065446799, 6181.876362472815, 6216.44052035319, 6217.409346112112, 6244.531660125509, 5597.496225339658, 5621.353544342453, 5623.718814059281, 5632.915506267409, 5724.398938111522, 5311.734413279398, 5344.973275133677, 5348.812791552277, 5351.170568561879, 5354.303940487712, 6306.306306306303, 6310.432061114522, 6313.779017734358, 6327.778527751599, 6333.65164915934, 6125.540694081788, 6144.003198960445, 6244.968775156095, 6258.561900667091, 6259.906101408574, 6261.060840873905, 6292.465140463112, 6294.779682711083, 6315.652639104894, 6316.115743795965, 6156.507479401726, 6159.6612186330185, 6182.783602573888, 6183.96908015457, 6198.752049918133, 5078.162103253069, 6129.816105516842, 6207.81376558704, 6255.31191568918, 6296.5592408530965, 5584.93886161628, 5804.1874137619925, 5989.940100598938, 6019.24044578853, 6052.485538729081, 5858.384869588632, 5896.764129434775, 6005.129256257906, 6027.36712645166, 6037.849053773691, 5836.124581312667, 5851.678157701197, 5906.852328691817, 5943.732532036155, 5989.311229208697, 5075.28945947575, 6020.578559500793, 6068.6358818471035, 6077.149199112217, 6086.087086936818, 5764.682942438206, 5804.622699524517, 5891.1752354671235, 5912.408759124225, 5915.0], "unit": "score", "name": "dojo.html", "value": 5636.730789049641}, {"lowerIsBetter": false, "replicates": [467.4530798965213, 529.7245432375167, 554.8155884973986, 591.6036255708676, 634.9142865713128, 22560.88719556402, 37387.06532336693, 37868.0, 37920.620793792055, 37989.81005094974, 40424.797876010576, 40740.59259407405, 40775.388369174485, 40779.38830917539, 40896.59103408965, 9406.15344618984, 9617.855732164024, 9642.180414664763, 9642.90357096427, 9652.083052110038, 8353.791155221137, 9577.760555986086, 9716.56275467602, 9746.512674366253, 9774.266929980244, 9640.325177237597, 9882.703518894408, 9900.0, 9901.306908516406, 9905.306628536006, 9797.559109840075, 9880.209583233396, 9881.703548893545, 9885.75285617858, 9896.406215627085, 9600.375975561636, 9733.853992190123, 9739.56171972263, 9751.17115045222, 9753.707388778348, 38936.415953760436, 39212.411813822815, 39343.80328098341, 39370.0, 39397.0, 2802.453521563296, 3200.4079245339685, 3366.9899030290817, 3721.813909304524, 3778.5465744110606, 28206.576901346496, 28395.57406638902, 28596.428071438662, 28630.85684571564, 29292.560611590845, 2690.7847372210176, 2795.4688609164195, 2806.7052959439375, 2835.5746638004257, 2867.569864520318, 440544.0, 441187.9999999968, 441462.0, 443066.0, 444106.0, 53702.92594148095, 54733.0, 60368.0, 60774.08838867421, 60998.78002440015, 65420.0, 65600.34399656038, 65949.01076483856, 66363.34546618178, 66561.0, 15616.609584760245, 15840.76238856418, 15844.970076944961, 15847.52457426279, 15856.762148567781, 11008.0, 11186.16103792219, 12049.578264760692, 12104.757904841854, 12280.14039017278, 19363.031848407805, 19367.418977430698, 19426.028698565297, 19518.70721939172, 19564.510887227934, 6663.800085997428, 7585.279398457138, 7917.2874441300555, 7966.0, 7993.760187194393, 941.8163458125737, 991.0733464210986, 1005.854151148094, 1017.4353233955226, 1176.7881781279282, 27618.0, 28575.856965721137, 28578.28554286118, 29102.417951640848, 30384.54423183654, 1060.2472244706191, 1088.2110469909253, 1093.9890601093887, 1136.4431428599926, 1152.9250598711058, 12560.623181304576, 12586.81119783204, 12678.366081695878, 12766.297853617954, 13095.148815327164, 405649.0, 431407.0, 432161.0, 432896.0, 433806.0, 52880.47119528832, 53531.46468535265, 53587.0, 53602.7319863406, 53625.731871340395, 1271.8664540223328, 1432.5917113622568, 1447.3993292783377, 1449.862263084984, 1575.818780840218, 28171.57742633903, 28766.712332876403, 28898.0, 29186.978455753946, 29734.0, 48274.0, 48796.26805597848, 48837.267440989126, 48847.0, 48909.75545122252, 483266.0, 486985.0, 490420.0, 501415.0, 621178.8941055447, 28963.565546517242, 28964.0, 29242.268943276587, 29363.0, 29448.558271625516, 31773.523397148598, 39736.2052758949, 40328.0, 40613.59386406098, 41044.58955410407, 27879.0, 33334.99995000154, 34694.82652586721, 34703.826480867436, 34990.47514287339, 27275.181744547695, 27481.17556473309, 31970.68029319677, 33727.66272337343, 34040.48939265864, 33407.49888751719, 33519.329613407106, 33976.15059623529, 33977.98066058022, 34001.14997125092, 29256.26859328534, 29279.85360073186, 31556.842215788773, 31746.0, 31824.04527864075, 24037.639435408833, 24804.0, 27908.86045569759, 31052.844735776176, 31083.222919427197], "unit": "score", "name": "ext.html", "value": 19011.777542503205}, {"lowerIsBetter": false, "replicates": [361.3207170519425, 361.5859840482647, 363.25532658051, 368.6571488515681, 370.3833117858765, 14489.78265326021, 14822.703545929102, 18487.075646217687, 19003.904980475094, 19898.70151947722, 18088.0, 18455.630887382278, 18709.438716838482, 19924.900375498102, 19963.0, 5801.0428279333855, 5986.191864098357, 6014.0, 6015.789447369343, 6025.15647809307, 4199.223143718406, 4361.454818147731, 4442.533533978934, 5942.6434413935085, 6025.638461692312, 6366.586171898835, 6535.607863528204, 6541.672916354187, 6543.803685889431, 6548.476121910236, 6257.874842503147, 6418.550701450877, 6423.7430502779835, 6424.582402143869, 6434.485241180694, 4520.457545094577, 5585.916211256835, 5614.045612245887, 5615.073512870372, 5620.522255608237, 12413.131080824345, 13039.54361597349, 19802.405927822187, 20059.1976320947, 22818.77181228183, 2185.9781402185936, 2196.560687862418, 2239.283429302624, 2264.445210923318, 2308.249818808894, 7398.593077380742, 8550.52972086535, 9769.51152442375, 9835.950820245924, 9997.900020999843, 1781.1628534588722, 1793.84752296055, 1796.9011704356255, 1805.0884303426817, 1829.2957211473545, 92769.53615231949, 94691.0, 94778.52610736972, 95667.0, 95764.04235957621, 10673.466326683634, 10776.568937242579, 10776.67669969902, 10801.351918884891, 10897.291676041032, 12768.445726109172, 12826.102172847812, 12889.097763156677, 12889.291088990196, 12932.67668308281, 8130.674773009014, 8141.1451797561585, 8161.67353305873, 8229.25936665703, 8250.504969701717, 7084.539504932163, 8130.918690813134, 8133.349332053422, 8133.918660813316, 8192.672293108328, 4238.703290769617, 4304.4834619845815, 4309.676774241944, 4351.08627188294, 4355.73865568067, 1694.7627332173506, 1745.694503461889, 1768.7170052791748, 1808.2586139682667, 1836.6510363030982, 394.1879727760765, 399.5185801109656, 429.5511190805616, 449.86054323159925, 875.6672464463463, 9220.723378298662, 11163.330200188015, 11505.309681419141, 11518.94240528792, 11575.536978520933, 444.7109378903738, 444.86431638350615, 447.1080195010974, 449.8043351142264, 454.96132828709267, 6049.546284028627, 6118.78584249558, 8241.299489543457, 10781.946090269656, 10801.0, 634942.0, 701546.0, 735541.0, 740396.0, 755555.0, 108633.76612987826, 108941.0, 108992.0, 110131.0, 111972.44013780043, 1138.2885696439726, 1167.6030149749126, 1193.176708071428, 1199.3703305764368, 1204.2894692131508, 17840.732389014436, 18196.545086372946, 18286.359977400727, 18295.54261143482, 18374.540636484195, 49026.509734902196, 49607.503924960285, 49960.25059624036, 50702.492975071254, 50978.0, 68030.65984670045, 70786.58426831538, 71575.64212178906, 72248.63875680589, 72727.63636181786, 7498.475106742694, 7641.388688904985, 7719.884201736866, 7728.149903510722, 7820.569868657051, 4604.194266003503, 10592.629257975934, 11653.669266146635, 11976.820347694966, 12050.480120704546, 10147.695569132939, 10350.5342259597, 10447.738806529898, 10527.263091583516, 10572.629957951434, 6539.939918925524, 10295.279330446796, 10316.793664126526, 10336.534855931652, 10481.528331225265, 9860.0, 10205.642802501878, 10541.31481453703, 10731.570737170427, 10769.299995500267, 7611.809704757426, 7667.769966901002, 7671.309582137635, 7681.807954801175, 7702.691892324468, 9760.658376956773, 10550.314229575053, 10636.361818290927, 10715.41065241388, 10722.839157412802], "unit": "score", "name": "jquery.html", "value": 8495.728088257993}, {"lowerIsBetter": false, "replicates": [1242.9440675169617, 1529.831718510964, 1572.992135039325, 1795.1831916477995, 1953.501857026459, 7880.881786773203, 8618.827623447527, 8761.95619021904, 8777.60500777465, 8785.165409286115, 8414.83170336593, 8683.43557668751, 8692.217700406962, 8702.738917832476, 8713.651453941851, 2200.5378870437225, 2254.9436264093447, 2256.142665787007, 2464.6813954534373, 2496.5755821510297, 2261.2650888461317, 2263.954720905581, 2449.0, 2512.7612876776675, 2517.509085728284, 2440.8169387296025, 2467.90128394864, 2472.6538284640164, 2472.7279999200073, 2485.9378515537164, 2445.6087026075743, 2461.729209786922, 2468.456939473313, 2474.9752502474926, 2476.3313905245573, 2427.0898413095088, 2460.852348859074, 2464.827462077655, 2475.740047295026, 2489.6887889013874, 8777.253933415668, 8835.160659737314, 8843.425177363451, 8846.557672116369, 8855.424397414148, 4470.26240670289, 5441.938821929725, 5449.618526703132, 5472.835814925519, 5492.258545096441, 3588.2105936693883, 3642.1258897864586, 3697.4453831925157, 3718.1819999600316, 3726.60252405348, 1056.4823236614081, 1069.4385447639972, 1076.364944682641, 1101.7906597746403, 1104.7072525780675, 12001.819972700416, 12040.939795301056, 12051.216670916363, 12054.578089766905, 12115.333656648882, 4860.8298709545, 4878.195097808893, 4952.860842006358, 4958.776855041532, 4965.230389289666, 10203.0, 10222.386656800616, 10230.437325946996, 10230.59077636901, 10240.641577544899, 5491.176323551419, 5498.202760599691, 5508.779648814083, 5511.448855114537, 5512.3660779010925, 4893.559579637849, 4939.802407903716, 4954.9752251238515, 4959.876003099879, 5015.949840501621, 3488.63369346215, 3539.185987222953, 3905.511811023622, 3929.2337994090876, 3990.2817492851564, 1219.6402061391912, 1244.5208594690928, 1246.6384748422856, 1285.7042880137622, 1311.731095125497, 1293.8512071111943, 1310.3644732304824, 1339.4240476594962, 1340.2561578324123, 1341.275711116006, 7957.920420795834, 8048.074471435742, 8063.637136328879, 8067.152948940394, 8110.594470276463, 1153.7288737146764, 1166.6616681162368, 1171.1801738782885, 1179.5930404010603, 1190.220405634311, 6212.937870621236, 6225.097360882737, 6311.053341998645, 6311.116443697886, 6319.24169099711, 9001.819963600692, 10239.385636861813, 10730.946345268223, 10756.247062705692, 10864.728381790519, 9423.952880235693, 10597.099246563974, 10694.62568810088, 10726.678199654023, 10793.29843560166, 8146.674133034612, 8184.099749027602, 8199.672013119527, 8212.876806847782, 8287.171282871665, 8041.316488098577, 8053.194680532134, 8115.7565273039545, 8147.511149331059, 8171.387145963958, 9443.386179898285, 9497.145256926633, 9664.081912218327, 9702.9029709702, 9786.559604817943, 9592.76018099553, 9791.510424478605, 9960.701178964642, 10062.798744025225, 10233.283670143019, 7575.053118360205, 7609.505382150142, 7627.733029343946, 7632.5038872473115, 7716.807079823049, 8229.177082291722, 8309.459885107448, 8311.792205194919, 8314.376421768271, 8335.95832020836, 6856.908642863775, 7081.973113898559, 7696.037995250594, 7803.102643196105, 7956.721514746956, 7114.21743608213, 7462.514936529108, 7464.626768661654, 7565.470417070752, 7586.24137586237, 7471.252874712485, 7606.163322034461, 7669.0, 7675.0, 7703.961480192564, 6983.6857341418745, 7026.683799229149, 7046.577205367695, 7046.647667616496, 7052.0832291801735, 7072.71709131629, 7116.537425067354, 7117.857642847218, 7142.9999800027, 7175.533590316612], "unit": "score", "name": "mootools.html", "value": 4956.428984722546}, {"lowerIsBetter": false, "replicates": [320.7257794585629, 326.580344257629, 327.34857633309707, 330.93381323735247, 335.7381242630747, 6171.197744293241, 6564.179477565304, 6658.633775142372, 6671.999999999994, 6713.784451131127, 6473.967630161843, 6580.0, 6675.933240667592, 6682.264950855402, 6684.966575167117, 4138.772367519785, 4811.30236115763, 4892.681975671588, 4910.312556242129, 4920.97539512302, 4907.2884431757375, 4924.4583095859425, 4925.48282430345, 4928.211486162215, 4945.950540494603, 4684.227102528079, 4767.856964291077, 4777.80888764449, 4788.664793464459, 4812.302216178669, 4767.0, 4792.161371759928, 4796.640251981098, 4807.78364973577, 4810.903781924342, 4071.2875246831686, 4081.632653061209, 4086.9182616347803, 4091.243120022805, 4102.220578090183, 5501.9174712379345, 6180.258368995705, 6407.775727849549, 6432.388923052303, 6454.838629034265, 5055.721935293557, 5446.0, 5719.571032172562, 5724.96950548901, 5738.167965644958, 7135.643217839139, 7145.821354466128, 7147.785566433015, 7151.570905745672, 7158.391536719385, 4621.676482646216, 4622.399088118523, 4626.236670949289, 4629.074185162947, 4634.420697412824, 6188.597741146811, 6524.282328943812, 7278.708851645928, 7411.036565246537, 7532.698692052311, 4652.3951886255245, 4688.835890743876, 4702.200625893606, 4717.009428020154, 4721.622270218374, 4756.8097276108565, 4774.379330686988, 4777.761111944458, 4792.0, 4796.088743138793, 5483.862903427366, 5721.4278572143285, 5723.227364305765, 5730.656160630292, 5734.856628584235, 7119.71521139159, 7193.5324203926575, 7221.638918054076, 7223.674934627954, 7231.89152162718, 1557.8052743407075, 1605.6146524833955, 1613.362721724912, 1643.6219669476088, 1649.9505014849574, 873.785922449004, 946.1910066892846, 1009.9242556808268, 1057.5611121384538, 1072.855164552791, 6500.252470965899, 6501.642409667514, 6548.770793022221, 6559.311272316433, 6605.30644282353, 7320.1215854097845, 7326.267373262631, 7327.963360183165, 7331.193568707438, 7347.008153899155, 6387.393197646216, 6549.508786841006, 6549.508786841006, 6562.409383155539, 6581.736730530725, 3194.904152875371, 3889.8833035008997, 3941.960580394217, 3946.743461674982, 3947.6644485218503, 6273.0, 7670.0, 7677.961610191914, 7689.538627682357, 7704.191059938737, 7419.925800742031, 7595.3164215220895, 7617.69529218825, 7627.618619069024, 7693.0, 7806.258405451473, 7823.921760782319, 7835.294823465915, 7906.090799558125, 7947.721829735931, 6165.907511387243, 7521.924780752122, 7536.8492630148185, 7553.32020118192, 7561.810954726176, 7223.2819760332595, 7345.934839448143, 7424.183339832722, 7437.107547094383, 7444.441666874898, 7883.763487095396, 7884.21157884207, 8093.919060809317, 8128.349732021542, 8144.063432705315, 4044.1102957349335, 4673.485916549245, 4683.976580117078, 4720.291956206596, 4727.57451829337, 7150.821229469305, 7183.20984691694, 7349.228331025379, 7474.065741782278, 7511.9624401877645, 6019.247594050744, 7072.752453664097, 7258.056452661121, 7271.490995630255, 7284.417246620152, 7242.804937185516, 7259.52813067149, 7259.745908893164, 7272.05463289769, 7274.0, 5809.0, 6795.762148324982, 7063.929360706533, 7067.57594544329, 7146.928530714834, 7269.600171990592, 7270.163931147986, 7278.09023872016, 7293.744718934812, 7294.635268236673, 6948.683826475993, 7016.473764467583, 7098.503104782616, 7112.786616401516, 7141.9642901785155], "unit": "score", "name": "prototype.html", "value": 5169.59160183499}, {"lowerIsBetter": false, "replicates": [664.2759392262433, 691.5263044814301, 698.8043347862593, 719.4100837313404, 747.2004954698475, 14809.0, 14954.32705528251, 14973.625659358535, 14994.925025374885, 15000.324985375657, 13605.591832245049, 13622.114562553426, 13641.386137623806, 13657.72684546311, 13664.38510267038, 667.4993754683975, 684.6816230452838, 692.3595674001554, 838.1241602525375, 838.7357982235607, 830.6552780596045, 838.9119142490011, 840.8024114333127, 841.20506121715, 841.4488510025943, 707.769974758203, 722.3751454991448, 888.6001299415257, 891.6656253904786, 892.1791951404723, 862.211076864668, 891.9331050171198, 892.9464232146092, 893.9553022348922, 894.1505569708738, 670.4033410264868, 670.6847781542716, 670.792054463118, 670.8859493886051, 671.9059331693518, 14527.418903243857, 14579.0, 14607.415703371853, 14629.707405851823, 14644.92677536616, 12389.256644601353, 12452.626421207378, 12501.93749031249, 12611.117221794479, 12823.294718790463, 10091.444970526618, 10105.242106841943, 10108.342957707726, 10180.949095254477, 10790.082842958358, 3558.8077993872084, 3580.516630254934, 3588.461062275597, 3600.5859326177565, 3634.582023067355, 76702.0, 76818.84771728428, 76889.0, 76947.61526192389, 77398.2260177391, 9306.044930904338, 9421.717348479557, 9425.198858097001, 9454.716358509255, 10143.594256229815, 19225.903870480837, 19814.811111333365, 21511.032003559878, 21522.0, 21541.461463463227, 7497.1003479581705, 7546.584937828362, 7694.538327700356, 7748.690052397841, 7900.012498437695, 4139.627433530996, 4189.455370801777, 4189.6438802701505, 4194.706370554032, 4196.349565817303, 3565.6612621800887, 3611.115276757159, 3611.5124458197806, 3617.9276414471565, 3620.6922411594783, 657.6580178307254, 662.3111963557942, 662.5196732368994, 662.5329142954206, 682.0383259603934, 524.609166171205, 581.4156772443667, 600.5885968111858, 610.8729443679898, 618.1716499890168, 8533.615987280587, 8638.265747411415, 8665.17680820321, 8954.373193876496, 9254.583543740548, 573.7160105747598, 600.798732424634, 613.6655522740117, 614.7264467312093, 623.4512835761757, 3786.5077539919635, 3963.405489176589, 4041.2725709372007, 4091.1204091120553, 4094.5905409458815, 88831.55584222038, 89117.0, 90213.0, 90263.19473610491, 90417.0, 77978.6101069491, 78081.60959195168, 78508.6074569635, 79695.0, 80110.19889801028, 65838.0, 67039.0, 67340.3164920871, 67376.6631166841, 68410.9738353925, 7953.602319883867, 8020.679172833022, 8087.555184464911, 8142.592870356577, 8210.384221183554, 47664.52335476601, 47739.76130119327, 48880.0223995511, 49002.26496602483, 49063.0, 50870.0, 71387.64306178436, 72837.0, 73940.0, 77619.79041676539, 11185.66443006711, 11491.195616307112, 11491.885081149081, 11717.238379505305, 12191.817122742988, 11987.400629968291, 11990.460429280878, 12011.0, 12080.335581543099, 12487.375631218585, 10283.691489255334, 10956.6347408153, 11124.479223633145, 11273.267237629529, 11367.943160284476, 11984.64046078619, 11993.82009269879, 12012.459439325077, 12226.083043771574, 12243.510259589517, 9562.95218523903, 11300.208985371273, 11576.88423115758, 11616.303021818718, 11679.357635329798, 9412.294077944045, 9467.384619999679, 9818.607255709978, 9827.754306142404, 9837.704868853945, 9858.014198580084, 10092.0, 10093.19254459656, 10098.545565449425, 10103.393796372242], "unit": "score", "name": "yui.html", "value": 6839.020648672553}], "name": "dromaeo_css", "value": 7364.619760543352}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 115.0, 161.0, 164.0, 111.0, 116.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.5}, {"lowerIsBetter": true, "replicates": [175.0, 146.0, 143.0, 158.0, 119.0, 143.0, 137.0, 122.0, 156.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 141.7}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 186.0, 184.0, 184.0, 184.0, 183.0, 181.0, 180.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 84.0, 78.0, 74.0, 82.0, 84.0, 110.0, 95.0, 54.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 125.0, 78.0, 81.0, 82.0, 108.0, 76.0, 77.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 86.0, 92.0, 86.0, 90.0, 85.0, 91.0, 85.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 95.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.9}, {"lowerIsBetter": true, "replicates": [101.0, 138.0, 85.0, 86.0, 85.0, 88.0, 86.0, 88.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 92.6}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 55.0, 54.0, 54.0, 53.0, 53.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 73.0, 73.0, 70.0, 66.0, 65.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 82.0, 81.0, 83.0, 70.0, 98.0, 98.0, 108.0, 106.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [121.0, 126.0, 121.0, 126.0, 132.0, 125.0, 123.0, 131.0, 125.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [137.0, 124.0, 137.0, 137.0, 134.0, 126.0, 137.0, 138.0, 137.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 65.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1432.7}]} 03:08:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1432.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7364.62"}}} 03:08:58 INFO - Return code: 0 03:08:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:08:58 INFO - # TBPL SUCCESS # 03:08:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:58 INFO - 2016-02-10 03:08:58.695 screenresolution[1691:9947] starting screenresolution argv=screenresolution get 03:08:58 INFO - 2016-02-10 03:08:58.698 screenresolution[1691:9947] Display 0: 1600x1200x32@60 03:08:58 INFO - 2016-02-10 03:08:58.704 screenresolution[1692:9950] starting screenresolution argv=screenresolution list 03:08:58 INFO - Available Modes on Display 0 03:08:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:58 INFO - Intel Iris: 03:08:58 INFO - Chipset Model: Intel Iris 03:08:58 INFO - Type: GPU 03:08:58 INFO - Bus: Built-In 03:08:58 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:58 INFO - Vendor: Intel (0x8086) 03:08:58 INFO - Device ID: 0x0a2e 03:08:58 INFO - Revision ID: 0x0009 03:08:58 INFO - Displays: 03:08:58 INFO - Display: 03:08:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:58 INFO - Display Serial Number: 1600x1200 60 03:08:58 INFO - Main Display: Yes 03:08:58 INFO - Mirror: Off 03:08:58 INFO - Online: Yes 03:08:58 INFO - Rotation: Supported 03:08:58 INFO - Return code: 0 03:08:58 INFO - Running post-action listener: _resource_record_post_action 03:08:58 INFO - Running post-run listener: _resource_record_post_run 03:08:59 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33775104; Write bytes: 710149120; Read time: 353; Write time: 1817 03:08:59 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393265664; Write bytes: 386721280; Read time: 29894; Write time: 663 03:09:00 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32013824; Write bytes: 301452800; Read time: 335; Write time: 1106 03:09:00 INFO - Running post-run listener: _upload_blobber_files 03:09:00 INFO - Blob upload gear active. 03:09:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:00 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 03:09:00 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'] 03:09:00 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 03:09:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:01 INFO - (blobuploader) - INFO - Done attempting. 03:09:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:02 INFO - (blobuploader) - INFO - Done attempting. 03:09:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:02 INFO - Return code: 0 03:09:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b95a7149eec580d15f8bbeda204b38e09f8502ca323dc73f747bc811cccceb8925013e2781941022d268c1bee3c0f9cebc65d4acdd7d80a9a17729f61f182d34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6af51c40f7819b7986916e15bcf0f8be61637a3501299acdb5019e8f4735af13f57b5951588e0e5378e21760f31d6538bf3fef57cdcfa8cbd107458ea61e3f4"} 03:09:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:02 INFO - Contents: 03:09:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b95a7149eec580d15f8bbeda204b38e09f8502ca323dc73f747bc811cccceb8925013e2781941022d268c1bee3c0f9cebc65d4acdd7d80a9a17729f61f182d34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6af51c40f7819b7986916e15bcf0f8be61637a3501299acdb5019e8f4735af13f57b5951588e0e5378e21760f31d6538bf3fef57cdcfa8cbd107458ea61e3f4"} 03:09:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:02 INFO - Copying logs to upload dir... 03:09:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.989586 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-10 03:09:02.853746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:02.857190) ========= 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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/b95a7149eec580d15f8bbeda204b38e09f8502ca323dc73f747bc811cccceb8925013e2781941022d268c1bee3c0f9cebc65d4acdd7d80a9a17729f61f182d34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6af51c40f7819b7986916e15bcf0f8be61637a3501299acdb5019e8f4735af13f57b5951588e0e5378e21760f31d6538bf3fef57cdcfa8cbd107458ea61e3f4"} build_url:https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/ediIUhyvTvK89nHZ1nbSeQ/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/b95a7149eec580d15f8bbeda204b38e09f8502ca323dc73f747bc811cccceb8925013e2781941022d268c1bee3c0f9cebc65d4acdd7d80a9a17729f61f182d34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6af51c40f7819b7986916e15bcf0f8be61637a3501299acdb5019e8f4735af13f57b5951588e0e5378e21760f31d6538bf3fef57cdcfa8cbd107458ea61e3f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:02.883371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:02.883776) ========= 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.zFfAwmEnzI/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.m1tjPOUwel/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005196 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 03:09:02.931446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:09:02.931728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 03:09:02.932072) ========= ========= Total master_lag: 0.51 =========