builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0072 starttime: 1456975599.78 results: success (0) buildid: 20160302174022 builduid: a5392d02e6f84ce0a1cf16d8c0f2a39e revision: 09d8e3caf51daf1554673799609b575de4383a02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.780973) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.781445) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.781767) ========= 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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005907 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.821318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.821642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.840350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.840632) ========= 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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005630 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.889663) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.892036) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.892414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:39.892707) ========= 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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-02 19:26:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-03-02 19:26:40 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:40.069902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:40.070235) ========= 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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.026667 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:40.118791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:40.119259) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 09d8e3caf51daf1554673799609b575de4383a02 --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 09d8e3caf51daf1554673799609b575de4383a02 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-02 19:26:40,200 truncating revision to first 12 chars 2016-03-02 19:26:40,201 Setting DEBUG logging. 2016-03-02 19:26:40,201 attempt 1/10 2016-03-02 19:26:40,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/09d8e3caf51d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 19:26:40,880 unpacking tar archive at: fx-team-09d8e3caf51d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:41.065039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:41.065401) ========= echo 09d8e3caf51daf1554673799609b575de4383a02 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'09d8e3caf51daf1554673799609b575de4383a02'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09d8e3caf51daf1554673799609b575de4383a02 program finished with exit code 0 elapsedTime=0.005324 script_repo_revision: '09d8e3caf51daf1554673799609b575de4383a02' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:41.116310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:41.116732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 19:26:41.129556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-02 19:26:41.129922) ========= /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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:26:41 INFO - MultiFileLogger online at 20160302 19:26:41 in /builds/slave/test 19:26:41 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 19:26:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:26:41 INFO - {'append_to_log': False, 19:26:41 INFO - 'base_work_dir': '/builds/slave/test', 19:26:41 INFO - 'blob_upload_branch': 'Fx-Team', 19:26:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:26:41 INFO - 'branch': 'Fx-Team', 19:26:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:26:41 INFO - 'config_files': ('talos/mac_config.py',), 19:26:41 INFO - 'default_actions': ('clobber', 19:26:41 INFO - 'read-buildbot-config', 19:26:41 INFO - 'download-and-extract', 19:26:41 INFO - 'populate-webroot', 19:26:41 INFO - 'create-virtualenv', 19:26:41 INFO - 'install', 19:26:41 INFO - 'run-tests'), 19:26:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:26:41 INFO - 'download_minidump_stackwalk': True, 19:26:41 INFO - 'download_symbols': 'ondemand', 19:26:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:26:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:26:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:26:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:26:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:26:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:26:41 INFO - 'installer_path': 'installer.exe', 19:26:41 INFO - 'log_level': 'info', 19:26:41 INFO - 'log_name': 'talos', 19:26:41 INFO - 'log_to_console': True, 19:26:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:26:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:26:41 INFO - 'opt_config_files': (), 19:26:41 INFO - 'pip_index': False, 19:26:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:26:41 INFO - 'cmd': ('bash', 19:26:41 INFO - '-c', 19:26:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:26:41 INFO - 'enabled': True, 19:26:41 INFO - 'halt_on_failure': False, 19:26:41 INFO - 'name': 'check_screen_resolution'},), 19:26:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:26:41 INFO - 'cmd': ('bash', 19:26:41 INFO - '-c', 19:26:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:26:41 INFO - 'enabled': True, 19:26:41 INFO - 'halt_on_failure': False, 19:26:41 INFO - 'name': 'check_screen_resolution'},), 19:26:41 INFO - 'run_cmd_checks_enabled': True, 19:26:41 INFO - 'sps_profile': False, 19:26:41 INFO - 'sps_profile_interval': 0, 19:26:41 INFO - 'suite': 'dromaeojs', 19:26:41 INFO - 'system_bits': '32', 19:26:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:26:41 INFO - 'title': 't-yosemite-r7-0072', 19:26:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:26:41 INFO - 'use_talos_json': True, 19:26:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:26:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:26:41 INFO - 'work_dir': 'build'} 19:26:41 INFO - ##### 19:26:41 INFO - ##### Running clobber step. 19:26:41 INFO - ##### 19:26:41 INFO - Running pre-action listener: _resource_record_pre_action 19:26:41 INFO - Running main action method: clobber 19:26:41 INFO - rmtree: /builds/slave/test/build 19:26:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:26:42 INFO - Running post-action listener: _resource_record_post_action 19:26:42 INFO - ##### 19:26:42 INFO - ##### Running read-buildbot-config step. 19:26:42 INFO - ##### 19:26:42 INFO - Running pre-action listener: _resource_record_pre_action 19:26:42 INFO - Running main action method: read_buildbot_config 19:26:42 INFO - Using buildbot properties: 19:26:42 INFO - { 19:26:42 INFO - "project": "", 19:26:42 INFO - "product": "firefox", 19:26:42 INFO - "script_repo_revision": "production", 19:26:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:26:42 INFO - "repository": "", 19:26:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:26:42 INFO - "buildid": "20160302174022", 19:26:42 INFO - "pgo_build": "False", 19:26:42 INFO - "basedir": "/builds/slave/test", 19:26:42 INFO - "buildnumber": 440, 19:26:42 INFO - "slavename": "t-yosemite-r7-0072", 19:26:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:26:42 INFO - "platform": "yosemite_r7", 19:26:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:26:42 INFO - "branch": "fx-team", 19:26:42 INFO - "repo_path": "integration/fx-team", 19:26:42 INFO - "revision": "09d8e3caf51daf1554673799609b575de4383a02", 19:26:42 INFO - "stage_platform": "macosx64", 19:26:42 INFO - "builduid": "a5392d02e6f84ce0a1cf16d8c0f2a39e", 19:26:42 INFO - "slavebuilddir": "test" 19:26:42 INFO - } 19:26:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 19:26:42 INFO - Running post-action listener: _resource_record_post_action 19:26:42 INFO - ##### 19:26:42 INFO - ##### Running download-and-extract step. 19:26:42 INFO - ##### 19:26:42 INFO - Running pre-action listener: _resource_record_pre_action 19:26:42 INFO - Running main action method: download_and_extract 19:26:42 INFO - mkdir: /builds/slave/test/build/tests 19:26: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')]} 19:26:42 INFO - https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 19:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 19:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 19:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 19:26:43 INFO - Downloaded 1277 bytes. 19:26:43 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 19:26:43 INFO - Using the following test package requirements: 19:26:43 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:26:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 19:26:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 19:26:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'jsshell-mac.zip'], 19:26:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 19:26:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:26:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 19:26:43 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 19:26:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 19:26:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:26:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:26:43 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 19:26:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:43 INFO - https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:44 INFO - Downloaded 17855083 bytes. 19:26:44 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'] 19:26:44 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 19:26:48 INFO - Return code: 0 19:26:48 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 19:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:48 INFO - https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:49 INFO - Downloaded 17855083 bytes. 19:26:49 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'] 19:26:49 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 19:26:53 INFO - Return code: 0 19:26:53 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')]} 19:26:53 INFO - https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:26:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:26:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:26:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:53 INFO - Downloaded 10808263 bytes. 19:26:53 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'] 19:26:53 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 19:26:54 INFO - Return code: 0 19:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:54 INFO - https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:26:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:26:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:26:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 19:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFATSoc0RIuOcAMrq_PW0A/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 19:26:56 INFO - Downloaded 110963437 bytes. 19:26:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:26:56 INFO - mkdir: /builds/slave/test/properties 19:26:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:26:56 INFO - Writing to file /builds/slave/test/properties/build_url 19:26:56 INFO - Contents: 19:26:56 INFO - build_url:https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:26:58 INFO - Running post-action listener: _resource_record_post_action 19:26:58 INFO - Running post-action listener: set_extra_try_arguments 19:26:58 INFO - ##### 19:26:58 INFO - ##### Running populate-webroot step. 19:26:58 INFO - ##### 19:26:58 INFO - Running pre-action listener: _resource_record_pre_action 19:26:58 INFO - Running main action method: populate_webroot 19:26:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:26:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:26:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:26:58 INFO - '--tppagecycles', 19:26:58 INFO - '7'], 19:26:58 INFO - 'tests': ['tsvgm']}}, 19:26:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:26:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:26:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:26:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:26:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'tests': ['damp', 'tps']}, 19:26:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['damp', 'tps']}, 19:26:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:26:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:26:58 INFO - 'other': {'tests': ['a11yr', 19:26:58 INFO - 'ts_paint', 19:26:58 INFO - 'tpaint', 19:26:58 INFO - 'sessionrestore', 19:26:58 INFO - 'sessionrestore_no_auto_restore']}, 19:26:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['a11yr', 19:26:58 INFO - 'ts_paint', 19:26:58 INFO - 'tpaint', 19:26:58 INFO - 'sessionrestore', 19:26:58 INFO - 'sessionrestore_no_auto_restore']}, 19:26:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['a11yr', 19:26:58 INFO - 'ts_paint', 19:26:58 INFO - 'tpaint', 19:26:58 INFO - 'sessionrestore', 19:26:58 INFO - 'sessionrestore_no_auto_restore']}, 19:26:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['a11yr', 19:26:58 INFO - 'ts_paint', 19:26:58 INFO - 'tpaint', 19:26:58 INFO - 'sessionrestore', 19:26:58 INFO - 'sessionrestore_no_auto_restore']}, 19:26:58 INFO - 'other_l64': {'tests': ['a11yr', 19:26:58 INFO - 'ts_paint', 19:26:58 INFO - 'tpaint', 19:26:58 INFO - 'sessionrestore', 19:26:58 INFO - 'sessionrestore_no_auto_restore']}, 19:26:58 INFO - 'other_nol64': {'tests': ['a11yr', 19:26:58 INFO - 'ts_paint', 19:26:58 INFO - 'tpaint', 19:26:58 INFO - 'sessionrestore', 19:26:58 INFO - 'sessionrestore_no_auto_restore']}, 19:26:58 INFO - 'svgr': {'tests': ['tsvgx', 19:26:58 INFO - 'tsvgr_opacity', 19:26:58 INFO - 'tart', 19:26:58 INFO - 'tscrollx', 19:26:58 INFO - 'cart']}, 19:26:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['tsvgx', 19:26:58 INFO - 'tsvgr_opacity', 19:26:58 INFO - 'tart', 19:26:58 INFO - 'tscrollx', 19:26:58 INFO - 'cart']}, 19:26:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'tests': ['tp5o']}, 19:26:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'talos_options': ['--e10s'], 19:26:58 INFO - 'tests': ['tp5o']}, 19:26:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'talos_options': ['--xperf_path', 19:26:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:58 INFO - 'tests': ['tp5n']}, 19:26:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:58 INFO - 'talos_options': ['--e10s', 19:26:58 INFO - '--xperf_path', 19:26:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:58 INFO - 'tests': ['tp5n']}}, 19:26:58 INFO - 'talos.zip': {'path': '', 19:26:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:26:58 INFO - Running post-action listener: _resource_record_post_action 19:26:58 INFO - ##### 19:26:58 INFO - ##### Running create-virtualenv step. 19:26:58 INFO - ##### 19:26:58 INFO - Running pre-action listener: _resource_record_pre_action 19:26:58 INFO - Running main action method: create_virtualenv 19:26:58 INFO - Creating virtualenv /builds/slave/test/build/venv 19:26:58 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 19:26:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:26:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:26:58 INFO - Using real prefix '/tools/python27' 19:26:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:26:58 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:01 INFO - Installing pip.................done. 19:27:01 INFO - Return code: 0 19:27:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:01 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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:01 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 19:27:01 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 19:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:01 INFO - 'HOME': '/Users/cltbld', 19:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:01 INFO - 'LOGNAME': 'cltbld', 19:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:01 INFO - 'MOZ_NO_REMOTE': '1', 19:27:01 INFO - 'NO_EM_RESTART': '1', 19:27:01 INFO - 'PAGER': '/bin/cat', 19:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:01 INFO - 'PWD': '/builds/slave/test', 19:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:01 INFO - 'SHELL': '/bin/bash', 19:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:01 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:01 INFO - 'USER': 'cltbld', 19:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:01 INFO - 'XPC_FLAGS': '0x0', 19:27:01 INFO - 'XPC_SERVICE_NAME': '0', 19:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:02 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 19:27:02 INFO - Cleaning up... 19:27:02 INFO - Return code: 0 19:27:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:02 INFO - 'HOME': '/Users/cltbld', 19:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:02 INFO - 'LOGNAME': 'cltbld', 19:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:02 INFO - 'MOZ_NO_REMOTE': '1', 19:27:02 INFO - 'NO_EM_RESTART': '1', 19:27:02 INFO - 'PAGER': '/bin/cat', 19:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:02 INFO - 'PWD': '/builds/slave/test', 19:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:02 INFO - 'SHELL': '/bin/bash', 19:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:02 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:02 INFO - 'USER': 'cltbld', 19:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:02 INFO - 'XPC_FLAGS': '0x0', 19:27:02 INFO - 'XPC_SERVICE_NAME': '0', 19:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:02 INFO - Downloading/unpacking psutil>=0.7.1 19:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:05 INFO - Installing collected packages: psutil 19:27:05 INFO - Running setup.py install for psutil 19:27:05 INFO - building 'psutil._psutil_osx' extension 19:27:05 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 19:27:05 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 19:27:06 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 19:27:06 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 19:27:06 INFO - building 'psutil._psutil_posix' extension 19:27:06 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 19:27:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:27:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:27:06 INFO - ^ 19:27:06 INFO - 1 warning generated. 19:27:06 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 19:27:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:06 INFO - Successfully installed psutil 19:27:06 INFO - Cleaning up... 19:27:06 INFO - Return code: 0 19:27:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:06 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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:06 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 19:27:06 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 19:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:06 INFO - 'HOME': '/Users/cltbld', 19:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:06 INFO - 'LOGNAME': 'cltbld', 19:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:06 INFO - 'MOZ_NO_REMOTE': '1', 19:27:06 INFO - 'NO_EM_RESTART': '1', 19:27:06 INFO - 'PAGER': '/bin/cat', 19:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:06 INFO - 'PWD': '/builds/slave/test', 19:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:06 INFO - 'SHELL': '/bin/bash', 19:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:06 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:06 INFO - 'USER': 'cltbld', 19:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:06 INFO - 'XPC_FLAGS': '0x0', 19:27:06 INFO - 'XPC_SERVICE_NAME': '0', 19:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:27:09 INFO - Installing collected packages: mozsystemmonitor 19:27:09 INFO - Running setup.py install for mozsystemmonitor 19:27:09 INFO - Successfully installed mozsystemmonitor 19:27:09 INFO - Cleaning up... 19:27:09 INFO - Return code: 0 19:27:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:09 INFO - 'HOME': '/Users/cltbld', 19:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:09 INFO - 'LOGNAME': 'cltbld', 19:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:09 INFO - 'MOZ_NO_REMOTE': '1', 19:27:09 INFO - 'NO_EM_RESTART': '1', 19:27:09 INFO - 'PAGER': '/bin/cat', 19:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:09 INFO - 'PWD': '/builds/slave/test', 19:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:09 INFO - 'SHELL': '/bin/bash', 19:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:09 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:09 INFO - 'USER': 'cltbld', 19:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:09 INFO - 'XPC_FLAGS': '0x0', 19:27:09 INFO - 'XPC_SERVICE_NAME': '0', 19:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:09 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:13 INFO - Downloading docopt-0.6.1.tar.gz 19:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:13 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:13 INFO - Running setup.py install for blobuploader 19:27:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:13 INFO - Running setup.py install for requests 19:27:13 INFO - Running setup.py install for docopt 19:27:14 INFO - Successfully installed blobuploader requests docopt 19:27:14 INFO - Cleaning up... 19:27:14 INFO - Return code: 0 19:27:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:14 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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:14 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 19:27:14 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 19:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:14 INFO - 'HOME': '/Users/cltbld', 19:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:14 INFO - 'LOGNAME': 'cltbld', 19:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:14 INFO - 'MOZ_NO_REMOTE': '1', 19:27:14 INFO - 'NO_EM_RESTART': '1', 19:27:14 INFO - 'PAGER': '/bin/cat', 19:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:14 INFO - 'PWD': '/builds/slave/test', 19:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:14 INFO - 'SHELL': '/bin/bash', 19:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:14 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:14 INFO - 'USER': 'cltbld', 19:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:14 INFO - 'XPC_FLAGS': '0x0', 19:27:14 INFO - 'XPC_SERVICE_NAME': '0', 19:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:14 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-f_ad16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:14 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-squ_0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:14 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-vfb5w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:14 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7lANIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:14 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-tIX0xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:14 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ssuNHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-NG8wPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zb8rAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-oFAu0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7W_T21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-f1_rgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Y6GF3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-3IZvYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-g9g1av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-pc1KwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-177hVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Zpyt_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:16 INFO - Running setup.py install for manifestparser 19:27:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozcrash 19:27:16 INFO - Running setup.py install for mozdebug 19:27:16 INFO - Running setup.py install for mozdevice 19:27:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:16 INFO - Running setup.py install for mozfile 19:27:16 INFO - Running setup.py install for mozhttpd 19:27:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozinfo 19:27:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozInstall 19:27:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozleak 19:27:17 INFO - Running setup.py install for mozlog 19:27:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for moznetwork 19:27:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:17 INFO - Running setup.py install for mozprocess 19:27:17 INFO - Running setup.py install for mozprofile 19:27:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozrunner 19:27:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Running setup.py install for mozscreenshot 19:27:18 INFO - Running setup.py install for moztest 19:27:18 INFO - Running setup.py install for mozversion 19:27:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:18 INFO - Cleaning up... 19:27:18 INFO - Return code: 0 19:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:18 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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:18 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 19:27:18 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 19:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:18 INFO - 'HOME': '/Users/cltbld', 19:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:18 INFO - 'LOGNAME': 'cltbld', 19:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:18 INFO - 'MOZ_NO_REMOTE': '1', 19:27:18 INFO - 'NO_EM_RESTART': '1', 19:27:18 INFO - 'PAGER': '/bin/cat', 19:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:18 INFO - 'PWD': '/builds/slave/test', 19:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:18 INFO - 'SHELL': '/bin/bash', 19:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:18 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:18 INFO - 'USER': 'cltbld', 19:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:18 INFO - 'XPC_FLAGS': '0x0', 19:27:18 INFO - 'XPC_SERVICE_NAME': '0', 19:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-F4547S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7qESRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-nSVmnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-AFiokH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-fAlr2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-CD8iPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-3RMP2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-BLC1GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Q201OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:19 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)) 19:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-S9WBon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zELzbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-nvRgJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-K2ebo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-vB183F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-YURd8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-k0SsjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:20 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)) 19:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-LWOGGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:20 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)) 19:27:20 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)) 19:27:20 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)) 19:27:20 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)) 19:27:20 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)) 19:27:20 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)) 19:27:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:20 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 19:27:20 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 19:27:20 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 19:27:20 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 19:27:20 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 19:27:20 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 19:27:23 INFO - Downloading blessings-1.6.tar.gz 19:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:23 INFO - Installing collected packages: blessings 19:27:23 INFO - Running setup.py install for blessings 19:27:23 INFO - Successfully installed blessings 19:27:23 INFO - Cleaning up... 19:27:23 INFO - Return code: 0 19:27:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:23 INFO - Reading from file tmpfile_stdout 19:27:23 INFO - Current package versions: 19:27:23 INFO - blessings == 1.6 19:27:23 INFO - blobuploader == 1.2.4 19:27:23 INFO - docopt == 0.6.1 19:27:23 INFO - manifestparser == 1.1 19:27:23 INFO - mozInstall == 1.12 19:27:23 INFO - mozcrash == 0.16 19:27:23 INFO - mozdebug == 0.1 19:27:23 INFO - mozdevice == 0.48 19:27:23 INFO - mozfile == 1.2 19:27:23 INFO - mozhttpd == 0.7 19:27:23 INFO - mozinfo == 0.9 19:27:23 INFO - mozleak == 0.1 19:27:23 INFO - mozlog == 3.1 19:27:23 INFO - moznetwork == 0.27 19:27:23 INFO - mozprocess == 0.22 19:27:23 INFO - mozprofile == 0.28 19:27:23 INFO - mozrunner == 6.11 19:27:23 INFO - mozscreenshot == 0.1 19:27:23 INFO - mozsystemmonitor == 0.0 19:27:23 INFO - moztest == 0.7 19:27:23 INFO - mozversion == 1.4 19:27:23 INFO - psutil == 3.1.1 19:27:23 INFO - requests == 1.2.3 19:27:23 INFO - wsgiref == 0.1.2 19:27:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:23 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')]} 19:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:23 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')]} 19:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:23 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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:23 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 19:27:23 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 19:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:23 INFO - 'HOME': '/Users/cltbld', 19:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:23 INFO - 'LOGNAME': 'cltbld', 19:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:23 INFO - 'MOZ_NO_REMOTE': '1', 19:27:23 INFO - 'NO_EM_RESTART': '1', 19:27:23 INFO - 'PAGER': '/bin/cat', 19:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:23 INFO - 'PWD': '/builds/slave/test', 19:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:23 INFO - 'SHELL': '/bin/bash', 19:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:23 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:23 INFO - 'USER': 'cltbld', 19:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:23 INFO - 'XPC_FLAGS': '0x0', 19:27:23 INFO - 'XPC_SERVICE_NAME': '0', 19:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 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)) 19:27:24 INFO - Cleaning up... 19:27:24 INFO - Return code: 0 19:27:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27:24 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')]} 19:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:24 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')]} 19:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:24 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 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27:24 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 19:27:24 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 19:27:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:24 INFO - 'HOME': '/Users/cltbld', 19:27:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:24 INFO - 'LOGNAME': 'cltbld', 19:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:24 INFO - 'MOZ_NO_REMOTE': '1', 19:27:24 INFO - 'NO_EM_RESTART': '1', 19:27:24 INFO - 'PAGER': '/bin/cat', 19:27:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:24 INFO - 'PWD': '/builds/slave/test', 19:27:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:24 INFO - 'SHELL': '/bin/bash', 19:27:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:24 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:24 INFO - 'USER': 'cltbld', 19:27:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:24 INFO - 'XPC_FLAGS': '0x0', 19:27:24 INFO - 'XPC_SERVICE_NAME': '0', 19:27:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:24 INFO - Downloading/unpacking jsonschema 19:27:24 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 19:27:24 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 19:27:24 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 19:27:24 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 19:27:24 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 19:27:24 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 19:27:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:27 INFO - Downloading/unpacking functools32 (from jsonschema) 19:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:27 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:27 INFO - warning: no files found matching '*.txt' 19:27:27 INFO - no previously-included directories found matching 'build' 19:27:27 INFO - no previously-included directories found matching 'dist' 19:27:27 INFO - no previously-included directories found matching '.git*' 19:27:27 INFO - Installing collected packages: jsonschema, functools32 19:27:28 INFO - Running setup.py install for functools32 19:27:28 INFO - warning: no files found matching '*.txt' 19:27:28 INFO - no previously-included directories found matching 'build' 19:27:28 INFO - no previously-included directories found matching 'dist' 19:27:28 INFO - no previously-included directories found matching '.git*' 19:27:28 INFO - Successfully installed jsonschema functools32 19:27:28 INFO - Cleaning up... 19:27:28 INFO - Return code: 0 19:27:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d0eea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0f64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893adb34a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, '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.WmvWPzW9cj/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.74jJMBbzCv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 19:27: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', 'flake8'] in /builds/slave/test/build 19:27: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 flake8 19:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:28 INFO - 'HOME': '/Users/cltbld', 19:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:28 INFO - 'LOGNAME': 'cltbld', 19:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:28 INFO - 'MOZ_NO_REMOTE': '1', 19:27:28 INFO - 'NO_EM_RESTART': '1', 19:27:28 INFO - 'PAGER': '/bin/cat', 19:27:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:28 INFO - 'PWD': '/builds/slave/test', 19:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:28 INFO - 'SHELL': '/bin/bash', 19:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:27:28 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:28 INFO - 'USER': 'cltbld', 19:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:28 INFO - 'XPC_FLAGS': '0x0', 19:27:28 INFO - 'XPC_SERVICE_NAME': '0', 19:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:28 INFO - Downloading/unpacking flake8 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:27:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:27:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:27:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:27:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:27:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:27:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:27:32 INFO - no previously-included directories found matching 'docs/_build' 19:27:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:27:32 INFO - Running setup.py install for pep8 19:27:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:27:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:27:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:27:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:27:32 INFO - no previously-included directories found matching 'docs/_build' 19:27:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:27:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:27:32 INFO - Cleaning up... 19:27:32 INFO - Return code: 0 19:27:32 INFO - Running post-action listener: _resource_record_post_action 19:27:32 INFO - Running post-action listener: _start_resource_monitoring 19:27:32 INFO - Starting resource monitoring. 19:27:32 INFO - ##### 19:27:32 INFO - ##### Running install step. 19:27:32 INFO - ##### 19:27:32 INFO - Running pre-action listener: _resource_record_pre_action 19:27:32 INFO - Running main action method: install 19:27:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:33 INFO - Reading from file tmpfile_stdout 19:27:33 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:33 INFO - Reading from file tmpfile_stdout 19:27:33 INFO - Output received: 19:27:33 INFO - Usage: mozinstall [options] installer 19:27:33 INFO - Options: 19:27:33 INFO - -h, --help show this help message and exit 19:27:33 INFO - -d DEST, --destination=DEST 19:27:33 INFO - Directory to install application into. [default: 19:27:33 INFO - "/builds/slave/test"] 19:27:33 INFO - --app=APP Application being installed. [default: firefox] 19:27:33 INFO - mkdir: /builds/slave/test/build/application 19:27:33 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'] 19:27:33 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 19:28:06 INFO - Reading from file tmpfile_stdout 19:28:06 INFO - Output received: 19:28:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:28:06 INFO - Running post-action listener: _resource_record_post_action 19:28:06 INFO - ##### 19:28:06 INFO - ##### Running run-tests step. 19:28:06 INFO - ##### 19:28:06 INFO - Running pre-action listener: _resource_record_pre_action 19:28:06 INFO - Running main action method: run_tests 19:28:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:28:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:28:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:28:06 INFO - 2016-03-02 19:28:06.871 screenresolution[1639:7555] starting screenresolution argv=screenresolution get 19:28:06 INFO - 2016-03-02 19:28:06.874 screenresolution[1639:7555] Display 0: 1600x1200x32@60 19:28:06 INFO - 2016-03-02 19:28:06.880 screenresolution[1640:7557] starting screenresolution argv=screenresolution list 19:28:06 INFO - Available Modes on Display 0 19:28:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:28:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:28:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:28:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:28:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:28:07 INFO - Intel Iris: 19:28:07 INFO - Chipset Model: Intel Iris 19:28:07 INFO - Type: GPU 19:28:07 INFO - Bus: Built-In 19:28:07 INFO - VRAM (Dynamic, Max): 1536 MB 19:28:07 INFO - Vendor: Intel (0x8086) 19:28:07 INFO - Device ID: 0x0a2e 19:28:07 INFO - Revision ID: 0x0009 19:28:07 INFO - Displays: 19:28:07 INFO - Display: 19:28:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:28:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:28:07 INFO - Display Serial Number: 1600x1200 60 19:28:07 INFO - Main Display: Yes 19:28:07 INFO - Mirror: Off 19:28:07 INFO - Online: Yes 19:28:07 INFO - Rotation: Supported 19:28:07 INFO - Return code: 0 19:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:07 INFO - Python 2.7.3 19:28:07 INFO - Return code: 0 19:28:07 INFO - grabbing minidump binary from tooltool 19:28:07 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')]} 19:28:07 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 0x10cf92d30>, '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 0x10cdb6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf89b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:07 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 19:28:07 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 19:28:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:07 INFO - Return code: 0 19:28:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:28:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:28:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:28:08 INFO - Return code: 0 19:28:08 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/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 19:28:08 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/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --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 19:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WmvWPzW9cj/Render', 19:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:08 INFO - 'HOME': '/Users/cltbld', 19:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:08 INFO - 'LOGNAME': 'cltbld', 19:28:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:08 INFO - 'MOZ_NO_REMOTE': '1', 19:28:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:08 INFO - 'NO_EM_RESTART': '1', 19:28:08 INFO - 'PAGER': '/bin/cat', 19:28:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:08 INFO - 'PWD': '/builds/slave/test', 19:28:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:08 INFO - 'SHELL': '/bin/bash', 19:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.74jJMBbzCv/Listeners', 19:28:08 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 19:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:08 INFO - 'USER': 'cltbld', 19:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:08 INFO - 'XPC_FLAGS': '0x0', 19:28:08 INFO - 'XPC_SERVICE_NAME': '0', 19:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:08 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/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 19:28:08 INFO - mozversion application_buildid: 20160302174022 19:28:08 INFO - mozversion application_changeset: 09d8e3caf51daf1554673799609b575de4383a02 19:28:08 INFO - mozversion application_display_name: Nightly 19:28:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:08 INFO - mozversion application_name: Firefox 19:28:08 INFO - mozversion application_remotingname: firefox 19:28:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:28:08 INFO - mozversion application_vendor: Mozilla 19:28:08 INFO - mozversion application_version: 47.0a1 19:28:08 INFO - mozversion platform_buildid: 20160302174022 19:28:08 INFO - mozversion platform_changeset: 09d8e3caf51daf1554673799609b575de4383a02 19:28:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:28:08 INFO - mozversion platform_version: 47.0a1 19:28:08 INFO - using testdate: 1456975688 19:28:08 INFO - actual date: 1456975688 19:28:08 INFO - starting webserver on 'localhost:49290' 19:28:08 INFO - SUITE-START | Running 2 tests 19:28:08 INFO - TEST-START | dromaeo_css 19:28:08 INFO - operating with platform_type : mac_ 19:28:08 INFO - Initialising browser for dromaeo_css test... 19:28:08 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpZ9UG_1/profile http://localhost:49290/getInfo.html) 19:28:11 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 19:28:11 INFO - PROCESS | 1658 | colorDepth:24 19:28:11 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 19:28:11 INFO - PROCESS | 1658 | __metrics 19:28:11 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:28:11 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:28:11 INFO - TEST-INFO | 1658: exit 0 19:28:11 INFO - Browser initialized. 19:28:11 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:11 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpZ9UG_1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:23 INFO - PROCESS | 1661 | RSS: Main: 243646464 19:28:23 INFO - PROCESS | 1661 | 19:29:14 INFO - PROCESS | 1661 | 1456975754808 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:31:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49290/tests/dromaeo/cssquery-ext.html) 19:31:26 INFO - PROCESS | 1661 | RSS: Main: 467238912 19:31:26 INFO - PROCESS | 1661 | 19:34:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-ext.html (next: http://localhost:49290/tests/dromaeo/cssquery-jquery.html) 19:34:30 INFO - PROCESS | 1661 | RSS: Main: 380891136 19:34:30 INFO - PROCESS | 1661 | 19:37:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49290/tests/dromaeo/cssquery-mootools.html) 19:37:32 INFO - PROCESS | 1661 | RSS: Main: 378904576 19:37:32 INFO - PROCESS | 1661 | 19:40:34 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49290/tests/dromaeo/cssquery-prototype.html) 19:40:35 INFO - PROCESS | 1661 | RSS: Main: 344580096 19:40:35 INFO - PROCESS | 1661 | 19:43:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49290/tests/dromaeo/cssquery-yui.html) 19:43:39 INFO - PROCESS | 1661 | RSS: Main: 342261760 19:43:39 INFO - PROCESS | 1661 | 19:46:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-yui.html (next: http://localhost:49290/tests/dromaeo/cssquery-dojo.html) 19:46:42 INFO - PROCESS | 1661 | RSS: Main: 410820608 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | __start_tp_report 19:46:42 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 19:46:42 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 19:46:42 INFO - PROCESS | 1661 | |i|pagename|runs| 19:46:42 INFO - PROCESS | 1661 | |0;dojo.html;3411.7270618350535;3463.982680086599;3483.790972541647;3505.2638945821377;3536.0452677777002;5601.327840659126;5655.915161272585;5662.292213473316;5669.971650141754;5672.347680016799;5631.380548139701;5655.095184770437;5701;5774.07614781635;5793.159991801186;5114.795408183687;5138.126518491856;5147.1249887519025;5168.2764412982215;5175.974120129413;5118.129917913945;5121.2318152277085;5178.8705282368055;5182.637215394924;5230.947690523084;5107.106256405114;5130.948690513103;5198.636095473318;5231.084560201949;5231.372235331746;5171.482851714836;5181.766820493049;5210;5216.504432078947;5223.2165175223645;5123.308353372285;5180.274761533388;5195.116830138885;5202.765875535572;5211.791528338862;5519.503244707956;5548.944510554883;5642.379338272786;5687.232223649796;5692.260006199168;6234.345393733638;6240.282367527747;6245.375462453764;6246.281677607042;6248.343923888017;6243.500519958392;6287.182666253358;6296.87406251877;6313.873722525524;6314;5696.259486266758;5710.200571919934;5765.106408506688;5779.999999999958;5785.739641716133;6252;6307.653079080603;6322.620642761449;6329.303776584572;6340.017297318923;6041.939580604226;6117.785877494266;6137.202163718688;6140.907886381708;6158.168647232566;6097.857415703;6178.505719542516;6260.780872669435;6272.529560282997;6283;6152.477039451696;6216.533759968021;6228.408301211378;6244.812655620339;6249.312575616769;6207.751689932352;6230.314665386803;6233.719482623293;6238.064290356483;6239.344868788712;4767.189577771787;4894.3147959285725;4900.264960255919;4913.459519452857;4941.802327906916;4319;4390.429244198298;4403.581659742319;4438.4451943507065;4442.622377097919;5588.30146231721;5609;5629.043062679272;5649.717514124277;5666.9716651416475;6118.449339559461;6172.105044768484;6285.96857015712;6298.212723409574;6304.779332723424;5542.140968149944;5575.721213939287;5582.748776305076;5588.888222235532;5597.580181486323;5307.893842123136;5316;5324.201369794562;5368.677879327175;5406;6274.341194174546;6296.496280297565;6302.432781049728;6309.305976342691;6337.112804207322;5208.739563021758;6212.347703491068;6244.500439964701;6263.029230469102;6266.655333956676;6209.937900621117;6230.59501132425;6285.748570057147;6299.716512756845;6300.243970723359;6025;6028.698565071817;6036.486898613667;6055.515558755201;6086.300075491198;6077.029405622591;6129;6151.6001459904965;6153.38466153399;6159.568830182024;5925.259342582177;6013.338532761481;6025.548083893813;6034.939650603438;6043.516518678583;5778.624389414675;5981.3420523743225;6004.099385092271;6013.067974463965;6014.969925150346;5854.297484301911;5858.882822343615;5862.560307977004;5865.354810970875;5868.4424979626865;5988.700564971647;5999.640021598718;6020.39796020412;6040.818775436744;6079.574429790049;5950;5960.284765828128;5965.373635768356;5978.940210597838;6001.729922153426 19:46:42 INFO - PROCESS | 1661 | |1;ext.html;438.4716416717855;535.2987586261997;537.991930121048;583.1515145463351;630.6531407725751;35037.82481087594;37653.43519847201;37688.86933391996;37692.81153594228;37750.0562485938;39898.60101398985;40655.796721016355;40656.18687626246;40699.796501017525;40801.387979180334;9387.765305867373;9643.61425542981;9648.179904708108;9649.903500965005;9654.71035868925;9585.37695049823;9740.51297435129;9742.415455072683;9745.463999480025;9753.463559504224;9670.274729395289;9723.173530249936;9734.123928846402;9734.464604446752;9738.269629777795;9656.420614763138;9716.368436051669;9729.221662267002;9731.56207970643;9731.708048758548;9467.66863159793;9597.08827661378;9602.90397096034;9608.327417080807;9630.90369096307;37940.05149871248;38184.23631527354;38327.42508862369;38354.80822595897;38355.97262287475;1841.1006839509998;3295.96704032959;3319.618243901934;3323.4350160472777;3876.8061596920043;26961.730382696314;27044.864775676193;27257.86371068152;27262.454750905068;28491.57262641062;2711.3086163028497;2789.428167225714;2843.8578071096567;2846.1603826870914;2899.6947426795537;403421;405031;405962;406276;406431;51034.23448648273;61312.080318795255;62681.373186268465;62789.37210627927;63021.05468417978;66643;66727.6654466908;66815;66840;66919.66540167268;16999.915000425168;17200.741988870177;17212.827871721373;17231.22459489301;17239.965602063916;12975.156614820007;13064.608061758163;13065.477380904847;13068.411921463558;13088.803667944989;16856.325746969986;18838.81082797474;20496.282630108173;20694.8617826021;20880.686789698168;7415.666295016737;8777.639465882798;8911.796907417545;8922.73231803047;8999.82000359989;880.423322723617;958.9568469418892;1029.4543891737392;1065.2596445470324;1141.3437273567565;28764.68031750966;29418.970336038135;29803.40393192124;30145.849270753504;30268.394632107236;1055.8702188658215;1114.0753174864842;1127.233481232753;1175.3065691242036;1242.7079636285466;12403.813942790865;15069.849301506845;15081.321340539702;15142.261693546487;15185.316660750294;580828.8627011795;582870;583983;585912.0704396451;586390;59493.107603385986;59984;60098.39901600928;60104.098438523455;60122.39877601168;1320.056159845715;1408.5422237772764;1437.7987081808556;1453.0192120318954;1541.3295216580823;27268.454630906876;28570.714292856806;28605;29163;29736.256593585334;47628.52371476241;47853.28220076771;48117;48162.5183748158;48176.75911620419;388709;390161;390702;391131;391895;35504.46743298904;42015;42754.14491710211;44050.89872753207;44379;42019.949501262716;42071.7896410516;42174.57825421829;42186.57813421827;42442;36004;36372.63627363798;36417.63582364142;37105;37179.07052323713;32507.837460812545;32761.017169484952;35878.64121358753;35976;36666;36425.90722278336;36706;36733.44899826451;36740.81629591835;37541.24917501689;25669;29522.852385737933;30107.54838677378;30918.845405772827;31192.53211201879;18890.622187556448;22701.432464187867;23544.6468302979;23617.52764944726;23727.288181354586 19:46:42 INFO - PROCESS | 1661 | |2;jquery.html;346.5096887903617;351.2062738211641;351.3552630922258;352.9135361836349;359.1380686352755;19219.654624176314;19409.32067377642;19569.217231310766;20823;20847;19440.22239110434;19936.800631993712;20144.496387590316;20225.797742022576;20382.286619968305;5628.127640215773;5894.4989675877605;5963.850903727398;5972.79095231667;5975.701214939236;4190.099128687331;4354.216241076605;4409.536998615147;4904.5831104356175;6155.138280640714;6487.156669632941;6495.870082598345;6496.382843629871;6500.93499065008;6511.4465270452065;5295;6132.172156758825;6223.097650840648;6394.328595497475;6396.840078998039;3728.12389088564;4616;5487.807926722586;5504.6421982571;5515.834524964257;24446.14438494662;24500.89745961418;24777.752222477906;24866.12968546092;24907.377315567257;2056.950955012939;2178.5425060737107;2229.7658745831777;2268.036084664011;2333.5099629077913;13738;14289.785653215211;14555.927220363936;14703.70592588153;14703.852961470355;1647;1668.0908904646876;1696.202784691193;1794.8923064616033;1829.140304057091;81343.7798433018;102521;105559.47220263927;105946;108235.91764082338;10432.634857779942;10832.40421776794;10845.891541084646;10935.890641093647;10959.616413425492;13139.408726607326;13218.73562528744;13287.667808304677;13325.800112998313;13356.465741370237;8253.917460825314;8397.496150231005;8409.32725381968;8477.872831907527;8504.31965442763;8610.009848867461;8610.87083693745;8635.306100032942;8713.869291960626;8718.346124040723;4320.4599425071865;4384.978075109604;4402.9559704402545;4446.933296000562;4453.109378124388;1726.8257584842177;1779.6173822628198;1789.0696837644352;1848.159087615132;1881.990590047041;875.5140896802209;887.2768693514765;917.9816403672023;932.5663566441638;974.2011550528499;18629.627407452048;19130.808691913182;19939.10274037672;20502.794972050087;20663.793362066488;778.2489897249069;914.9405288656216;924.8474001789764;930.1814951769275;946.8674385586023;10773.299735517323;10927.836082458769;10969.83545246822;11006.712738361572;11065.059469944983;576805;609148.9542552258;614210;626509;629761;126130;127119.36440317739;127852;131902;132085.33957330152;857.3398483167925;986.1765425869479;997.9371968853148;1006.1900170362782;1008;17010.404635837687;17031.063291519087;17925.731114033562;18001.2799488019;18600.34898778536;39884;52812.20781688354;53628;55010;56168;74107;75402.62298688471;76984;78273;78514;7910.644021018953;8038.919610803817;8054.5569993650915;8113.472624279403;8202.671893124209;9392.859107113261;12858.549950751678;13150.539731109366;13153.839270622986;13417.463301468222;11031.448427578749;11085.448037274627;11169.553217871518;11358;11532.59635912739;10745.677629671123;10941.890581094087;11093.722656933642;11114.944425278145;11253.437328133725;11049.39228342449;11508.769824603629;11556.94221528887;11582.768344633228;11812.70468238301;7790.922090779246;7869.016372953381;7978.720744773905;8028.598570071356;8035.718749843962;10164.390136591828;10786.784264314827;11573.479193436147;11607.245529040585;11632.418379081182 19:46:42 INFO - PROCESS | 1661 | |3;mootools.html;1399.2164387942746;1530.6096945278953;1551.3872020551878;1762.453639371794;1910.9808901910985;7616.543007419552;8181.8363632727305;8317.168283171679;8336.083030866599;8338.666453341873;7359.77920662381;8157.225063618962;8261.504309741405;8265.421420500568;8273.255407013368;2110.00829610083;2332.778386053331;2387.594109001474;2411.0837881605053;2412.469256763518;2396.820238482112;2403.483251101013;2405.1702162753822;2407.4944261705064;2408.157144999245;2000.669889468236;2331.2190416210506;2367.6330168823774;2392.7487613800563;2393.664886915833;2329.9767002329927;2364.9054037838464;2377.9881100594557;2380.702412198475;2385.9045638174453;2338.5673650374733;2344.2615576093476;2367.786899179082;2371.9288421347387;2373.2287006722713;8402.621882015324;8452.366072544522;8461.915380846174;8467.49195048299;8474.533900635462;5150.072986862363;5279.208118782175;5301.946980530184;5302.946970530284;5306.389765177016;3460.9480857786903;3529.770564913272;3576.695980841632;3594.7663401878795;3602.6937710294656;999.6251405722854;1017.954192061359;1029.0892560084305;1053.467998660679;1057.3391630231106;10791.46042697862;10975.780484390267;10978.725531861688;10979.066779323766;10987;4445.066536027406;4457.331400289918;4516.345129956138;4573.199690054227;4591.4260717410325;8806.86789698155;8814.779630509289;8820.823583528294;8824.5587720615;8834.381593288537;5160.664556803796;5161.922571161435;5165.715885626251;5169.302144210558;5237.450067742909;4291.227579035741;4430.712003719748;4608.9308660370125;4734.95265047352;4954.8761280968265;3608.6210947850623;3650.0509867434125;3660.0666829958723;3679.6504332088407;3701.9814900925862;962.9053588853214;1151.45305979659;1153.6481373181093;1159.1769843411105;1165.597868735285;1265.0764941592504;1270.8665590112905;1292.405493472994;1293.2822283632674;1296.092735085444;7878.606069696607;7914.525128492309;7941.880871786928;7954.880676789853;7967.601619918981;488.2456604545985;500.43950775132083;501.31069779053803;506.7035784066289;508.1640701046757;6066.423689749467;6120.204373431426;6154;6155.630662160284;6158.322584515699;9695.854562181574;9879.506024698736;9894.653687120915;9899.257555683209;10049.196064314838;9679.516024198761;9855.310128291094;9892.901070989343;9915;9917.702468925943;7750.922490775133;7872.370210383156;7891.289783919475;7897.486663366748;7958.403119766041;7397.963010184914;7709.730159444617;7714.15144334134;7815.335696465864;7820.296173344426;9020.954895225483;9280.443173409347;9318.440893546409;9361.85957210656;9387.718368448957;9326.160645541933;9547.379420337656;9591.944886062389;9701.805963880824;9833.311668183445;6312.737452509425;6413.326600707045;6585.473162146921;7224.277572242734;7397.186309506058;7881.921180788118;7926.722564710208;7947.761567152995;7956.124826269222;7971.481853679492;6918.481113916376;7003.3346832050875;7018.789436316919;7117.6085315308155;7133.643317834191;6910.343517365842;6913.619750913748;6991.6853741580735;7042.7887163385185;7054.647267636495;7351.264873512606;7389.704411823467;7425.997490338735;7462.813429664302;7482.738104166328;6717.731290748316;6730.697118629576;6776.830579235559;6777.390034896883;6834.282400347892;6858.931410686029;6869.793906182823;6937.132858392701;6938.063361446342;6948.652567371712 19:46:42 INFO - PROCESS | 1661 | |4;prototype.html;268.754090007643;310.31730193574134;317.9205198700325;322.0708256679479;323.0437903804741;6420;6436.871262574751;6496.870062598757;6507;6529.673516324188;6431.935680643192;6447.7743278985245;6459.51553633477;6496.837579060514;6513.544051916368;3692.353838078339;4707.90584188316;4721.386219791422;4786.1145688047645;4857.3685420895235;4804.927926081112;4811;4826.107170173512;4827.082854257697;4831.975840120795;4262.808173632194;4387.1445068211715;4785.425748910136;4788.449328327235;4800.159972004885;3822.7706337619834;4551.68138230324;4647.209974304376;4737.478877323491;4788.473267940523;4059.6143366380443;4069.6133867282856;4072.124493233969;4085;4086.1010577672864;6203.4416902479;6243.469305109071;6255;6262.997920332725;6314.589551679126;5614.326280846284;5619.690916999563;5626.7211779229065;5642.266505354278;5649.6327738696855;6701.195856497203;6962.060121883532;6967.965160174167;6974.546654467444;6975.232724400312;4238.19474299882;4574.451065872084;4589.128065667513;4614.400127983375;4617.076584683077;6649.468042556584;7356.852862942711;7358.153812311599;7365.558066516026;7376.336129748294;4668.416447944007;4669.112868554964;4679.766011699401;4685.929711054337;4778.665493415428;4741.644376671763;4744.739039352799;4745.810167593327;4750.453697824794;4756.167670657621;4832;5583.302087239095;5585.1901474286005;5595.38450770415;5596.076647353222;6707.396334329934;6991.720331186797;7016.333448322402;7020.262872398427;7032.12098487689;1634.6485505616113;1641.0399916049246;1654.040656419274;1657.6021754779008;1659.2616285752724;999.4702807512031;1032.87605487342;1067.7544164841975;1083.0198670203322;1096.9670909872716;5275.311900191902;5661.518770904519;5935.554833387513;6443.581167224209;6471.320511346335;7186.676599552928;7286.4899457038555;7307.903814427878;7314.6708398121145;7326.67029983652;6490.415862572391;6493.058506516623;6497.772577959749;6499.05763664266;6518.608883467007;3798.3732684106812;3852.075501879529;3862.903427414281;3868.2263547290654;3873.0317420644838;6159.5072394208355;7143.642817859086;7661.42539309554;7666.731664391719;7688;7501.212372700897;7557.508761930567;7566.810829729301;7580;7603.505772124794;7619.352355049772;7634.770956871303;7647.732329368446;7659.348955338859;7662.0422447195215;6464;6591.274959754327;7331.340179383881;7342.3758980487255;7350.154732205865;5813.447722466359;7163.964180179066;7195.280471952763;7255.09311336083;7277.2722727726805;7641.624507588687;7642.04474440695;7650.693972241271;7651.273129052731;7665.540067595962;4190.580941905907;4709.458412282632;4758.357621721023;4784.282357646381;4796.304535842213;6918.273581273894;6925.411340036153;7250.238724934017;7261.927380726125;7267.018952441353;6959.652017399211;6980.267071957574;6981.860362792817;6990.8951365728535;7000.159980802337;6902.102726645504;6962.860742785015;6973.5118541701595;6981.441484681315;6982.965085174542;6816.625085620339;6817.795466136024;6823;6832.555883867532;6837.213720422215;6753;6989.405900498515;7002.299770022957;7004.7198112076985;7007.649617519001;6670.166229221348;6760.3239676032;6853.451723861979;6877.037214789833;6954.582725036514 19:46:42 INFO - PROCESS | 1661 | |5;yui.html;642.1876326447044;652.1684851813936;710.4139085254662;726.843728598352;737.3511310047157;14166.787498187523;14290.499832505864;14290.857091429083;14309.570712878603;14611.342489587967;13234.404451799692;13983.860161398383;14135.434582616708;14153.15081095135;14158.50445234417;697.570993838788;808.296781799835;859.7635650196199;880.5685214245005;880.9383343165981;726.6911562585906;869.4522450855952;885.8139790643972;889.0398369760643;893.2764460786783;930.6137952749601;933.7478880702206;935.1957316707626;935.9110884465999;936.5691781780389;748.4424104042469;756.3570964679978;922.8431166701644;924.01130790055;926.800737841364;562.5977426140329;675.139197523157;682.7405585877335;685.2462291479383;685.6468918506973;14722.043067200597;14727.042742221722;14791;14794.038387504885;14812.925935370362;12215.633530994084;12236;12362.75274494514;12493.125481216319;12733.61799146027;9622.182114520274;9742.561584728704;9813.460259685715;10053.547590358452;10129.746756331151;3491.720662347006;3525.3301872644115;3526.0479670488826;3544.6809787119023;3603.549556305462;75681;76122.61938690326;77139.6143019287;79886;80943.5952820238;9292.163705266423;9302.209312208402;9457.148856602938;9478.620855165716;9959.452230127268;21406.464838379165;21468.570628587342;21512.81679507611;21516.56966860654;21519.354419367442;7379.631018449056;7413.221611730798;7417.592032438268;7471.626418679044;7489.700411983568;3996.18078293949;4010.218007488512;4026.859059932888;4078.938815917764;4285.892852678646;3463.0649724574223;3497.2480916603054;3520.559930008749;3525.8060806655367;3529.2059286660296;553.2310088976326;611.8225714542733;616.4082480818464;618.551550126164;626.3611116661071;511.07750510329214;518.9091908915925;542.3302221756128;560.3276068717474;560.8233406477028;7532.17146113927;7838.3337416320255;7959.363250939911;8116.310113640407;8169.959150204211;532.6378062917254;559.6949662433983;575.3153747041008;586.1091141464949;605.7213681706464;3498.111757985777;3731.645493678096;3732.5101030536534;3738.7943663098245;3775.7356985010783;69998.30001700019;88083.55958220168;88284.11715882887;90561;90566.64150037755;70511.94232086523;70744.58510829754;76410.2358976403;76732;77762.61118694484;70614;71961;72455.27544724486;73307.63346183235;73455.63272183605;7385.741499047507;7408.666610002455;7467.701291948261;7713.344365728976;7738.947746632745;49981;50143.74928125336;50378.748106259234;51342;51850.48149518456;68362.65818670875;69379.24621683647;69941.950870738;70094.64952675204;70888;9766;9796.412215267106;9838.483737000333;9857.431774487586;10233.692989210336;10435.060844524029;11007.559697612005;11028.44857757125;11588.826167607323;11662.950334469939;9723.951380243054;9898.752531186778;10014.849777253492;10047.598096076075;10234.539445724811;10141.543630536496;10357.223208259562;10475.266731328733;10481.528331224961;10486.056254937092;10062.345947513388;10087;10234.21156428953;10353.01646343596;10373.844392333971;8649.91350086491;8719.171678690514;8775.254103401283;8896.843023717003;8994.730158095268;8022.438429310126;8650.394472386872;8664.740057798275;8720.476771393736;8798.868016979879 19:46:42 INFO - PROCESS | 1661 | __end_tp_report 19:46:42 INFO - PROCESS | 1661 | __start_cc_report 19:46:42 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2368 19:46:42 INFO - PROCESS | 1661 | __end_cc_report 19:46:42 INFO - PROCESS | 1661 | __startTimestamp1456976802181__endTimestamp 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | ------- Summary: start ------- 19:46:42 INFO - PROCESS | 1661 | Number of tests: 6 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5709.12 Median:5925.26 stddev:625.25 (10.6%) stddev-sans-first:600.63 19:46:42 INFO - PROCESS | 1661 | Values: 3411.7 3464.0 3483.8 3505.3 3536.0 5601.3 5655.9 5662.3 5670.0 5672.3 5631.4 5655.1 5701.0 5774.1 5793.2 5114.8 5138.1 5147.1 5168.3 5176.0 5118.1 5121.2 5178.9 5182.6 5230.9 5107.1 5130.9 5198.6 5231.1 5231.4 5171.5 5181.8 5210.0 5216.5 5223.2 5123.3 5180.3 5195.1 5202.8 5211.8 5519.5 5548.9 5642.4 5687.2 5692.3 6234.3 6240.3 6245.4 6246.3 6248.3 6243.5 6287.2 6296.9 6313.9 6314.0 5696.3 5710.2 5765.1 5780.0 5785.7 6252.0 6307.7 6322.6 6329.3 6340.0 6041.9 6117.8 6137.2 6140.9 6158.2 6097.9 6178.5 6260.8 6272.5 6283.0 6152.5 6216.5 6228.4 6244.8 6249.3 6207.8 6230.3 6233.7 6238.1 6239.3 4767.2 4894.3 4900.3 4913.5 4941.8 4319.0 4390.4 4403.6 4438.4 4442.6 5588.3 5609.0 5629.0 5649.7 5667.0 6118.4 6172.1 6286.0 6298.2 6304.8 5542.1 5575.7 5582.7 5588.9 5597.6 5307.9 5316.0 5324.2 5368.7 5406.0 6274.3 6296.5 6302.4 6309.3 6337.1 5208.7 6212.3 6244.5 6263.0 6266.7 6209.9 6230.6 6285.7 6299.7 6300.2 6025.0 6028.7 6036.5 6055.5 6086.3 6077.0 6129.0 6151.6 6153.4 6159.6 5925.3 6013.3 6025.5 6034.9 6043.5 5778.6 5981.3 6004.1 6013.1 6015.0 5854.3 5858.9 5862.6 5865.4 5868.4 5988.7 5999.6 6020.4 6040.8 6079.6 5950.0 5960.3 5965.4 5978.9 6001.7 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:60889.25 Median:38341.12 stddev:124606.38 (325.0%) stddev-sans-first:124873.27 19:46:42 INFO - PROCESS | 1661 | Values: 438.5 535.3 538.0 583.2 630.7 35037.8 37653.4 37688.9 37692.8 37750.1 39898.6 40655.8 40656.2 40699.8 40801.4 9387.8 9643.6 9648.2 9649.9 9654.7 9585.4 9740.5 9742.4 9745.5 9753.5 9670.3 9723.2 9734.1 9734.5 9738.3 9656.4 9716.4 9729.2 9731.6 9731.7 9467.7 9597.1 9602.9 9608.3 9630.9 37940.1 38184.2 38327.4 38354.8 38356.0 1841.1 3296.0 3319.6 3323.4 3876.8 26961.7 27044.9 27257.9 27262.5 28491.6 2711.3 2789.4 2843.9 2846.2 2899.7 403421.0 405031.0 405962.0 406276.0 406431.0 51034.2 61312.1 62681.4 62789.4 63021.1 66643.0 66727.7 66815.0 66840.0 66919.7 16999.9 17200.7 17212.8 17231.2 17240.0 12975.2 13064.6 13065.5 13068.4 13088.8 16856.3 18838.8 20496.3 20694.9 20880.7 7415.7 8777.6 8911.8 8922.7 8999.8 880.4 959.0 1029.5 1065.3 1141.3 28764.7 29419.0 29803.4 30145.8 30268.4 1055.9 1114.1 1127.2 1175.3 1242.7 12403.8 15069.8 15081.3 15142.3 15185.3 580828.9 582870.0 583983.0 585912.1 586390.0 59493.1 59984.0 60098.4 60104.1 60122.4 1320.1 1408.5 1437.8 1453.0 1541.3 27268.5 28570.7 28605.0 29163.0 29736.3 47628.5 47853.3 48117.0 48162.5 48176.8 388709.0 390161.0 390702.0 391131.0 391895.0 35504.5 42015.0 42754.1 44050.9 44379.0 42019.9 42071.8 42174.6 42186.6 42442.0 36004.0 36372.6 36417.6 37105.0 37179.1 32507.8 32761.0 35878.6 35976.0 36666.0 36425.9 36706.0 36733.4 36740.8 37541.2 25669.0 29522.9 30107.5 30918.8 31192.5 18890.6 22701.4 23544.6 23617.5 23727.3 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34797.28 Median:24473.52 stddev:101629.66 (415.3%) stddev-sans-first:101881.83 19:46:42 INFO - PROCESS | 1661 | Values: 346.5 351.2 351.4 352.9 359.1 19219.7 19409.3 19569.2 20823.0 20847.0 19440.2 19936.8 20144.5 20225.8 20382.3 5628.1 5894.5 5963.9 5972.8 5975.7 4190.1 4354.2 4409.5 4904.6 6155.1 6487.2 6495.9 6496.4 6500.9 6511.4 5295.0 6132.2 6223.1 6394.3 6396.8 3728.1 4616.0 5487.8 5504.6 5515.8 24446.1 24500.9 24777.8 24866.1 24907.4 2057.0 2178.5 2229.8 2268.0 2333.5 13738.0 14289.8 14555.9 14703.7 14703.9 1647.0 1668.1 1696.2 1794.9 1829.1 81343.8 102521.0 105559.5 105946.0 108235.9 10432.6 10832.4 10845.9 10935.9 10959.6 13139.4 13218.7 13287.7 13325.8 13356.5 8253.9 8397.5 8409.3 8477.9 8504.3 8610.0 8610.9 8635.3 8713.9 8718.3 4320.5 4385.0 4403.0 4446.9 4453.1 1726.8 1779.6 1789.1 1848.2 1882.0 875.5 887.3 918.0 932.6 974.2 18629.6 19130.8 19939.1 20502.8 20663.8 778.2 914.9 924.8 930.2 946.9 10773.3 10927.8 10969.8 11006.7 11065.1 576805.0 609149.0 614210.0 626509.0 629761.0 126130.0 127119.4 127852.0 131902.0 132085.3 857.3 986.2 997.9 1006.2 1008.0 17010.4 17031.1 17925.7 18001.3 18600.3 39884.0 52812.2 53628.0 55010.0 56168.0 74107.0 75402.6 76984.0 78273.0 78514.0 7910.6 8038.9 8054.6 8113.5 8202.7 9392.9 12858.5 13150.5 13153.8 13417.5 11031.4 11085.4 11169.6 11358.0 11532.6 10745.7 10941.9 11093.7 11114.9 11253.4 11049.4 11508.8 11556.9 11582.8 11812.7 7790.9 7869.0 7978.7 8028.6 8035.7 10164.4 10786.8 11573.5 11607.2 11632.4 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5739.56 Median:6499.40 stddev:3001.68 (46.2%) stddev-sans-first:2992.37 19:46:42 INFO - PROCESS | 1661 | Values: 1399.2 1530.6 1551.4 1762.5 1911.0 7616.5 8181.8 8317.2 8336.1 8338.7 7359.8 8157.2 8261.5 8265.4 8273.3 2110.0 2332.8 2387.6 2411.1 2412.5 2396.8 2403.5 2405.2 2407.5 2408.2 2000.7 2331.2 2367.6 2392.7 2393.7 2330.0 2364.9 2378.0 2380.7 2385.9 2338.6 2344.3 2367.8 2371.9 2373.2 8402.6 8452.4 8461.9 8467.5 8474.5 5150.1 5279.2 5301.9 5302.9 5306.4 3460.9 3529.8 3576.7 3594.8 3602.7 999.6 1018.0 1029.1 1053.5 1057.3 10791.5 10975.8 10978.7 10979.1 10987.0 4445.1 4457.3 4516.3 4573.2 4591.4 8806.9 8814.8 8820.8 8824.6 8834.4 5160.7 5161.9 5165.7 5169.3 5237.5 4291.2 4430.7 4608.9 4735.0 4954.9 3608.6 3650.1 3660.1 3679.7 3702.0 962.9 1151.5 1153.6 1159.2 1165.6 1265.1 1270.9 1292.4 1293.3 1296.1 7878.6 7914.5 7941.9 7954.9 7967.6 488.2 500.4 501.3 506.7 508.2 6066.4 6120.2 6154.0 6155.6 6158.3 9695.9 9879.5 9894.7 9899.3 10049.2 9679.5 9855.3 9892.9 9915.0 9917.7 7750.9 7872.4 7891.3 7897.5 7958.4 7398.0 7709.7 7714.2 7815.3 7820.3 9021.0 9280.4 9318.4 9361.9 9387.7 9326.2 9547.4 9591.9 9701.8 9833.3 6312.7 6413.3 6585.5 7224.3 7397.2 7881.9 7926.7 7947.8 7956.1 7971.5 6918.5 7003.3 7018.8 7117.6 7133.6 6910.3 6913.6 6991.7 7042.8 7054.6 7351.3 7389.7 7426.0 7462.8 7482.7 6717.7 6730.7 6776.8 6777.4 6834.3 6858.9 6869.8 6937.1 6938.1 6948.7 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5691.56 Median:6467.66 stddev:1832.62 (28.3%) stddev-sans-first:1791.99 19:46:42 INFO - PROCESS | 1661 | Values: 268.8 310.3 317.9 322.1 323.0 6420.0 6436.9 6496.9 6507.0 6529.7 6431.9 6447.8 6459.5 6496.8 6513.5 3692.4 4707.9 4721.4 4786.1 4857.4 4804.9 4811.0 4826.1 4827.1 4832.0 4262.8 4387.1 4785.4 4788.4 4800.2 3822.8 4551.7 4647.2 4737.5 4788.5 4059.6 4069.6 4072.1 4085.0 4086.1 6203.4 6243.5 6255.0 6263.0 6314.6 5614.3 5619.7 5626.7 5642.3 5649.6 6701.2 6962.1 6968.0 6974.5 6975.2 4238.2 4574.5 4589.1 4614.4 4617.1 6649.5 7356.9 7358.2 7365.6 7376.3 4668.4 4669.1 4679.8 4685.9 4778.7 4741.6 4744.7 4745.8 4750.5 4756.2 4832.0 5583.3 5585.2 5595.4 5596.1 6707.4 6991.7 7016.3 7020.3 7032.1 1634.6 1641.0 1654.0 1657.6 1659.3 999.5 1032.9 1067.8 1083.0 1097.0 5275.3 5661.5 5935.6 6443.6 6471.3 7186.7 7286.5 7307.9 7314.7 7326.7 6490.4 6493.1 6497.8 6499.1 6518.6 3798.4 3852.1 3862.9 3868.2 3873.0 6159.5 7143.6 7661.4 7666.7 7688.0 7501.2 7557.5 7566.8 7580.0 7603.5 7619.4 7634.8 7647.7 7659.3 7662.0 6464.0 6591.3 7331.3 7342.4 7350.2 5813.4 7164.0 7195.3 7255.1 7277.3 7641.6 7642.0 7650.7 7651.3 7665.5 4190.6 4709.5 4758.4 4784.3 4796.3 6918.3 6925.4 7250.2 7261.9 7267.0 6959.7 6980.3 6981.9 6990.9 7000.2 6902.1 6962.9 6973.5 6981.4 6983.0 6816.6 6817.8 6823.0 6832.6 6837.2 6753.0 6989.4 7002.3 7004.7 7007.6 6670.2 6760.3 6853.5 6877.0 6954.6 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17785.82 Median:34522.70 stddev:25143.04 (72.8%) stddev-sans-first:25180.62 19:46:42 INFO - PROCESS | 1661 | Values: 642.2 652.2 710.4 726.8 737.4 14166.8 14290.5 14290.9 14309.6 14611.3 13234.4 13983.9 14135.4 14153.2 14158.5 697.6 808.3 859.8 880.6 880.9 726.7 869.5 885.8 889.0 893.3 930.6 933.7 935.2 935.9 936.6 748.4 756.4 922.8 924.0 926.8 562.6 675.1 682.7 685.2 685.6 14722.0 14727.0 14791.0 14794.0 14812.9 12215.6 12236.0 12362.8 12493.1 12733.6 9622.2 9742.6 9813.5 10053.5 10129.7 3491.7 3525.3 3526.0 3544.7 3603.5 75681.0 76122.6 77139.6 79886.0 80943.6 9292.2 9302.2 9457.1 9478.6 9959.5 21406.5 21468.6 21512.8 21516.6 21519.4 7379.6 7413.2 7417.6 7471.6 7489.7 3996.2 4010.2 4026.9 4078.9 4285.9 3463.1 3497.2 3520.6 3525.8 3529.2 553.2 611.8 616.4 618.6 626.4 511.1 518.9 542.3 560.3 560.8 7532.2 7838.3 7959.4 8116.3 8170.0 532.6 559.7 575.3 586.1 605.7 3498.1 3731.6 3732.5 3738.8 3775.7 69998.3 88083.6 88284.1 90561.0 90566.6 70511.9 70744.6 76410.2 76732.0 77762.6 70614.0 71961.0 72455.3 73307.6 73455.6 7385.7 7408.7 7467.7 7713.3 7738.9 49981.0 50143.7 50378.7 51342.0 51850.5 68362.7 69379.2 69942.0 70094.6 70888.0 9766.0 9796.4 9838.5 9857.4 10233.7 10435.1 11007.6 11028.4 11588.8 11663.0 9724.0 9898.8 10014.8 10047.6 10234.5 10141.5 10357.2 10475.3 10481.5 10486.1 10062.3 10087.0 10234.2 10353.0 10373.8 8649.9 8719.2 8775.3 8896.8 8994.7 8022.4 8650.4 8664.7 8720.5 8798.9 19:46:42 INFO - PROCESS | 1661 | -------- Summary: end -------- 19:46:42 INFO - PROCESS | 1661 | 19:46:42 INFO - TEST-INFO | 1661: exit 0 19:46:42 INFO - TEST-OK | dromaeo_css | took 1114009ms 19:46:42 INFO - TEST-START | kraken 19:46:42 INFO - operating with platform_type : mac_ 19:46:42 INFO - Initialising browser for kraken test... 19:46:42 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpCZucr2/profile http://localhost:49290/getInfo.html) 19:46:44 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 19:46:44 INFO - PROCESS | 1671 | colorDepth:24 19:46:44 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 19:46:44 INFO - PROCESS | 1671 | __metrics 19:46:45 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:46:45 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:46:45 INFO - TEST-INFO | 1671: exit 0 19:46:45 INFO - Browser initialized. 19:46:45 INFO - Running cycle 1/1 for kraken test... 19:46:45 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpCZucr2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:57 INFO - PROCESS | 1673 | RSS: Main: 243634176 19:46:57 INFO - PROCESS | 1673 | 19:47:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection) 19:47:00 INFO - PROCESS | 1673 | RSS: Main: 288600064 19:47:00 INFO - PROCESS | 1673 | 19:47:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-dft) 19:47:03 INFO - PROCESS | 1673 | RSS: Main: 300175360 19:47:03 INFO - PROCESS | 1673 | 19:47:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-fft) 19:47:08 INFO - PROCESS | 1673 | RSS: Main: 287436800 19:47:08 INFO - PROCESS | 1673 | 19:47:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator) 19:47:10 INFO - PROCESS | 1673 | RSS: Main: 288862208 19:47:10 INFO - PROCESS | 1673 | 19:47:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:13 INFO - PROCESS | 1673 | RSS: Main: 290226176 19:47:13 INFO - PROCESS | 1673 | 19:47:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:16 INFO - PROCESS | 1673 | RSS: Main: 291393536 19:47:16 INFO - PROCESS | 1673 | 19:47:19 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:20 INFO - PROCESS | 1673 | RSS: Main: 291180544 19:47:20 INFO - PROCESS | 1673 | 19:47:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial) 19:47:23 INFO - PROCESS | 1673 | RSS: Main: 289972224 19:47:23 INFO - PROCESS | 1673 | 19:47:24 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:25 INFO - PROCESS | 1673 | RSS: Main: 325521408 19:47:25 INFO - PROCESS | 1673 | 19:47:27 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:27 INFO - PROCESS | 1673 | RSS: Main: 324435968 19:47:27 INFO - PROCESS | 1673 | 19:47:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:30 INFO - PROCESS | 1673 | RSS: Main: 330997760 19:47:30 INFO - PROCESS | 1673 | 19:47:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:33 INFO - PROCESS | 1673 | RSS: Main: 334090240 19:47:33 INFO - PROCESS | 1673 | 19:47:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:36 INFO - PROCESS | 1673 | RSS: Main: 333864960 19:47:36 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49290/tests/kraken/driver.html?testName=ai-astar) 19:47:38 INFO - PROCESS | 1673 | RSS: Main: 395022336 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | __start_tp_report 19:47:38 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 19:47:38 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 19:47:38 INFO - PROCESS | 1673 | |i|pagename|runs| 19:47:38 INFO - PROCESS | 1673 | |0;ai-astar;111;109;110;111;110;112;116;110;109;110 19:47:38 INFO - PROCESS | 1673 | |1;audio-beat-detection;156;121;145;159;120;140;139;119;164;137 19:47:38 INFO - PROCESS | 1673 | |2;audio-dft;185;185;190;262;220;186;185;226;250;182 19:47:38 INFO - PROCESS | 1673 | |3;audio-fft;74;77;85;79;58;62;69;108;106;55 19:47:38 INFO - PROCESS | 1673 | |4;audio-oscillator;95;97;126;80;80;82;109;77;80;138 19:47:38 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;87;85;87;84;89;124;88;84;88;82 19:47:38 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;95;93;92;93;92;94;93;92;93 19:47:38 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;87;82;88;86;85;86;87;91;84 19:47:38 INFO - PROCESS | 1673 | |8;json-parse-financial;56;54;55;53;54;53;53;65;55;51 19:47:38 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;64;64;63;74;71;69;67;67;66;72 19:47:38 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;83;82;82;81;83;82;83;82;85;81 19:47:38 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;120;124;134;111;123;132;130;133;132;125 19:47:38 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;141;127;141;140;135;119;139;138;139;148 19:47:38 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;68;65;67;67;66;68;67;66;67 19:47:38 INFO - PROCESS | 1673 | __end_tp_report 19:47:38 INFO - PROCESS | 1673 | __start_cc_report 19:47:38 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1254 19:47:38 INFO - PROCESS | 1673 | __end_cc_report 19:47:38 INFO - PROCESS | 1673 | __startTimestamp1456976858826__endTimestamp 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | ------- Summary: start ------- 19:47:38 INFO - PROCESS | 1673 | Number of tests: 14 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:2.04 (1.8%) stddev-sans-first:2.17 19:47:38 INFO - PROCESS | 1673 | Values: 111.0 109.0 110.0 111.0 110.0 112.0 116.0 110.0 109.0 110.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:142.50 stddev:16.43 (11.5%) stddev-sans-first:16.38 19:47:38 INFO - PROCESS | 1673 | Values: 156.0 121.0 145.0 159.0 120.0 140.0 139.0 119.0 164.0 137.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:207.10 Median:205.00 stddev:30.20 (14.7%) stddev-sans-first:30.96 19:47:38 INFO - PROCESS | 1673 | Values: 185.0 185.0 190.0 262.0 220.0 186.0 185.0 226.0 250.0 182.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:77.30 Median:71.50 stddev:18.29 (25.6%) stddev-sans-first:19.36 19:47:38 INFO - PROCESS | 1673 | Values: 74.0 77.0 85.0 79.0 58.0 62.0 69.0 108.0 106.0 55.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:80.00 stddev:21.50 (26.9%) stddev-sans-first:22.79 19:47:38 INFO - PROCESS | 1673 | Values: 95.0 97.0 126.0 80.0 80.0 82.0 109.0 77.0 80.0 138.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:87.00 stddev:12.22 (14.0%) stddev-sans-first:12.92 19:47:38 INFO - PROCESS | 1673 | Values: 87.0 85.0 87.0 84.0 89.0 124.0 88.0 84.0 88.0 82.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 19:47:38 INFO - PROCESS | 1673 | Values: 93.0 95.0 93.0 92.0 93.0 92.0 94.0 93.0 92.0 93.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:2.39 (2.8%) stddev-sans-first:2.54 19:47:38 INFO - PROCESS | 1673 | Values: 86.0 87.0 82.0 88.0 86.0 85.0 86.0 87.0 91.0 84.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.81 (7.0%) stddev-sans-first:4.02 19:47:38 INFO - PROCESS | 1673 | Values: 56.0 54.0 55.0 53.0 54.0 53.0 53.0 65.0 55.0 51.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:3.71 (5.5%) stddev-sans-first:3.69 19:47:38 INFO - PROCESS | 1673 | Values: 64.0 64.0 63.0 74.0 71.0 69.0 67.0 67.0 66.0 72.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:1.22 19:47:38 INFO - PROCESS | 1673 | Values: 83.0 82.0 82.0 81.0 83.0 82.0 83.0 82.0 85.0 81.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:131.00 stddev:7.26 (5.5%) stddev-sans-first:7.32 19:47:38 INFO - PROCESS | 1673 | Values: 120.0 124.0 134.0 111.0 123.0 132.0 130.0 133.0 132.0 125.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.70 Median:139.50 stddev:8.15 (5.8%) stddev-sans-first:8.50 19:47:38 INFO - PROCESS | 1673 | Values: 141.0 127.0 141.0 140.0 135.0 119.0 139.0 138.0 139.0 148.0 19:47:38 INFO - PROCESS | 1673 | 19:47:38 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 19:47:38 INFO - PROCESS | 1673 | Values: 66.0 68.0 65.0 67.0 67.0 66.0 68.0 67.0 66.0 67.0 19:47:38 INFO - PROCESS | 1673 | -------- Summary: end -------- 19:47:38 INFO - PROCESS | 1673 | 19:47:39 INFO - TEST-INFO | 1673: exit 0 19:47:39 INFO - TEST-OK | kraken | took 56871ms 19:47:39 INFO - SUITE-END | took 1170s 19:47:39 INFO - Completed test suite (00:19:31) 19:47:39 INFO - Working with test: dromaeo_css 19:47:39 INFO - Generating results file: dromaeo_css 19:47:39 INFO - Working with test: kraken 19:47:39 INFO - Generating results file: kraken 19:47:39 INFO - javascript benchmark 19:47:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:47:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 19:47:40 INFO - process_Request line: dromaeo_css 7376.72 graph.html#tests=[[72,64,59]] 19:47:40 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:47:40 INFO - process_Request line: kraken 1435.40 graph.html#tests=[[232,64,59]] 19:47:40 INFO - RETURN: dromaeo_css: 7376.72 19:47:40 INFO - RETURN: kraken: 1435.40 19:47:40 INFO - javascript benchmark 19:47:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3411.7270618350535, 3463.982680086599, 3483.790972541647, 3505.2638945821377, 3536.0452677777002, 5601.327840659126, 5655.915161272585, 5662.292213473316, 5669.971650141754, 5672.347680016799, 5631.380548139701, 5655.095184770437, 5701.0, 5774.07614781635, 5793.159991801186, 5114.795408183687, 5138.126518491856, 5147.1249887519025, 5168.2764412982215, 5175.974120129413, 5118.129917913945, 5121.2318152277085, 5178.8705282368055, 5182.637215394924, 5230.947690523084, 5107.106256405114, 5130.948690513103, 5198.636095473318, 5231.084560201949, 5231.372235331746, 5171.482851714836, 5181.766820493049, 5210.0, 5216.504432078947, 5223.2165175223645, 5123.308353372285, 5180.274761533388, 5195.116830138885, 5202.765875535572, 5211.791528338862, 5519.503244707956, 5548.944510554883, 5642.379338272786, 5687.232223649796, 5692.260006199168, 6234.345393733638, 6240.282367527747, 6245.375462453764, 6246.281677607042, 6248.343923888017, 6243.500519958392, 6287.182666253358, 6296.87406251877, 6313.873722525524, 6314.0, 5696.259486266758, 5710.200571919934, 5765.106408506688, 5779.999999999958, 5785.739641716133, 6252.0, 6307.653079080603, 6322.620642761449, 6329.303776584572, 6340.017297318923, 6041.939580604226, 6117.785877494266, 6137.202163718688, 6140.907886381708, 6158.168647232566, 6097.857415703, 6178.505719542516, 6260.780872669435, 6272.529560282997, 6283.0, 6152.477039451696, 6216.533759968021, 6228.408301211378, 6244.812655620339, 6249.312575616769, 6207.751689932352, 6230.314665386803, 6233.719482623293, 6238.064290356483, 6239.344868788712, 4767.189577771787, 4894.3147959285725, 4900.264960255919, 4913.459519452857, 4941.802327906916, 4319.0, 4390.429244198298, 4403.581659742319, 4438.4451943507065, 4442.622377097919, 5588.30146231721, 5609.0, 5629.043062679272, 5649.717514124277, 5666.9716651416475, 6118.449339559461, 6172.105044768484, 6285.96857015712, 6298.212723409574, 6304.779332723424, 5542.140968149944, 5575.721213939287, 5582.748776305076, 5588.888222235532, 5597.580181486323, 5307.893842123136, 5316.0, 5324.201369794562, 5368.677879327175, 5406.0, 6274.341194174546, 6296.496280297565, 6302.432781049728, 6309.305976342691, 6337.112804207322, 5208.739563021758, 6212.347703491068, 6244.500439964701, 6263.029230469102, 6266.655333956676, 6209.937900621117, 6230.59501132425, 6285.748570057147, 6299.716512756845, 6300.243970723359, 6025.0, 6028.698565071817, 6036.486898613667, 6055.515558755201, 6086.300075491198, 6077.029405622591, 6129.0, 6151.6001459904965, 6153.38466153399, 6159.568830182024, 5925.259342582177, 6013.338532761481, 6025.548083893813, 6034.939650603438, 6043.516518678583, 5778.624389414675, 5981.3420523743225, 6004.099385092271, 6013.067974463965, 6014.969925150346, 5854.297484301911, 5858.882822343615, 5862.560307977004, 5865.354810970875, 5868.4424979626865, 5988.700564971647, 5999.640021598718, 6020.39796020412, 6040.818775436744, 6079.574429790049, 5950.0, 5960.284765828128, 5965.373635768356, 5978.940210597838, 6001.729922153426], "unit": "score", "name": "dojo.html", "value": 5670.1527089583315}, {"lowerIsBetter": false, "replicates": [438.4716416717855, 535.2987586261997, 537.991930121048, 583.1515145463351, 630.6531407725751, 35037.82481087594, 37653.43519847201, 37688.86933391996, 37692.81153594228, 37750.0562485938, 39898.60101398985, 40655.796721016355, 40656.18687626246, 40699.796501017525, 40801.387979180334, 9387.765305867373, 9643.61425542981, 9648.179904708108, 9649.903500965005, 9654.71035868925, 9585.37695049823, 9740.51297435129, 9742.415455072683, 9745.463999480025, 9753.463559504224, 9670.274729395289, 9723.173530249936, 9734.123928846402, 9734.464604446752, 9738.269629777795, 9656.420614763138, 9716.368436051669, 9729.221662267002, 9731.56207970643, 9731.708048758548, 9467.66863159793, 9597.08827661378, 9602.90397096034, 9608.327417080807, 9630.90369096307, 37940.05149871248, 38184.23631527354, 38327.42508862369, 38354.80822595897, 38355.97262287475, 1841.1006839509998, 3295.96704032959, 3319.618243901934, 3323.4350160472777, 3876.8061596920043, 26961.730382696314, 27044.864775676193, 27257.86371068152, 27262.454750905068, 28491.57262641062, 2711.3086163028497, 2789.428167225714, 2843.8578071096567, 2846.1603826870914, 2899.6947426795537, 403421.0, 405031.0, 405962.0, 406276.0, 406431.0, 51034.23448648273, 61312.080318795255, 62681.373186268465, 62789.37210627927, 63021.05468417978, 66643.0, 66727.6654466908, 66815.0, 66840.0, 66919.66540167268, 16999.915000425168, 17200.741988870177, 17212.827871721373, 17231.22459489301, 17239.965602063916, 12975.156614820007, 13064.608061758163, 13065.477380904847, 13068.411921463558, 13088.803667944989, 16856.325746969986, 18838.81082797474, 20496.282630108173, 20694.8617826021, 20880.686789698168, 7415.666295016737, 8777.639465882798, 8911.796907417545, 8922.73231803047, 8999.82000359989, 880.423322723617, 958.9568469418892, 1029.4543891737392, 1065.2596445470324, 1141.3437273567565, 28764.68031750966, 29418.970336038135, 29803.40393192124, 30145.849270753504, 30268.394632107236, 1055.8702188658215, 1114.0753174864842, 1127.233481232753, 1175.3065691242036, 1242.7079636285466, 12403.813942790865, 15069.849301506845, 15081.321340539702, 15142.261693546487, 15185.316660750294, 580828.8627011795, 582870.0, 583983.0, 585912.0704396451, 586390.0, 59493.107603385986, 59984.0, 60098.39901600928, 60104.098438523455, 60122.39877601168, 1320.056159845715, 1408.5422237772764, 1437.7987081808556, 1453.0192120318954, 1541.3295216580823, 27268.454630906876, 28570.714292856806, 28605.0, 29163.0, 29736.256593585334, 47628.52371476241, 47853.28220076771, 48117.0, 48162.5183748158, 48176.75911620419, 388709.0, 390161.0, 390702.0, 391131.0, 391895.0, 35504.46743298904, 42015.0, 42754.14491710211, 44050.89872753207, 44379.0, 42019.949501262716, 42071.7896410516, 42174.57825421829, 42186.57813421827, 42442.0, 36004.0, 36372.63627363798, 36417.63582364142, 37105.0, 37179.07052323713, 32507.837460812545, 32761.017169484952, 35878.64121358753, 35976.0, 36666.0, 36425.90722278336, 36706.0, 36733.44899826451, 36740.81629591835, 37541.24917501689, 25669.0, 29522.852385737933, 30107.54838677378, 30918.845405772827, 31192.53211201879, 18890.622187556448, 22701.432464187867, 23544.6468302979, 23617.52764944726, 23727.288181354586], "unit": "score", "name": "ext.html", "value": 19531.383689628354}, {"lowerIsBetter": false, "replicates": [346.5096887903617, 351.2062738211641, 351.3552630922258, 352.9135361836349, 359.1380686352755, 19219.654624176314, 19409.32067377642, 19569.217231310766, 20823.0, 20847.0, 19440.22239110434, 19936.800631993712, 20144.496387590316, 20225.797742022576, 20382.286619968305, 5628.127640215773, 5894.4989675877605, 5963.850903727398, 5972.79095231667, 5975.701214939236, 4190.099128687331, 4354.216241076605, 4409.536998615147, 4904.5831104356175, 6155.138280640714, 6487.156669632941, 6495.870082598345, 6496.382843629871, 6500.93499065008, 6511.4465270452065, 5295.0, 6132.172156758825, 6223.097650840648, 6394.328595497475, 6396.840078998039, 3728.12389088564, 4616.0, 5487.807926722586, 5504.6421982571, 5515.834524964257, 24446.14438494662, 24500.89745961418, 24777.752222477906, 24866.12968546092, 24907.377315567257, 2056.950955012939, 2178.5425060737107, 2229.7658745831777, 2268.036084664011, 2333.5099629077913, 13738.0, 14289.785653215211, 14555.927220363936, 14703.70592588153, 14703.852961470355, 1647.0, 1668.0908904646876, 1696.202784691193, 1794.8923064616033, 1829.140304057091, 81343.7798433018, 102521.0, 105559.47220263927, 105946.0, 108235.91764082338, 10432.634857779942, 10832.40421776794, 10845.891541084646, 10935.890641093647, 10959.616413425492, 13139.408726607326, 13218.73562528744, 13287.667808304677, 13325.800112998313, 13356.465741370237, 8253.917460825314, 8397.496150231005, 8409.32725381968, 8477.872831907527, 8504.31965442763, 8610.009848867461, 8610.87083693745, 8635.306100032942, 8713.869291960626, 8718.346124040723, 4320.4599425071865, 4384.978075109604, 4402.9559704402545, 4446.933296000562, 4453.109378124388, 1726.8257584842177, 1779.6173822628198, 1789.0696837644352, 1848.159087615132, 1881.990590047041, 875.5140896802209, 887.2768693514765, 917.9816403672023, 932.5663566441638, 974.2011550528499, 18629.627407452048, 19130.808691913182, 19939.10274037672, 20502.794972050087, 20663.793362066488, 778.2489897249069, 914.9405288656216, 924.8474001789764, 930.1814951769275, 946.8674385586023, 10773.299735517323, 10927.836082458769, 10969.83545246822, 11006.712738361572, 11065.059469944983, 576805.0, 609148.9542552258, 614210.0, 626509.0, 629761.0, 126130.0, 127119.36440317739, 127852.0, 131902.0, 132085.33957330152, 857.3398483167925, 986.1765425869479, 997.9371968853148, 1006.1900170362782, 1008.0, 17010.404635837687, 17031.063291519087, 17925.731114033562, 18001.2799488019, 18600.34898778536, 39884.0, 52812.20781688354, 53628.0, 55010.0, 56168.0, 74107.0, 75402.62298688471, 76984.0, 78273.0, 78514.0, 7910.644021018953, 8038.919610803817, 8054.5569993650915, 8113.472624279403, 8202.671893124209, 9392.859107113261, 12858.549950751678, 13150.539731109366, 13153.839270622986, 13417.463301468222, 11031.448427578749, 11085.448037274627, 11169.553217871518, 11358.0, 11532.59635912739, 10745.677629671123, 10941.890581094087, 11093.722656933642, 11114.944425278145, 11253.437328133725, 11049.39228342449, 11508.769824603629, 11556.94221528887, 11582.768344633228, 11812.70468238301, 7790.922090779246, 7869.016372953381, 7978.720744773905, 8028.598570071356, 8035.718749843962, 10164.390136591828, 10786.784264314827, 11573.479193436147, 11607.245529040585, 11632.418379081182], "unit": "score", "name": "jquery.html", "value": 9400.433959469556}, {"lowerIsBetter": false, "replicates": [1399.2164387942746, 1530.6096945278953, 1551.3872020551878, 1762.453639371794, 1910.9808901910985, 7616.543007419552, 8181.8363632727305, 8317.168283171679, 8336.083030866599, 8338.666453341873, 7359.77920662381, 8157.225063618962, 8261.504309741405, 8265.421420500568, 8273.255407013368, 2110.00829610083, 2332.778386053331, 2387.594109001474, 2411.0837881605053, 2412.469256763518, 2396.820238482112, 2403.483251101013, 2405.1702162753822, 2407.4944261705064, 2408.157144999245, 2000.669889468236, 2331.2190416210506, 2367.6330168823774, 2392.7487613800563, 2393.664886915833, 2329.9767002329927, 2364.9054037838464, 2377.9881100594557, 2380.702412198475, 2385.9045638174453, 2338.5673650374733, 2344.2615576093476, 2367.786899179082, 2371.9288421347387, 2373.2287006722713, 8402.621882015324, 8452.366072544522, 8461.915380846174, 8467.49195048299, 8474.533900635462, 5150.072986862363, 5279.208118782175, 5301.946980530184, 5302.946970530284, 5306.389765177016, 3460.9480857786903, 3529.770564913272, 3576.695980841632, 3594.7663401878795, 3602.6937710294656, 999.6251405722854, 1017.954192061359, 1029.0892560084305, 1053.467998660679, 1057.3391630231106, 10791.46042697862, 10975.780484390267, 10978.725531861688, 10979.066779323766, 10987.0, 4445.066536027406, 4457.331400289918, 4516.345129956138, 4573.199690054227, 4591.4260717410325, 8806.86789698155, 8814.779630509289, 8820.823583528294, 8824.5587720615, 8834.381593288537, 5160.664556803796, 5161.922571161435, 5165.715885626251, 5169.302144210558, 5237.450067742909, 4291.227579035741, 4430.712003719748, 4608.9308660370125, 4734.95265047352, 4954.8761280968265, 3608.6210947850623, 3650.0509867434125, 3660.0666829958723, 3679.6504332088407, 3701.9814900925862, 962.9053588853214, 1151.45305979659, 1153.6481373181093, 1159.1769843411105, 1165.597868735285, 1265.0764941592504, 1270.8665590112905, 1292.405493472994, 1293.2822283632674, 1296.092735085444, 7878.606069696607, 7914.525128492309, 7941.880871786928, 7954.880676789853, 7967.601619918981, 488.2456604545985, 500.43950775132083, 501.31069779053803, 506.7035784066289, 508.1640701046757, 6066.423689749467, 6120.204373431426, 6154.0, 6155.630662160284, 6158.322584515699, 9695.854562181574, 9879.506024698736, 9894.653687120915, 9899.257555683209, 10049.196064314838, 9679.516024198761, 9855.310128291094, 9892.901070989343, 9915.0, 9917.702468925943, 7750.922490775133, 7872.370210383156, 7891.289783919475, 7897.486663366748, 7958.403119766041, 7397.963010184914, 7709.730159444617, 7714.15144334134, 7815.335696465864, 7820.296173344426, 9020.954895225483, 9280.443173409347, 9318.440893546409, 9361.85957210656, 9387.718368448957, 9326.160645541933, 9547.379420337656, 9591.944886062389, 9701.805963880824, 9833.311668183445, 6312.737452509425, 6413.326600707045, 6585.473162146921, 7224.277572242734, 7397.186309506058, 7881.921180788118, 7926.722564710208, 7947.761567152995, 7956.124826269222, 7971.481853679492, 6918.481113916376, 7003.3346832050875, 7018.789436316919, 7117.6085315308155, 7133.643317834191, 6910.343517365842, 6913.619750913748, 6991.6853741580735, 7042.7887163385185, 7054.647267636495, 7351.264873512606, 7389.704411823467, 7425.997490338735, 7462.813429664302, 7482.738104166328, 6717.731290748316, 6730.697118629576, 6776.830579235559, 6777.390034896883, 6834.282400347892, 6858.931410686029, 6869.793906182823, 6937.132858392701, 6938.063361446342, 6948.652567371712], "unit": "score", "name": "mootools.html", "value": 4614.661211758716}, {"lowerIsBetter": false, "replicates": [268.754090007643, 310.31730193574134, 317.9205198700325, 322.0708256679479, 323.0437903804741, 6420.0, 6436.871262574751, 6496.870062598757, 6507.0, 6529.673516324188, 6431.935680643192, 6447.7743278985245, 6459.51553633477, 6496.837579060514, 6513.544051916368, 3692.353838078339, 4707.90584188316, 4721.386219791422, 4786.1145688047645, 4857.3685420895235, 4804.927926081112, 4811.0, 4826.107170173512, 4827.082854257697, 4831.975840120795, 4262.808173632194, 4387.1445068211715, 4785.425748910136, 4788.449328327235, 4800.159972004885, 3822.7706337619834, 4551.68138230324, 4647.209974304376, 4737.478877323491, 4788.473267940523, 4059.6143366380443, 4069.6133867282856, 4072.124493233969, 4085.0, 4086.1010577672864, 6203.4416902479, 6243.469305109071, 6255.0, 6262.997920332725, 6314.589551679126, 5614.326280846284, 5619.690916999563, 5626.7211779229065, 5642.266505354278, 5649.6327738696855, 6701.195856497203, 6962.060121883532, 6967.965160174167, 6974.546654467444, 6975.232724400312, 4238.19474299882, 4574.451065872084, 4589.128065667513, 4614.400127983375, 4617.076584683077, 6649.468042556584, 7356.852862942711, 7358.153812311599, 7365.558066516026, 7376.336129748294, 4668.416447944007, 4669.112868554964, 4679.766011699401, 4685.929711054337, 4778.665493415428, 4741.644376671763, 4744.739039352799, 4745.810167593327, 4750.453697824794, 4756.167670657621, 4832.0, 5583.302087239095, 5585.1901474286005, 5595.38450770415, 5596.076647353222, 6707.396334329934, 6991.720331186797, 7016.333448322402, 7020.262872398427, 7032.12098487689, 1634.6485505616113, 1641.0399916049246, 1654.040656419274, 1657.6021754779008, 1659.2616285752724, 999.4702807512031, 1032.87605487342, 1067.7544164841975, 1083.0198670203322, 1096.9670909872716, 5275.311900191902, 5661.518770904519, 5935.554833387513, 6443.581167224209, 6471.320511346335, 7186.676599552928, 7286.4899457038555, 7307.903814427878, 7314.6708398121145, 7326.67029983652, 6490.415862572391, 6493.058506516623, 6497.772577959749, 6499.05763664266, 6518.608883467007, 3798.3732684106812, 3852.075501879529, 3862.903427414281, 3868.2263547290654, 3873.0317420644838, 6159.5072394208355, 7143.642817859086, 7661.42539309554, 7666.731664391719, 7688.0, 7501.212372700897, 7557.508761930567, 7566.810829729301, 7580.0, 7603.505772124794, 7619.352355049772, 7634.770956871303, 7647.732329368446, 7659.348955338859, 7662.0422447195215, 6464.0, 6591.274959754327, 7331.340179383881, 7342.3758980487255, 7350.154732205865, 5813.447722466359, 7163.964180179066, 7195.280471952763, 7255.09311336083, 7277.2722727726805, 7641.624507588687, 7642.04474440695, 7650.693972241271, 7651.273129052731, 7665.540067595962, 4190.580941905907, 4709.458412282632, 4758.357621721023, 4784.282357646381, 4796.304535842213, 6918.273581273894, 6925.411340036153, 7250.238724934017, 7261.927380726125, 7267.018952441353, 6959.652017399211, 6980.267071957574, 6981.860362792817, 6990.8951365728535, 7000.159980802337, 6902.102726645504, 6962.860742785015, 6973.5118541701595, 6981.441484681315, 6982.965085174542, 6816.625085620339, 6817.795466136024, 6823.0, 6832.555883867532, 6837.213720422215, 6753.0, 6989.405900498515, 7002.299770022957, 7004.7198112076985, 7007.649617519001, 6670.166229221348, 6760.3239676032, 6853.451723861979, 6877.037214789833, 6954.582725036514], "unit": "score", "name": "prototype.html", "value": 5075.364871565137}, {"lowerIsBetter": false, "replicates": [642.1876326447044, 652.1684851813936, 710.4139085254662, 726.843728598352, 737.3511310047157, 14166.787498187523, 14290.499832505864, 14290.857091429083, 14309.570712878603, 14611.342489587967, 13234.404451799692, 13983.860161398383, 14135.434582616708, 14153.15081095135, 14158.50445234417, 697.570993838788, 808.296781799835, 859.7635650196199, 880.5685214245005, 880.9383343165981, 726.6911562585906, 869.4522450855952, 885.8139790643972, 889.0398369760643, 893.2764460786783, 930.6137952749601, 933.7478880702206, 935.1957316707626, 935.9110884465999, 936.5691781780389, 748.4424104042469, 756.3570964679978, 922.8431166701644, 924.01130790055, 926.800737841364, 562.5977426140329, 675.139197523157, 682.7405585877335, 685.2462291479383, 685.6468918506973, 14722.043067200597, 14727.042742221722, 14791.0, 14794.038387504885, 14812.925935370362, 12215.633530994084, 12236.0, 12362.75274494514, 12493.125481216319, 12733.61799146027, 9622.182114520274, 9742.561584728704, 9813.460259685715, 10053.547590358452, 10129.746756331151, 3491.720662347006, 3525.3301872644115, 3526.0479670488826, 3544.6809787119023, 3603.549556305462, 75681.0, 76122.61938690326, 77139.6143019287, 79886.0, 80943.5952820238, 9292.163705266423, 9302.209312208402, 9457.148856602938, 9478.620855165716, 9959.452230127268, 21406.464838379165, 21468.570628587342, 21512.81679507611, 21516.56966860654, 21519.354419367442, 7379.631018449056, 7413.221611730798, 7417.592032438268, 7471.626418679044, 7489.700411983568, 3996.18078293949, 4010.218007488512, 4026.859059932888, 4078.938815917764, 4285.892852678646, 3463.0649724574223, 3497.2480916603054, 3520.559930008749, 3525.8060806655367, 3529.2059286660296, 553.2310088976326, 611.8225714542733, 616.4082480818464, 618.551550126164, 626.3611116661071, 511.07750510329214, 518.9091908915925, 542.3302221756128, 560.3276068717474, 560.8233406477028, 7532.17146113927, 7838.3337416320255, 7959.363250939911, 8116.310113640407, 8169.959150204211, 532.6378062917254, 559.6949662433983, 575.3153747041008, 586.1091141464949, 605.7213681706464, 3498.111757985777, 3731.645493678096, 3732.5101030536534, 3738.7943663098245, 3775.7356985010783, 69998.30001700019, 88083.55958220168, 88284.11715882887, 90561.0, 90566.64150037755, 70511.94232086523, 70744.58510829754, 76410.2358976403, 76732.0, 77762.61118694484, 70614.0, 71961.0, 72455.27544724486, 73307.63346183235, 73455.63272183605, 7385.741499047507, 7408.666610002455, 7467.701291948261, 7713.344365728976, 7738.947746632745, 49981.0, 50143.74928125336, 50378.748106259234, 51342.0, 51850.48149518456, 68362.65818670875, 69379.24621683647, 69941.950870738, 70094.64952675204, 70888.0, 9766.0, 9796.412215267106, 9838.483737000333, 9857.431774487586, 10233.692989210336, 10435.060844524029, 11007.559697612005, 11028.44857757125, 11588.826167607323, 11662.950334469939, 9723.951380243054, 9898.752531186778, 10014.849777253492, 10047.598096076075, 10234.539445724811, 10141.543630536496, 10357.223208259562, 10475.266731328733, 10481.528331224961, 10486.056254937092, 10062.345947513388, 10087.0, 10234.21156428953, 10353.01646343596, 10373.844392333971, 8649.91350086491, 8719.171678690514, 8775.254103401283, 8896.843023717003, 8994.730158095268, 8022.438429310126, 8650.394472386872, 8664.740057798275, 8720.476771393736, 8798.868016979879], "unit": "score", "name": "yui.html", "value": 6607.861089926125}], "name": "dromaeo_css", "value": 7376.722982769937}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 111.0, 110.0, 112.0, 116.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 145.0, 159.0, 120.0, 140.0, 139.0, 119.0, 164.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 140.0}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 190.0, 262.0, 220.0, 186.0, 185.0, 226.0, 250.0, 182.0], "unit": "score", "name": "audio-dft", "value": 207.1}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 85.0, 79.0, 58.0, 62.0, 69.0, 108.0, 106.0, 55.0], "unit": "score", "name": "audio-fft", "value": 77.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 126.0, 80.0, 80.0, 82.0, 109.0, 77.0, 80.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 96.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 84.0, 89.0, 124.0, 88.0, 84.0, 88.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 93.0, 92.0, 93.0, 92.0, 94.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 82.0, 88.0, 86.0, 85.0, 86.0, 87.0, 91.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 55.0, 53.0, 54.0, 53.0, 53.0, 65.0, 55.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 74.0, 71.0, 69.0, 67.0, 67.0, 66.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 81.0, 83.0, 82.0, 83.0, 82.0, 85.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 134.0, 111.0, 123.0, 132.0, 130.0, 133.0, 132.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [141.0, 127.0, 141.0, 140.0, 135.0, 119.0, 139.0, 138.0, 139.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1435.4}]} 19:47:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1435.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7376.72"}}} 19:47:40 INFO - Return code: 0 19:47:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:47:40 INFO - # TBPL SUCCESS # 19:47:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:40 INFO - 2016-03-02 19:47:40.609 screenresolution[1677:9703] starting screenresolution argv=screenresolution get 19:47:40 INFO - 2016-03-02 19:47:40.612 screenresolution[1677:9703] Display 0: 1600x1200x32@60 19:47:40 INFO - 2016-03-02 19:47:40.617 screenresolution[1678:9706] starting screenresolution argv=screenresolution list 19:47:40 INFO - Available Modes on Display 0 19:47:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:40 INFO - Intel Iris: 19:47:40 INFO - Chipset Model: Intel Iris 19:47:40 INFO - Type: GPU 19:47:40 INFO - Bus: Built-In 19:47:40 INFO - VRAM (Dynamic, Max): 1536 MB 19:47:40 INFO - Vendor: Intel (0x8086) 19:47:40 INFO - Device ID: 0x0a2e 19:47:40 INFO - Revision ID: 0x0009 19:47:40 INFO - Displays: 19:47:40 INFO - Display: 19:47:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:40 INFO - Display Serial Number: 1600x1200 60 19:47:40 INFO - Main Display: Yes 19:47:40 INFO - Mirror: Off 19:47:40 INFO - Online: Yes 19:47:40 INFO - Rotation: Supported 19:47:40 INFO - Return code: 0 19:47:40 INFO - Running post-action listener: _resource_record_post_action 19:47:40 INFO - Running post-run listener: _resource_record_post_run 19:47:41 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39409152; Write bytes: 704072192; Read time: 430; Write time: 1744 19:47:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 380111360; Write bytes: 374433792; Read time: 28616; Write time: 628 19:47:41 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38331904; Write bytes: 300007936; Read time: 408; Write time: 1057 19:47:41 INFO - Running post-run listener: _upload_blobber_files 19:47:41 INFO - Blob upload gear active. 19:47:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:47:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:47:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:43 INFO - (blobuploader) - INFO - Done attempting. 19:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:44 INFO - (blobuploader) - INFO - Done attempting. 19:47:44 INFO - (blobuploader) - INFO - Iteration through files over. 19:47:44 INFO - Return code: 0 19:47:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:47:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:47:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4c3c0b8912c1ba93f061682f154eb4f7f2935c8fcd64a646e74beabbaa9f2e65034e381b2fbddcfdcf958e4494e43b43118b85602ea009b21dddf373efc4ffb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bdd4d334352bd86e61dd63d3a4ebd26807185ca9df8599446ed9fc60e20dde26ef53c31ef968f8be88c6290ed43142221de7860e255ab9cde9115ed34d465db"} 19:47:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:47:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:47:44 INFO - Contents: 19:47:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4c3c0b8912c1ba93f061682f154eb4f7f2935c8fcd64a646e74beabbaa9f2e65034e381b2fbddcfdcf958e4494e43b43118b85602ea009b21dddf373efc4ffb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bdd4d334352bd86e61dd63d3a4ebd26807185ca9df8599446ed9fc60e20dde26ef53c31ef968f8be88c6290ed43142221de7860e255ab9cde9115ed34d465db"} 19:47:44 INFO - Running post-run listener: copy_logs_to_upload_dir 19:47:44 INFO - Copying logs to upload dir... 19:47:44 INFO - mkdir: /builds/slave/test/build/upload/logs 19:47:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.133649 ========= master_lag: 1.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-02 19:47:45.899350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-02 19:47:45.905264) ========= 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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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/e4c3c0b8912c1ba93f061682f154eb4f7f2935c8fcd64a646e74beabbaa9f2e65034e381b2fbddcfdcf958e4494e43b43118b85602ea009b21dddf373efc4ffb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bdd4d334352bd86e61dd63d3a4ebd26807185ca9df8599446ed9fc60e20dde26ef53c31ef968f8be88c6290ed43142221de7860e255ab9cde9115ed34d465db"} build_url:https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/EFATSoc0RIuOcAMrq_PW0A/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/e4c3c0b8912c1ba93f061682f154eb4f7f2935c8fcd64a646e74beabbaa9f2e65034e381b2fbddcfdcf958e4494e43b43118b85602ea009b21dddf373efc4ffb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8bdd4d334352bd86e61dd63d3a4ebd26807185ca9df8599446ed9fc60e20dde26ef53c31ef968f8be88c6290ed43142221de7860e255ab9cde9115ed34d465db"}' ========= master_lag: 1.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-02 19:47:46.937230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-02 19:47:46.937563) ========= 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.WmvWPzW9cj/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.74jJMBbzCv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005149 ========= master_lag: 5.50 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-02 19:47:52.438958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 19:47:52.439298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 19:47:52.550214) ========= ========= Total master_lag: 8.33 =========