builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0075 starttime: 1460145150.72 results: success (0) buildid: 20160408110255 builduid: 98dee13656fd413e959c2ce0c2353238 revision: 96dbbe35b47f6b6ff63d32fdac0895240fde458b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:30.721702) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:30.722184) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:30.722482) ========= 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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005574 basedir: '/builds/slave/test' ========= master_lag: 0.19 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:30.914403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:30.914673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:31.438817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:31.439200) ========= 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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.006379 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:31.560997) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:31.561260) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:31.561913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 12:52:31.562182) ========= 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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-04-08 12:52:31-- 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% 17.4M=0.001s 2016-04-08 12:52:32 (17.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.566637 ========= master_lag: 1.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 12:52:33.234592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:33.234881) ========= 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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.031763 ========= master_lag: 0.88 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:34.148749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 12:52:34.149059) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 96dbbe35b47f6b6ff63d32fdac0895240fde458b --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 96dbbe35b47f6b6ff63d32fdac0895240fde458b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-04-08 12:52:34,650 truncating revision to first 12 chars 2016-04-08 12:52:34,650 Setting DEBUG logging. 2016-04-08 12:52:34,650 attempt 1/10 2016-04-08 12:52:34,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/96dbbe35b47f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 12:52:35,379 unpacking tar archive at: fx-team-96dbbe35b47f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.980899 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 12:52:35.731777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:35.732088) ========= echo 96dbbe35b47f6b6ff63d32fdac0895240fde458b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'96dbbe35b47f6b6ff63d32fdac0895240fde458b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 96dbbe35b47f6b6ff63d32fdac0895240fde458b program finished with exit code 0 elapsedTime=0.006169 script_repo_revision: '96dbbe35b47f6b6ff63d32fdac0895240fde458b' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:35.816757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:35.817065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 12:52:36.342051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-04-08 12:52:36.342303) ========= /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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:52:36 INFO - MultiFileLogger online at 20160408 12:52:36 in /builds/slave/test 12:52:36 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 12:52:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:52:36 INFO - {'append_to_log': False, 12:52:36 INFO - 'base_work_dir': '/builds/slave/test', 12:52:36 INFO - 'blob_upload_branch': 'Fx-Team', 12:52:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:52:36 INFO - 'branch': 'Fx-Team', 12:52:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:52:36 INFO - 'config_files': ('talos/mac_config.py',), 12:52:36 INFO - 'default_actions': ('clobber', 12:52:36 INFO - 'read-buildbot-config', 12:52:36 INFO - 'download-and-extract', 12:52:36 INFO - 'populate-webroot', 12:52:36 INFO - 'create-virtualenv', 12:52:36 INFO - 'install', 12:52:36 INFO - 'run-tests'), 12:52:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:52:36 INFO - 'download_minidump_stackwalk': True, 12:52:36 INFO - 'download_symbols': 'ondemand', 12:52:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:52:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:52:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:52:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:52:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:52:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:52:36 INFO - 'installer_path': 'installer.exe', 12:52:36 INFO - 'log_level': 'info', 12:52:36 INFO - 'log_name': 'talos', 12:52:36 INFO - 'log_to_console': True, 12:52:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:52:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:52:36 INFO - 'opt_config_files': (), 12:52:36 INFO - 'pip_index': False, 12:52:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:52:36 INFO - 'cmd': ('bash', 12:52:36 INFO - '-c', 12:52:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:52:36 INFO - 'enabled': True, 12:52:36 INFO - 'halt_on_failure': False, 12:52:36 INFO - 'name': 'check_screen_resolution'},), 12:52:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:52:36 INFO - 'cmd': ('bash', 12:52:36 INFO - '-c', 12:52:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:52:36 INFO - 'enabled': True, 12:52:36 INFO - 'halt_on_failure': False, 12:52:36 INFO - 'name': 'check_screen_resolution'},), 12:52:36 INFO - 'run_cmd_checks_enabled': True, 12:52:36 INFO - 'sps_profile': False, 12:52:36 INFO - 'sps_profile_interval': 0, 12:52:36 INFO - 'suite': 'dromaeojs', 12:52:36 INFO - 'system_bits': '32', 12:52:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:52:36 INFO - 'title': 't-yosemite-r7-0075', 12:52:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:52:36 INFO - 'use_talos_json': True, 12:52:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:52:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:52:36 INFO - 'work_dir': 'build'} 12:52:36 INFO - ##### 12:52:36 INFO - ##### Running clobber step. 12:52:36 INFO - ##### 12:52:36 INFO - Running pre-action listener: _resource_record_pre_action 12:52:36 INFO - Running main action method: clobber 12:52:36 INFO - rmtree: /builds/slave/test/build 12:52:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:52:38 INFO - Running post-action listener: _resource_record_post_action 12:52:38 INFO - ##### 12:52:38 INFO - ##### Running read-buildbot-config step. 12:52:38 INFO - ##### 12:52:38 INFO - Running pre-action listener: _resource_record_pre_action 12:52:38 INFO - Running main action method: read_buildbot_config 12:52:38 INFO - Using buildbot properties: 12:52:38 INFO - { 12:52:38 INFO - "project": "", 12:52:38 INFO - "product": "firefox", 12:52:38 INFO - "script_repo_revision": "production", 12:52:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:52:38 INFO - "repository": "", 12:52:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:52:38 INFO - "buildid": "20160408110255", 12:52:38 INFO - "pgo_build": "False", 12:52:38 INFO - "basedir": "/builds/slave/test", 12:52:38 INFO - "buildnumber": 593, 12:52:38 INFO - "slavename": "t-yosemite-r7-0075", 12:52:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:52:38 INFO - "platform": "yosemite_r7", 12:52:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:52:38 INFO - "branch": "fx-team", 12:52:38 INFO - "repo_path": "integration/fx-team", 12:52:38 INFO - "revision": "96dbbe35b47f6b6ff63d32fdac0895240fde458b", 12:52:38 INFO - "stage_platform": "macosx64", 12:52:38 INFO - "builduid": "98dee13656fd413e959c2ce0c2353238", 12:52:38 INFO - "slavebuilddir": "test" 12:52:38 INFO - } 12:52:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 12:52:38 INFO - Running post-action listener: _resource_record_post_action 12:52:38 INFO - ##### 12:52:38 INFO - ##### Running download-and-extract step. 12:52:38 INFO - ##### 12:52:38 INFO - Running pre-action listener: _resource_record_pre_action 12:52:38 INFO - Running main action method: download_and_extract 12:52:38 INFO - mkdir: /builds/slave/test/build/tests 12:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:38 INFO - https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 12:53:06 INFO - Downloaded 1199 bytes. 12:53:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:53:06 INFO - Using the following test package requirements: 12:53:06 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:53:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 12:53:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 12:53:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'jsshell-mac.zip'], 12:53:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 12:53:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:53:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 12:53:06 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 12:53:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 12:53:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:53:06 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 12:53:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:53: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')]} 12:53:06 INFO - https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:53:08 INFO - Downloaded 18014587 bytes. 12:53:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:53:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:53:11 INFO - Return code: 0 12:53:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:11 INFO - https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:53:15 INFO - Downloaded 18014587 bytes. 12:53:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:53:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:53:19 INFO - Return code: 0 12:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:19 INFO - https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:53:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:53:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:53:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:53:20 INFO - Downloaded 10847693 bytes. 12:53:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:53:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:53:20 INFO - Return code: 0 12:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:20 INFO - https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 12:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 12:53:36 INFO - Downloaded 108790055 bytes. 12:53:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:53:36 INFO - mkdir: /builds/slave/test/properties 12:53:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:36 INFO - Contents: 12:53:36 INFO - build_url:https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:53:37 INFO - Running post-action listener: _resource_record_post_action 12:53:37 INFO - Running post-action listener: set_extra_try_arguments 12:53:37 INFO - ##### 12:53:37 INFO - ##### Running populate-webroot step. 12:53:37 INFO - ##### 12:53:37 INFO - Running pre-action listener: _resource_record_pre_action 12:53:37 INFO - Running main action method: populate_webroot 12:53:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:53:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:53:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:53:37 INFO - '--tppagecycles', 12:53:37 INFO - '7'], 12:53:37 INFO - 'tests': ['tsvgm']}}, 12:53:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:53:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:53:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['damp', 'tps']}, 12:53:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'tests': ['damp', 'tps']}, 12:53:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['dromaeo_dom']}, 12:53:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tsvgx', 12:53:37 INFO - 'tsvgr_opacity', 12:53:37 INFO - 'tart', 12:53:37 INFO - 'tscrollx', 12:53:37 INFO - 'cart']}, 12:53:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:37 INFO - 'tsvgr_opacity', 12:53:37 INFO - 'tart', 12:53:37 INFO - 'tscrollx', 12:53:37 INFO - 'cart']}, 12:53:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tp5o']}, 12:53:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'tests': ['tp5o']}, 12:53:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s', 12:53:37 INFO - '--xperf_path', 12:53:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:37 INFO - 'tests': ['tp5n']}, 12:53:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--xperf_path', 12:53:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:37 INFO - 'tests': ['tp5n']}}, 12:53:37 INFO - 'talos.zip': {'path': '', 12:53:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:53:37 INFO - Running post-action listener: _resource_record_post_action 12:53:37 INFO - ##### 12:53:37 INFO - ##### Running create-virtualenv step. 12:53:37 INFO - ##### 12:53:37 INFO - Running pre-action listener: _resource_record_pre_action 12:53:37 INFO - Running main action method: create_virtualenv 12:53:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:37 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 12:53:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:53:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:37 INFO - Using real prefix '/tools/python27' 12:53:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:41 INFO - Installing pip.................done. 12:53:41 INFO - Return code: 0 12:53:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:41 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:53:41 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 12:53:41 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 12:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:41 INFO - 'HOME': '/Users/cltbld', 12:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:41 INFO - 'LOGNAME': 'cltbld', 12:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:41 INFO - 'MOZ_NO_REMOTE': '1', 12:53:41 INFO - 'NO_EM_RESTART': '1', 12:53:41 INFO - 'PAGER': '/bin/cat', 12:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:41 INFO - 'PWD': '/builds/slave/test', 12:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:41 INFO - 'SHELL': '/bin/bash', 12:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:53:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:41 INFO - 'USER': 'cltbld', 12:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:41 INFO - 'XPC_FLAGS': '0x0', 12:53:41 INFO - 'XPC_SERVICE_NAME': '0', 12:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:41 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 12:53:41 INFO - Cleaning up... 12:53:41 INFO - Return code: 0 12:53:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:41 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:53:41 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 12:53:41 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 12:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:41 INFO - 'HOME': '/Users/cltbld', 12:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:41 INFO - 'LOGNAME': 'cltbld', 12:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:41 INFO - 'MOZ_NO_REMOTE': '1', 12:53:41 INFO - 'NO_EM_RESTART': '1', 12:53:41 INFO - 'PAGER': '/bin/cat', 12:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:41 INFO - 'PWD': '/builds/slave/test', 12:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:41 INFO - 'SHELL': '/bin/bash', 12:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:53:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:41 INFO - 'USER': 'cltbld', 12:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:41 INFO - 'XPC_FLAGS': '0x0', 12:53:41 INFO - 'XPC_SERVICE_NAME': '0', 12:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:41 INFO - Downloading/unpacking psutil>=0.7.1 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 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 12:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:44 INFO - Installing collected packages: psutil 12:53:44 INFO - Running setup.py install for psutil 12:53:44 INFO - building 'psutil._psutil_osx' extension 12:53:44 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 12:53:45 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 12:53:45 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 12:53:45 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 12:53:45 INFO - building 'psutil._psutil_posix' extension 12:53:45 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 12:53:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:53:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:53:45 INFO - ^ 12:53:45 INFO - 1 warning generated. 12:53:45 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 12:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:45 INFO - Successfully installed psutil 12:53:45 INFO - Cleaning up... 12:53:46 INFO - Return code: 0 12:53:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:46 INFO - 'HOME': '/Users/cltbld', 12:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:46 INFO - 'LOGNAME': 'cltbld', 12:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:46 INFO - 'MOZ_NO_REMOTE': '1', 12:53:46 INFO - 'NO_EM_RESTART': '1', 12:53:46 INFO - 'PAGER': '/bin/cat', 12:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:46 INFO - 'PWD': '/builds/slave/test', 12:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:46 INFO - 'SHELL': '/bin/bash', 12:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:53:46 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:46 INFO - 'USER': 'cltbld', 12:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:46 INFO - 'XPC_FLAGS': '0x0', 12:53:46 INFO - 'XPC_SERVICE_NAME': '0', 12:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:53:48 INFO - Installing collected packages: mozsystemmonitor 12:53:48 INFO - Running setup.py install for mozsystemmonitor 12:53:48 INFO - Successfully installed mozsystemmonitor 12:53:48 INFO - Cleaning up... 12:53:49 INFO - Return code: 0 12:53:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:49 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:53:49 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 12:53:49 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 12:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:49 INFO - 'HOME': '/Users/cltbld', 12:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:49 INFO - 'LOGNAME': 'cltbld', 12:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:49 INFO - 'MOZ_NO_REMOTE': '1', 12:53:49 INFO - 'NO_EM_RESTART': '1', 12:53:49 INFO - 'PAGER': '/bin/cat', 12:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:49 INFO - 'PWD': '/builds/slave/test', 12:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:49 INFO - 'SHELL': '/bin/bash', 12:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:53:49 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:49 INFO - 'USER': 'cltbld', 12:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:49 INFO - 'XPC_FLAGS': '0x0', 12:53:49 INFO - 'XPC_SERVICE_NAME': '0', 12:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:51 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:53:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:52 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 12:53:52 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 12:53:52 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 12:53:52 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 12:53:52 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 12:53:52 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 12:53:52 INFO - Downloading docopt-0.6.1.tar.gz 12:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:52 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:52 INFO - Running setup.py install for blobuploader 12:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:53:53 INFO - Running setup.py install for requests 12:53:53 INFO - Running setup.py install for docopt 12:53:53 INFO - Successfully installed blobuploader requests docopt 12:53:53 INFO - Cleaning up... 12:53:53 INFO - Return code: 0 12:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:53 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:53:53 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 12:53:53 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 12:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:53 INFO - 'HOME': '/Users/cltbld', 12:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:53 INFO - 'LOGNAME': 'cltbld', 12:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:53 INFO - 'MOZ_NO_REMOTE': '1', 12:53:53 INFO - 'NO_EM_RESTART': '1', 12:53:53 INFO - 'PAGER': '/bin/cat', 12:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:53 INFO - 'PWD': '/builds/slave/test', 12:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:53 INFO - 'SHELL': '/bin/bash', 12:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:53:53 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:53 INFO - 'USER': 'cltbld', 12:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:53 INFO - 'XPC_FLAGS': '0x0', 12:53:53 INFO - 'XPC_SERVICE_NAME': '0', 12:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-A_KcyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-W6ek41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-9OP705-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-eWHJ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-MzyWP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-CUYc9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-J2oUFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-WCgDSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:54 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-TTYwMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-C2BBKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-i6CI2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LC3Avc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-8T5D_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-RMZdyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Q52LMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-nWWUlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:55 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-7yVn86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:55 INFO - Running setup.py install for manifestparser 12:53:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozcrash 12:53:56 INFO - Running setup.py install for mozdebug 12:53:56 INFO - Running setup.py install for mozdevice 12:53:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozfile 12:53:56 INFO - Running setup.py install for mozhttpd 12:53:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozinfo 12:53:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:53:56 INFO - Running setup.py install for mozInstall 12:53:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Running setup.py install for mozleak 12:53:57 INFO - Running setup.py install for mozlog 12:53:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Running setup.py install for moznetwork 12:53:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Running setup.py install for mozprocess 12:53:57 INFO - Running setup.py install for mozprofile 12:53:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:53:57 INFO - Running setup.py install for mozrunner 12:53:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:53:58 INFO - Running setup.py install for mozscreenshot 12:53:58 INFO - Running setup.py install for moztest 12:53:58 INFO - Running setup.py install for mozversion 12:53:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:53:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:58 INFO - Cleaning up... 12:53:58 INFO - Return code: 0 12:53:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:58 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')]} 12:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:58 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')]} 12:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:58 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:53:58 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 12:53:58 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 12:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:58 INFO - 'HOME': '/Users/cltbld', 12:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:58 INFO - 'LOGNAME': 'cltbld', 12:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:58 INFO - 'MOZ_NO_REMOTE': '1', 12:53:58 INFO - 'NO_EM_RESTART': '1', 12:53:58 INFO - 'PAGER': '/bin/cat', 12:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:58 INFO - 'PWD': '/builds/slave/test', 12:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:58 INFO - 'SHELL': '/bin/bash', 12:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:53:58 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:58 INFO - 'USER': 'cltbld', 12:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:58 INFO - 'XPC_FLAGS': '0x0', 12:53:58 INFO - 'XPC_SERVICE_NAME': '0', 12:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:58 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-4PZsiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:58 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)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:58 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-0TlM92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 12:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:58 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Ye6kyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-E9zplG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-BJ4xZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jQb1BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-UdDi6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-cLZ6Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-P7P0Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Kur_pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-arUN71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Q0ugKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:59 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)) 12:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Q5pnER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:00 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)) 12:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-1lwPVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:00 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)) 12:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mbgjUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:00 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)) 12:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-77ltts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:00 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)) 12:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-OL9fc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:00 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)) 12:54:00 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:00 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:00 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)) 12:54:00 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)) 12:54:00 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)) 12:54:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:00 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 12:54:00 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 12:54:00 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 12:54:00 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 12:54:00 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 12:54:00 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 12:54:02 INFO - Downloading blessings-1.6.tar.gz 12:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:03 INFO - Installing collected packages: blessings 12:54:03 INFO - Running setup.py install for blessings 12:54:03 INFO - Successfully installed blessings 12:54:03 INFO - Cleaning up... 12:54:03 INFO - Return code: 0 12:54:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:03 INFO - Reading from file tmpfile_stdout 12:54:03 INFO - Current package versions: 12:54:03 INFO - blessings == 1.6 12:54:03 INFO - blobuploader == 1.2.4 12:54:03 INFO - docopt == 0.6.1 12:54:03 INFO - manifestparser == 1.1 12:54:03 INFO - mozInstall == 1.12 12:54:03 INFO - mozcrash == 0.17 12:54:03 INFO - mozdebug == 0.1 12:54:03 INFO - mozdevice == 0.48 12:54:03 INFO - mozfile == 1.2 12:54:03 INFO - mozhttpd == 0.7 12:54:03 INFO - mozinfo == 0.9 12:54:03 INFO - mozleak == 0.1 12:54:03 INFO - mozlog == 3.1 12:54:03 INFO - moznetwork == 0.27 12:54:03 INFO - mozprocess == 0.22 12:54:03 INFO - mozprofile == 0.28 12:54:03 INFO - mozrunner == 6.11 12:54:03 INFO - mozscreenshot == 0.1 12:54:03 INFO - mozsystemmonitor == 0.0 12:54:03 INFO - moztest == 0.7 12:54:03 INFO - mozversion == 1.4 12:54:03 INFO - psutil == 3.1.1 12:54:03 INFO - requests == 1.2.3 12:54:03 INFO - wsgiref == 0.1.2 12:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:03 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')]} 12:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 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')]} 12:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:54:03 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 12:54:03 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 12:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:03 INFO - 'HOME': '/Users/cltbld', 12:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:03 INFO - 'LOGNAME': 'cltbld', 12:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:03 INFO - 'MOZ_NO_REMOTE': '1', 12:54:03 INFO - 'NO_EM_RESTART': '1', 12:54:03 INFO - 'PAGER': '/bin/cat', 12:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:03 INFO - 'PWD': '/builds/slave/test', 12:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:03 INFO - 'SHELL': '/bin/bash', 12:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:54:03 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:03 INFO - 'USER': 'cltbld', 12:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:03 INFO - 'XPC_FLAGS': '0x0', 12:54:03 INFO - 'XPC_SERVICE_NAME': '0', 12:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 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)) 12:54:03 INFO - Cleaning up... 12:54:03 INFO - Return code: 0 12:54:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:03 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')]} 12:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 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')]} 12:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:54:03 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 12:54:03 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 12:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:03 INFO - 'HOME': '/Users/cltbld', 12:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:03 INFO - 'LOGNAME': 'cltbld', 12:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:03 INFO - 'MOZ_NO_REMOTE': '1', 12:54:03 INFO - 'NO_EM_RESTART': '1', 12:54:03 INFO - 'PAGER': '/bin/cat', 12:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:03 INFO - 'PWD': '/builds/slave/test', 12:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:03 INFO - 'SHELL': '/bin/bash', 12:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:54:03 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:03 INFO - 'USER': 'cltbld', 12:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:03 INFO - 'XPC_FLAGS': '0x0', 12:54:03 INFO - 'XPC_SERVICE_NAME': '0', 12:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:04 INFO - Downloading/unpacking jsonschema 12:54:04 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 12:54:04 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 12:54:04 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 12:54:04 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 12:54:04 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 12:54:04 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 12:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:06 INFO - Downloading/unpacking functools32 (from jsonschema) 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:07 INFO - warning: no files found matching '*.txt' 12:54:07 INFO - no previously-included directories found matching 'build' 12:54:07 INFO - no previously-included directories found matching 'dist' 12:54:07 INFO - no previously-included directories found matching '.git*' 12:54:07 INFO - Installing collected packages: jsonschema, functools32 12:54:07 INFO - Running setup.py install for functools32 12:54:07 INFO - warning: no files found matching '*.txt' 12:54:07 INFO - no previously-included directories found matching 'build' 12:54:07 INFO - no previously-included directories found matching 'dist' 12:54:07 INFO - no previously-included directories found matching '.git*' 12:54:07 INFO - Successfully installed jsonschema functools32 12:54:07 INFO - Cleaning up... 12:54:07 INFO - Return code: 0 12:54:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 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 0x100b9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100baf420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d05afce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, '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.dMAuqJx2ab/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.0xvyikWdhw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:54:07 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 12:54:07 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 12:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:07 INFO - 'HOME': '/Users/cltbld', 12:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:07 INFO - 'LOGNAME': 'cltbld', 12:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:07 INFO - 'MOZ_NO_REMOTE': '1', 12:54:07 INFO - 'NO_EM_RESTART': '1', 12:54:07 INFO - 'PAGER': '/bin/cat', 12:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:07 INFO - 'PWD': '/builds/slave/test', 12:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:07 INFO - 'SHELL': '/bin/bash', 12:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:54:07 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:07 INFO - 'USER': 'cltbld', 12:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:07 INFO - 'XPC_FLAGS': '0x0', 12:54:07 INFO - 'XPC_SERVICE_NAME': '0', 12:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:07 INFO - Downloading/unpacking flake8 12:54:07 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 12:54:07 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 12:54:07 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 12:54:07 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 12:54:07 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 12:54:07 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 12:54:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:54:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:54:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:10 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 12:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:11 INFO - no previously-included directories found matching 'docs/_build' 12:54:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:54:11 INFO - Running setup.py install for pep8 12:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:11 INFO - no previously-included directories found matching 'docs/_build' 12:54:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:54:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:54:11 INFO - Cleaning up... 12:54:11 INFO - Return code: 0 12:54:11 INFO - Running post-action listener: _resource_record_post_action 12:54:11 INFO - Running post-action listener: _start_resource_monitoring 12:54:11 INFO - Starting resource monitoring. 12:54:11 INFO - ##### 12:54:11 INFO - ##### Running install step. 12:54:11 INFO - ##### 12:54:11 INFO - Running pre-action listener: _resource_record_pre_action 12:54:11 INFO - Running main action method: install 12:54:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:11 INFO - Reading from file tmpfile_stdout 12:54:11 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:12 INFO - Reading from file tmpfile_stdout 12:54:12 INFO - Output received: 12:54:12 INFO - Usage: mozinstall [options] installer 12:54:12 INFO - Options: 12:54:12 INFO - -h, --help show this help message and exit 12:54:12 INFO - -d DEST, --destination=DEST 12:54:12 INFO - Directory to install application into. [default: 12:54:12 INFO - "/builds/slave/test"] 12:54:12 INFO - --app=APP Application being installed. [default: firefox] 12:54:12 INFO - mkdir: /builds/slave/test/build/application 12:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:54:45 INFO - Reading from file tmpfile_stdout 12:54:45 INFO - Output received: 12:54:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:54:45 INFO - Running post-action listener: _resource_record_post_action 12:54:45 INFO - ##### 12:54:45 INFO - ##### Running run-tests step. 12:54:45 INFO - ##### 12:54:45 INFO - Running pre-action listener: _resource_record_pre_action 12:54:45 INFO - Running main action method: run_tests 12:54:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:54:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:54:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:54:45 INFO - 2016-04-08 12:54:45.046 screenresolution[1649:9050] starting screenresolution argv=screenresolution get 12:54:45 INFO - 2016-04-08 12:54:45.049 screenresolution[1649:9050] Display 0: 1600x1200x32@60 12:54:45 INFO - 2016-04-08 12:54:45.055 screenresolution[1650:9052] starting screenresolution argv=screenresolution list 12:54:45 INFO - Available Modes on Display 0 12:54:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:54:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:54:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:54:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:54:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:54:45 INFO - Intel Iris: 12:54:45 INFO - Chipset Model: Intel Iris 12:54:45 INFO - Type: GPU 12:54:45 INFO - Bus: Built-In 12:54:45 INFO - VRAM (Dynamic, Max): 1536 MB 12:54:45 INFO - Vendor: Intel (0x8086) 12:54:45 INFO - Device ID: 0x0a2e 12:54:45 INFO - Revision ID: 0x0009 12:54:45 INFO - Displays: 12:54:45 INFO - Display: 12:54:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:54:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:54:45 INFO - Display Serial Number: 1600x1200 60 12:54:45 INFO - Main Display: Yes 12:54:45 INFO - Mirror: Off 12:54:45 INFO - Online: Yes 12:54:45 INFO - Rotation: Supported 12:54:45 INFO - Return code: 0 12:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:45 INFO - Python 2.7.3 12:54:45 INFO - Return code: 0 12:54:45 INFO - grabbing minidump binary from tooltool 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:45 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 0x100a3ee00>, '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 0x100867db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a39b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:45 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 12:54:45 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 12:54:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:45 INFO - Return code: 0 12:54:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:54:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:54:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:54:46 INFO - Return code: 0 12:54:46 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/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 12:54:46 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/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --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 12:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMAuqJx2ab/Render', 12:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:46 INFO - 'HOME': '/Users/cltbld', 12:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:46 INFO - 'LOGNAME': 'cltbld', 12:54:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:46 INFO - 'MOZ_NO_REMOTE': '1', 12:54:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:46 INFO - 'NO_EM_RESTART': '1', 12:54:46 INFO - 'PAGER': '/bin/cat', 12:54:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:46 INFO - 'PWD': '/builds/slave/test', 12:54:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:46 INFO - 'SHELL': '/bin/bash', 12:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0xvyikWdhw/Listeners', 12:54:46 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:46 INFO - 'USER': 'cltbld', 12:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:46 INFO - 'XPC_FLAGS': '0x0', 12:54:46 INFO - 'XPC_SERVICE_NAME': '0', 12:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:46 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/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 12:54:46 INFO - mozversion application_buildid: 20160408110255 12:54:46 INFO - mozversion application_changeset: 96dbbe35b47f6b6ff63d32fdac0895240fde458b 12:54:46 INFO - mozversion application_display_name: Nightly 12:54:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:46 INFO - mozversion application_name: Firefox 12:54:46 INFO - mozversion application_remotingname: firefox 12:54:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:54:46 INFO - mozversion application_vendor: Mozilla 12:54:46 INFO - mozversion application_version: 48.0a1 12:54:46 INFO - mozversion platform_buildid: 20160408110255 12:54:46 INFO - mozversion platform_changeset: 96dbbe35b47f6b6ff63d32fdac0895240fde458b 12:54:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:54:46 INFO - mozversion platform_version: 48.0a1 12:54:46 INFO - using testdate: 1460145286 12:54:46 INFO - actual date: 1460145286 12:54:46 INFO - starting webserver on 'localhost:49274' 12:54:46 INFO - SUITE-START | Running 2 tests 12:54:46 INFO - TEST-START | dromaeo_css 12:54:46 INFO - operating with platform_type : mac_ 12:54:46 INFO - Initialising browser for dromaeo_css test... 12:54:46 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpNaFkjg/profile http://localhost:49274/getInfo.html) 12:54:49 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 12:54:49 INFO - PROCESS | 1668 | colorDepth:24 12:54:49 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 12:54:49 INFO - PROCESS | 1668 | __metrics 12:54:49 INFO - PROCESS | 1668 | 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" 12:54:49 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:54:49 INFO - TEST-INFO | 1668: exit 0 12:54:49 INFO - Browser initialized. 12:54:49 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:49 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpNaFkjg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:01 INFO - PROCESS | 1671 | RSS: Main: 237203456 12:55:01 INFO - PROCESS | 1671 | 12:55:52 INFO - PROCESS | 1671 | 1460145352961 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] 12:58:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 12:58:04 INFO - PROCESS | 1671 | RSS: Main: 365363200 12:58:04 INFO - PROCESS | 1671 | 13:01:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 13:01:08 INFO - PROCESS | 1671 | RSS: Main: 374181888 13:01:08 INFO - PROCESS | 1671 | 13:04:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 13:04:11 INFO - PROCESS | 1671 | RSS: Main: 375578624 13:04:11 INFO - PROCESS | 1671 | 13:07:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 13:07:13 INFO - PROCESS | 1671 | RSS: Main: 332697600 13:07:13 INFO - PROCESS | 1671 | 13:10:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 13:10:17 INFO - PROCESS | 1671 | RSS: Main: 334667776 13:10:17 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 13:13:20 INFO - PROCESS | 1671 | RSS: Main: 384999424 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | __start_tp_report 13:13:20 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 13:13:20 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 13:13:20 INFO - PROCESS | 1671 | |i|pagename|runs| 13:13:20 INFO - PROCESS | 1671 | |0;dojo.html;3186.617605887293;3409.863605455782;3445.55207822983;3449.5688038995127;3491.3715531204375;5599.1041433370665;5615.354234263056;5644.887102257958;5652.858678533039;5687.459691329317;5591.077472217079;5691.8577035574135;5720.856978575538;5771.942280577193;5772.624779389347;5119.462456442076;5163.767630456619;5188.42927278001;5193.974030129844;5278.049951008817;5287.312649355597;5295.523402893738;5336.092864213093;5338.839834804962;5370.7046112463795;5137.3064636274;5177.171652535576;5230.790768369298;5255.947440525584;5296.655717378358;5238.030964271622;5242.030224408459;5251.317328747276;5256.1852912798195;5279.683219006872;5188.870278243074;5202.4537423570355;5221.373435187764;5254.238135470336;5257.158854583248;5459.071957767189;5576.581756368248;5583.3300003999375;5587.245721827582;5711.628744131618;6196.938030619726;6224.564280500367;6229.4704950079295;6248.218972628421;6254.530910181755;6229.6573688447115;6297.055441683784;6297.118403423525;6309.148264984215;6340.3659634036685;5672;5731.484166425042;5785.508231800302;5790.942090579082;5851.736671849777;6273.560850740496;6294.937050629526;6300;6302.149209856702;6304.716287767062;5914.940850591525;5925.585209035412;5977.910331345033;6009.969950150309;6020.458158765732;6131.651934473353;6165.784197553064;6177.289611694712;6269.310375858652;6284.025975973731;5083.830718934666;6016.127661489059;6193.721282542297;6195.132681424604;6203.379662033761;6226.813195604139;6227.252729672468;6229.345918678564;6239.1577137085915;6240.438360547572;4853.781579828917;4887.997960418105;4895.681780684244;4931.630127740434;4979.128652485873;4429.889252768642;4437.5784300491405;4451.287793952952;4459.665525085632;4492.236319825637;5623.437656234344;5656.547476201977;5684.8294551163535;5694.658320500783;5697.116946873241;6130.092410195624;6167.198264225622;6277.874442511215;6291.276503202099;6292.685365731695;5660.490555849993;5665.348484924287;5700.714964251853;5706.572007099484;5710.885782284331;5259.894802103937;5372.462753724596;5378.2470454136455;5381.569474442035;5388.838334849961;6224.688765561795;6274.1843560336865;6277.5605707600025;6280.685965701605;6291.811245662638;6239.4696450800375;6254.843628909313;6257.499400047895;6261.092141639346;6276.184096067482;6196.132541444112;6234.9688251558455;6240.375962403723;6255.155554000152;6284.717187726655;6117.021276595723;6160.075988601567;6177.752889884354;6184.938150618436;6185.103160041679;5650.378458369658;5870.8258348329655;6073.969630151821;6227.50179985591;6238.344973777688;5039.470855560114;5914.172015917861;5940.376260492586;6056.424639659225;6069.848253793514;6052.303985041601;6062.272527296753;6082.665453400105;6087.391260873877;6127.325994140552;5904.3800400959;5907.9704601476715;5919.704014799329;5922.082077278029;5927.377625349449;5866.442687944638;6008.759649613967;6059.575829691879;6075.1191077294425;6081.5742897996715;4938.75306234694;5935.792247271324;5936.643801371932;5949.345571986992;5973.850653733692 13:13:20 INFO - PROCESS | 1671 | |1;ext.html;502.427232954432;529.5340100711373;578.4042436290622;580.5877826743011;587.4742105815295;29204.707952920464;37313.813430932874;38411;38511.22977540448;38520.22959540808;42874.35688464675;43579;43624.12751744963;43820.56179438205;43847.34228986568;9533.285003624738;9682.612695492171;9689.467079310634;9693.757656058584;9721.173700235453;9558.856617150748;9707.320487565874;9722.368046077017;9727.416355018722;9742.269329800294;9677.419354838697;9729.56216970238;9747.707568772912;9768.853467197998;9772.755681107994;9668.661596844111;9732.41605503672;9735.56189971453;9749.756256093584;9758.219342452587;9555.61777528898;9664.468454235015;9665.613375464973;9673;9681.757956051084;39831.00422489432;40275.798621007;40395.79802101;40423;40504.59495405038;3122.3443076953868;3143.512755522898;3209.7111259986714;3292.259241670629;3630.6550877666577;28122.156335309974;28433.147005589864;29115.41769164605;29118.417631647248;29230.56154157689;2630.053180854891;2702.297402675299;2754.187514683173;2758.903438379667;2776.819506732076;377496;386601.06699466606;386652;386867;387185.12814872054;65893.670531648;65966.75415573054;66693.66369699329;66703.99944000844;66765.33234667592;70768;71232;71689;71851;71953;16664.083475408726;16855;16903.915480422518;16919.40782072646;16919.577010574834;12402;12482.063845211645;12496.375181240901;12509.874901251053;12510;20059.699104513445;20127.899360503103;20424.876631785395;20577.38267851967;20632;7388.298111679489;8553.572321383906;8638.13618638131;8646.178613031752;8654.307655387554;916.5508900638772;977.5210147028047;998.9500524973722;1061.506399524225;1099.4887377369562;23099.653505197435;28514.429711405657;28568.428631427254;29380.971665991587;29969;1061.6708820265742;1096.6490722968574;1103.862017247844;1131.2477202660139;1168.3457263932225;14944.476943306932;14994.925025374803;15471.303791329417;15511.5346539604;15570.688586228212;584867;589676;595496;595848;596685.0331496629;58908.7054564733;59565.70217148887;59658;59832.102518462256;59903.80192396128;1227.1655274413486;1350.6960933790015;1356.1727346318935;1432.6776475292975;1476.3135142158947;25882.482350353264;26690.733092668826;30056.69943300539;30806.228820717435;31564.526532101576;52213.73893130662;54175.72912135414;54401.455985439636;54455;54482.72758636181;347840;353371;354521;354986;356673;34770.304593908484;40740;41867.581324186365;42669.573304267804;42772;41743.58256417397;42605;43533.3469997944;44129.77935110304;45457.54542454533;35900;36949.81525092357;37077;37281.97493489754;37816.81091594634;29931.70068299289;31013;35016.249187541034;36498.635013649524;36652;36664.816675917515;36756.264874702894;37028.25943481169;37655.62344376631;37763.62236377601;27729.660162092692;31676.208094797814;31992.840035799672;32049.83352164297;32186.678133219306;23364.415889602897;23906.64140037866;24064.87967560151;24257.331693514054;24344.391390215387 13:13:20 INFO - PROCESS | 1671 | |2;jquery.html;371.6562179983518;389.94735710679066;395.7427672013191;398.09234944326926;403.21373322022043;19583;20902.790972090275;21113.894430527827;21189.894050529765;21205.893970530145;20099.899500502514;20380;20802.583948321062;20931.37205883822;21143.04856281467;5225.973870130644;5796.623219490741;5999.970000149993;6000.039993601024;6033.456988871001;4219.746815191098;4468.575485328888;4470.597646211841;4474.865754027368;4484.506704262529;4459.866204013885;5485.930243602499;5641.351244606861;6511.837204069912;6516.902246466307;6394.872102557946;6442.903356449657;6524.902126468107;6559.672016399209;6566.835829104287;5487.176923461513;5656.462636049569;5671.432856714337;5673.177389278531;5679.318481782171;19779;22394.888025559932;25691.84386702603;26040.739592604023;26138.86930565354;2325.430269583946;2335.988320058389;2418.718079417911;2528.810339224547;2530.3800568860747;14013.5095271665;14685.412583496647;15031.098134111988;15131.940764146515;15543.300551475098;1708.7607734917121;1710.529604358799;1773.6786094359784;1780.1455301455374;1944.9983258621821;89225;111057;116265;120812;123537.38231308966;9562.091601297865;11658.242214256046;11704.47329870158;11844;11866.34735089561;15191.240437978056;15277.694446111016;15287.61780955485;15311.61720956985;15329.540113796604;8544.102869198645;8704.738857834274;8723.781905452288;8819.603117859711;8845.292376609856;7102.786916392516;8586.31309495239;8589.398742087993;8602.483386672377;8721.825563488695;3817.84728610858;4615.353850460871;4660.067986402733;4813.927791083137;4828.975855120702;1824.6315263552335;1872.4008317338594;1896.952576185579;1953.687410014391;1995.2517805822818;757.3184134279082;885.7519894429441;1034.2915103154364;1053.641761800976;1055.6516349604613;19182.808171918383;19966.30117945865;20723.171073157206;20824.895875520524;20836.47908802292;913.881195444588;914.1863741270275;929.256594724218;941.6045260990263;950.7670620697835;8478.533680647624;8484.957575212084;10845.023947844731;11119.944400277947;11184.888151118384;506901.4654926775;614282.9285853542;632183.8390808017;635576;638461;120109.39945300217;126435;129360;130044;134202;1024.1806554756165;1026.97432564185;1051.2851261142343;1100.5102729285552;1105.618561596248;18056.277748889897;18378.1729822161;18453.723194152368;18582.256709732;18702;47112;48474;50188.49811501838;50356.49643503518;50806.23790643217;73513;73687.631561844;73968;75586.62206688931;76638.2336176631;7938.206179382247;8003.838963479711;8082.7171049013;8195.631196596287;8312.584370781558;10925.180611454014;12547.372631368578;12608.74782504363;12661.81007284873;12667.113302068767;10495.685129446128;10684.358938463716;10688.946555267485;10946.124310055337;11120.388378639253;10378;10474.68575942723;10630.84053739179;10704.946475267574;11030.393328367018;10833.620823271147;11019.118470522179;11064.889351106385;11146;11253.381064041556;8083.595820208849;8155.021397432346;8237.258646721824;8348.206920342558;8396.202360775716;10213.693589192038;10913.781724365626;10938.945305273422;11006.449677515931;11164.49759760829 13:13:20 INFO - PROCESS | 1671 | |3;mootools.html;1410.2243765928736;1576.6925449537341;1609.364301101065;1791.4088350844215;1917.7890432052482;7890.210978902107;8570.957145214274;8840.115988401156;8842.204201621853;8856.955715221415;8474.135690148172;8679.783005424868;8699.043105258432;8708.303335733142;8713.477191368507;2044.509317763741;2132.957340853182;2246.7303923529157;2257.6500642400456;2285.2915596165158;2213.8671679699187;2422.9394265143337;2473.2951108933958;2500.8874600643016;2501.5997440409537;2431.63525471179;2456.4472993576483;2469.3579669285937;2471.864047477388;2474;2263.796258336741;2265.207177487874;2276.7950884420316;2297.977020229793;2299.011425087212;2381.595128828086;2384.6661467394406;2452.3869032741813;2454.1533171055958;2459.7417271186446;8654.826903461959;8796.736097917073;8810.823783524358;8812.16284452976;8834.646614135427;5202.583793296565;5383.111786555253;5393.002294575477;5393.9730301348245;5396.487333703292;3547.5742910850604;3573.9992802015477;3591.191981804099;3634.7819130852236;3648.8175591220333;1027.7071034755058;1039.864817573718;1039.9480025998669;1052.8420736889452;1059.2532264753331;11523.654290371302;11555.19113662044;11569.826452603218;11604.767904641943;11613;4668.276417155346;4671.5094915034115;4895.412550493892;4901.264810278415;4918.458969513351;9826.16477599412;9826.803463930824;9830.066143716336;9833.754156146153;9860.408375497493;5343.973280133574;5346.037713211659;5355.651882627617;5384.165454354581;5390.703511306916;4407.272799987966;4572.337011133433;4758.381410416693;4880.1215781159735;4908;3927.0575061985487;3978.1645854370904;4043.7775922323967;4072.328065869158;4113.465249517543;1327.5419980106847;1335.365701291898;1343.167236313492;1343.5767733164023;1349.3860293566404;1040.7710303733168;1071.4321409652896;1074.4949873559415;1078.6063086973197;1229.9385030748426;8083.959580202179;8158;8172.387070969582;8183.468074575134;8185.754427367188;1107.2802678259195;1118.7482816366253;1121.2207515776456;1130.4347826086957;1165.3182888010608;6233.563650544418;6369.5541312108635;6386.84032899172;6387.744490220339;6394.264659564116;9597;10670.51982660782;10767.676969690921;10773.192010599236;10790.24468287228;10250.897491024994;10586.57653693859;10649.627263045757;10737.83893241602;10755.83866242007;7977.401694872908;8137.186281371815;8209.38429617781;8212.301954333949;8232.917670823335;7839.216078392344;7949.403794715535;8077.717279895411;8088.676452941816;8098.75703728889;9410;9828.557714902703;9942.15491683215;9994.400335979864;10078.748031299276;10006;10047.346922450017;10246.077852993267;10330.276880618285;10335.793284134124;6410.487161027013;6697.933020669926;6820.283870193558;7043.36609705129;7149.857002860018;8270.627821748156;8318.209770071833;8343.624536895975;8344.499330040217;8359.665613375397;7241.601711905896;7293.0519032525435;7296.087989001375;7460.142083660448;7474.738384156529;7230.710771569078;7418.295261950106;7594.240575942362;7684.731034413769;7825.882611760942;7633.6564854580565;7713.537187768752;7730;7762.961185194038;7772.145064043064;6804.727810887509;7038.648067596702;7108.466864985044;7115.857682846417;7124.893126603209;7144.106986626672;7174.964125179341;7192.352688258082;7214.96392518034;7223.530470519399 13:13:20 INFO - PROCESS | 1671 | |4;prototype.html;280.39854512071605;320.67932067932065;324.4435792615664;328.990130296091;334.5149533176891;5693.202951586781;6001.48987336077;6018.969905150469;6029.4573488386095;6039.6980150992495;5285;5872.5889187756875;5885.8822823543505;5894.88210235795;5936.376680448556;3648.4709717091005;3720.6465385788306;3748.9625103748886;3883.961160388388;4159.209750147477;4100.405441211023;4383.868483945471;4390.934135987963;4390.934135987963;4408.603225709686;4343.978280108595;4358.629516491086;4364.192624364487;4370.934435983463;4384.5834645708765;3909.8270518844515;3923.5487918889407;4252.617264446215;4373.169097871426;4378.824847006116;2893.985530072336;3755.7746535207975;3769.1707824278888;3777.7922214278206;3818.369968955119;4811.542903424169;5583.728447737484;5663.32040155184;5687.4881260686325;5692.0323544997445;4439.578240067189;4680.251159814447;4983.651144419892;5011.398632164163;5033.395992480926;5817.243758311435;6140.3552626974415;6144.38556144382;6157.261128664589;6159.969200153971;3252.975312776468;3772.585015648304;4092.1815636872743;4134.834606615732;4155.376693495969;5271.393789714193;5319.734013299359;5328.49379308965;6292.370762923717;6436.292007879129;3872.373603086654;3883.417487376916;3952.525696916331;4195.517515485697;4212.11470142953;3462.9091836071557;4260.892168036333;4266.786660666954;4291.935620965688;4299.012186530332;4736.194846876039;4983.950160498349;4985.975070124626;5015.724135172528;5039.546440820343;6206.317305096436;6225.346338634468;6244.781432649836;6247.500199983991;6247.718852651642;1434.3115304653616;1465.8607432293916;1466.0910235653962;1468.4713503138862;1469.3608280397848;917.9311551633521;953.575658831827;967.1923943507251;967.7145242153582;968.6464440479315;4793.18515852299;5782.768689252467;5785.1611516329895;5789.015867302569;5806;5382;6066.666333351708;6435.292117867031;6435.581687190318;6449.258335291502;4764.809407623726;4857.80568777252;5766.913496297559;5778.942210577925;5785.334686511105;3291.9506207406907;3353.564036675217;3382.5771778527683;3387.966120338765;3414.9487757683655;5765.463196193661;5828.737706803204;5850.736716847752;6608.768693095719;6662.400383965466;6547.574407663486;6552.541322107502;6556.311587283267;6559.8360040998405;6584.6378449184795;5428.782848686087;6229.813105606839;6502.7724029659685;6606.372394622503;6773.864522709617;5293.232481290268;6464.159659244457;6496.480281577368;6504.642244676588;6525.575837570543;5704.600677952503;6198.194234749454;6373.235211774617;6392.9041064385;6409.647469389229;6068.4538391544975;6121.8680237522785;6699.866002680016;6705.564138330993;6734.494912881455;3204.9839750801098;4192.161567686414;4198.664106871504;4199.349100889367;4220.391565211822;5475.288212532345;6215.502759779297;6229.595076320024;6448.935510644834;6498.285188629342;6223.172748759571;6240.843978900564;6258.280297765815;6276.497880169484;6294.244690637152;4946.579540738933;5256.843494431219;5858.062709966385;5939.316978547522;6287.717052732546;5050.823221187241;5992.340842507234;6116.418940200674;6125.969370153299;6137.649717062239;5432.049391356418;5458.2904222450825;5630.5372196099925;5939.168516407793;6301.558890877778;5125.974370128126;6113.17472141273;6165.300819508259;6188.412100850412;6231 13:13:20 INFO - PROCESS | 1671 | |5;yui.html;662.2681936460211;669.2170160911733;740.5311772559645;754.8414832885094;755.176857225624;14594.343254553543;14667.92666036671;15034.77447838282;15087.622809429757;15920.681586368266;14426.927865360658;14532.636684082876;14544.709105817878;14549.345279462423;14559.708805823877;727.3526561360394;749.5764892835558;895.726803324984;916.1937495004387;917.4082716647791;872.8908886389202;899.928005759541;909.417972497602;911.225458360395;913.2830727878617;950.3015283766426;955.4362925873733;960.1118964957421;961.8172547216042;962.6919385796548;758.0070108158275;924.1082355526881;950.5674917912368;950.971470855872;953.5661274120293;714.760555214004;718.1525799556521;718.2314923032358;718.7448455798169;720.398467279822;15168.544943651708;15255.466058688004;15265.007774494734;15302.311395987208;15314.310856011394;12412.317322547256;12532.561360352343;12630.74738505234;12668.176568523017;12869.549565765246;9250.676226332045;9820.96879827622;9834.901650983471;10226.948865255627;10255.846162307571;3460.8615655373756;3516.7010804081683;3522.084258092889;3568.3933731265747;3778.565464971536;88805.66791498133;90540.54729726375;91511.1366647504;92622.53688731648;92717;9547.093026162504;9657.565409556586;9693.369930954465;9695.951520242495;9952.601895924226;21863.234786782385;22012.779872201394;22023.449413764785;22046.228382006553;22050;7574.469787114959;7644.235576442311;7667.156612772591;7674.8081297968;7692.730754423568;4081.8163182656854;4161.687873409446;4196.097838964576;4215.473065866767;4292.163028209469;3517.8416971235843;3628.0748409155494;3629.637036296402;3631.291898079902;3633.091727068233;622.439804176236;631.43171145969;634.4068296143121;638.2086213095728;638.9009703495966;518.098508595042;552.5137878666748;580.3818932836516;584.9941500585024;589.4757734388551;7805.492642978302;7967.681292748341;8019.117897031322;8044.557549334726;8201.671933122609;520.5445235419008;542.1704791668753;547.9889603681202;589.3634874335708;591.6509259536808;3769.4722738816586;3860.1700634363747;3863.285292220948;3870.4000879863665;4074.3888416737727;90596.54701726449;93800;94304;94354.58468122984;95883.52058239664;78420.60789696015;79280;79983;80217;80340.19659803444;71164.28835711577;71672;71684;72379;72796.81609551722;7520.345523984714;7578.810529736801;7753.379729621504;7755.379569634529;7999.360051196007;44384.77807610941;45296;45474;45795;46551;63695;64976;64979.67510162608;65107.34892651013;65445.345546543926;9997.750056248651;10232;10364.637237696645;10409.323393979366;10466.68599942003;10827.729306767395;10835.620753273597;10865.674029779118;10899.291546049799;11108.666739997812;10108.292419530562;10277.383356998604;10340.689779306633;10547.841782373423;10580.994805493467;10118.544665490217;10399.32404393712;10575.312604680672;10592;11310.94344528272;9443.197328227177;9888.604455821975;10005.84932732745;10909.236353455182;10917.672469825919;8587.455278832156;8786.912130878609;8793.692220772242;8870.911290887267;9117.133872282122;8507.064222935349;8685.174908383693;8692.695755648521;8839.337049721167;8945.37382383227 13:13:20 INFO - PROCESS | 1671 | __end_tp_report 13:13:20 INFO - PROCESS | 1671 | __start_cc_report 13:13:20 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1348 13:13:20 INFO - PROCESS | 1671 | __end_cc_report 13:13:20 INFO - PROCESS | 1671 | __startTimestamp1460146400724__endTimestamp 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | ------- Summary: start ------- 13:13:20 INFO - PROCESS | 1671 | Number of tests: 6 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5706.13 Median:5907.97 stddev:624.34 (10.6%) stddev-sans-first:594.14 13:13:20 INFO - PROCESS | 1671 | Values: 3186.6 3409.9 3445.6 3449.6 3491.4 5599.1 5615.4 5644.9 5652.9 5687.5 5591.1 5691.9 5720.9 5771.9 5772.6 5119.5 5163.8 5188.4 5194.0 5278.0 5287.3 5295.5 5336.1 5338.8 5370.7 5137.3 5177.2 5230.8 5255.9 5296.7 5238.0 5242.0 5251.3 5256.2 5279.7 5188.9 5202.5 5221.4 5254.2 5257.2 5459.1 5576.6 5583.3 5587.2 5711.6 6196.9 6224.6 6229.5 6248.2 6254.5 6229.7 6297.1 6297.1 6309.1 6340.4 5672.0 5731.5 5785.5 5790.9 5851.7 6273.6 6294.9 6300.0 6302.1 6304.7 5914.9 5925.6 5977.9 6010.0 6020.5 6131.7 6165.8 6177.3 6269.3 6284.0 5083.8 6016.1 6193.7 6195.1 6203.4 6226.8 6227.3 6229.3 6239.2 6240.4 4853.8 4888.0 4895.7 4931.6 4979.1 4429.9 4437.6 4451.3 4459.7 4492.2 5623.4 5656.5 5684.8 5694.7 5697.1 6130.1 6167.2 6277.9 6291.3 6292.7 5660.5 5665.3 5700.7 5706.6 5710.9 5259.9 5372.5 5378.2 5381.6 5388.8 6224.7 6274.2 6277.6 6280.7 6291.8 6239.5 6254.8 6257.5 6261.1 6276.2 6196.1 6235.0 6240.4 6255.2 6284.7 6117.0 6160.1 6177.8 6184.9 6185.1 5650.4 5870.8 6074.0 6227.5 6238.3 5039.5 5914.2 5940.4 6056.4 6069.8 6052.3 6062.3 6082.7 6087.4 6127.3 5904.4 5908.0 5919.7 5922.1 5927.4 5866.4 6008.8 6059.6 6075.1 6081.6 4938.8 5935.8 5936.6 5949.3 5973.9 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:60205.05 Median:38113.91 stddev:121411.80 (318.5%) stddev-sans-first:121669.65 13:13:20 INFO - PROCESS | 1671 | Values: 502.4 529.5 578.4 580.6 587.5 29204.7 37313.8 38411.0 38511.2 38520.2 42874.4 43579.0 43624.1 43820.6 43847.3 9533.3 9682.6 9689.5 9693.8 9721.2 9558.9 9707.3 9722.4 9727.4 9742.3 9677.4 9729.6 9747.7 9768.9 9772.8 9668.7 9732.4 9735.6 9749.8 9758.2 9555.6 9664.5 9665.6 9673.0 9681.8 39831.0 40275.8 40395.8 40423.0 40504.6 3122.3 3143.5 3209.7 3292.3 3630.7 28122.2 28433.1 29115.4 29118.4 29230.6 2630.1 2702.3 2754.2 2758.9 2776.8 377496.0 386601.1 386652.0 386867.0 387185.1 65893.7 65966.8 66693.7 66704.0 66765.3 70768.0 71232.0 71689.0 71851.0 71953.0 16664.1 16855.0 16903.9 16919.4 16919.6 12402.0 12482.1 12496.4 12509.9 12510.0 20059.7 20127.9 20424.9 20577.4 20632.0 7388.3 8553.6 8638.1 8646.2 8654.3 916.6 977.5 999.0 1061.5 1099.5 23099.7 28514.4 28568.4 29381.0 29969.0 1061.7 1096.6 1103.9 1131.2 1168.3 14944.5 14994.9 15471.3 15511.5 15570.7 584867.0 589676.0 595496.0 595848.0 596685.0 58908.7 59565.7 59658.0 59832.1 59903.8 1227.2 1350.7 1356.2 1432.7 1476.3 25882.5 26690.7 30056.7 30806.2 31564.5 52213.7 54175.7 54401.5 54455.0 54482.7 347840.0 353371.0 354521.0 354986.0 356673.0 34770.3 40740.0 41867.6 42669.6 42772.0 41743.6 42605.0 43533.3 44129.8 45457.5 35900.0 36949.8 37077.0 37282.0 37816.8 29931.7 31013.0 35016.2 36498.6 36652.0 36664.8 36756.3 37028.3 37655.6 37763.6 27729.7 31676.2 31992.8 32049.8 32186.7 23364.4 23906.6 24064.9 24257.3 24344.4 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34905.76 Median:12360.16 stddev:101165.28 (818.5%) stddev-sans-first:101415.85 13:13:20 INFO - PROCESS | 1671 | Values: 371.7 389.9 395.7 398.1 403.2 19583.0 20902.8 21113.9 21189.9 21205.9 20099.9 20380.0 20802.6 20931.4 21143.0 5226.0 5796.6 6000.0 6000.0 6033.5 4219.7 4468.6 4470.6 4474.9 4484.5 4459.9 5485.9 5641.4 6511.8 6516.9 6394.9 6442.9 6524.9 6559.7 6566.8 5487.2 5656.5 5671.4 5673.2 5679.3 19779.0 22394.9 25691.8 26040.7 26138.9 2325.4 2336.0 2418.7 2528.8 2530.4 14013.5 14685.4 15031.1 15131.9 15543.3 1708.8 1710.5 1773.7 1780.1 1945.0 89225.0 111057.0 116265.0 120812.0 123537.4 9562.1 11658.2 11704.5 11844.0 11866.3 15191.2 15277.7 15287.6 15311.6 15329.5 8544.1 8704.7 8723.8 8819.6 8845.3 7102.8 8586.3 8589.4 8602.5 8721.8 3817.8 4615.4 4660.1 4813.9 4829.0 1824.6 1872.4 1897.0 1953.7 1995.3 757.3 885.8 1034.3 1053.6 1055.7 19182.8 19966.3 20723.2 20824.9 20836.5 913.9 914.2 929.3 941.6 950.8 8478.5 8485.0 10845.0 11119.9 11184.9 506901.5 614282.9 632183.8 635576.0 638461.0 120109.4 126435.0 129360.0 130044.0 134202.0 1024.2 1027.0 1051.3 1100.5 1105.6 18056.3 18378.2 18453.7 18582.3 18702.0 47112.0 48474.0 50188.5 50356.5 50806.2 73513.0 73687.6 73968.0 75586.6 76638.2 7938.2 8003.8 8082.7 8195.6 8312.6 10925.2 12547.4 12608.7 12661.8 12667.1 10495.7 10684.4 10688.9 10946.1 11120.4 10378.0 10474.7 10630.8 10704.9 11030.4 10833.6 11019.1 11064.9 11146.0 11253.4 8083.6 8155.0 8237.3 8348.2 8396.2 10213.7 10913.8 10938.9 11006.4 11164.5 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:6033.45 Median:5273.28 stddev:3189.09 (60.5%) stddev-sans-first:3179.10 13:13:20 INFO - PROCESS | 1671 | Values: 1410.2 1576.7 1609.4 1791.4 1917.8 7890.2 8571.0 8840.1 8842.2 8857.0 8474.1 8679.8 8699.0 8708.3 8713.5 2044.5 2133.0 2246.7 2257.7 2285.3 2213.9 2422.9 2473.3 2500.9 2501.6 2431.6 2456.4 2469.4 2471.9 2474.0 2263.8 2265.2 2276.8 2298.0 2299.0 2381.6 2384.7 2452.4 2454.2 2459.7 8654.8 8796.7 8810.8 8812.2 8834.6 5202.6 5383.1 5393.0 5394.0 5396.5 3547.6 3574.0 3591.2 3634.8 3648.8 1027.7 1039.9 1039.9 1052.8 1059.3 11523.7 11555.2 11569.8 11604.8 11613.0 4668.3 4671.5 4895.4 4901.3 4918.5 9826.2 9826.8 9830.1 9833.8 9860.4 5344.0 5346.0 5355.7 5384.2 5390.7 4407.3 4572.3 4758.4 4880.1 4908.0 3927.1 3978.2 4043.8 4072.3 4113.5 1327.5 1335.4 1343.2 1343.6 1349.4 1040.8 1071.4 1074.5 1078.6 1229.9 8084.0 8158.0 8172.4 8183.5 8185.8 1107.3 1118.7 1121.2 1130.4 1165.3 6233.6 6369.6 6386.8 6387.7 6394.3 9597.0 10670.5 10767.7 10773.2 10790.2 10250.9 10586.6 10649.6 10737.8 10755.8 7977.4 8137.2 8209.4 8212.3 8232.9 7839.2 7949.4 8077.7 8088.7 8098.8 9410.0 9828.6 9942.2 9994.4 10078.7 10006.0 10047.3 10246.1 10330.3 10335.8 6410.5 6697.9 6820.3 7043.4 7149.9 8270.6 8318.2 8343.6 8344.5 8359.7 7241.6 7293.1 7296.1 7460.1 7474.7 7230.7 7418.3 7594.2 7684.7 7825.9 7633.7 7713.5 7730.0 7763.0 7772.1 6804.7 7038.6 7108.5 7115.9 7124.9 7144.1 7175.0 7192.4 7215.0 7223.5 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4951.47 Median:5675.40 stddev:1574.57 (27.7%) stddev-sans-first:1539.46 13:13:20 INFO - PROCESS | 1671 | Values: 280.4 320.7 324.4 329.0 334.5 5693.2 6001.5 6019.0 6029.5 6039.7 5285.0 5872.6 5885.9 5894.9 5936.4 3648.5 3720.6 3749.0 3884.0 4159.2 4100.4 4383.9 4390.9 4390.9 4408.6 4344.0 4358.6 4364.2 4370.9 4384.6 3909.8 3923.5 4252.6 4373.2 4378.8 2894.0 3755.8 3769.2 3777.8 3818.4 4811.5 5583.7 5663.3 5687.5 5692.0 4439.6 4680.3 4983.7 5011.4 5033.4 5817.2 6140.4 6144.4 6157.3 6160.0 3253.0 3772.6 4092.2 4134.8 4155.4 5271.4 5319.7 5328.5 6292.4 6436.3 3872.4 3883.4 3952.5 4195.5 4212.1 3462.9 4260.9 4266.8 4291.9 4299.0 4736.2 4984.0 4986.0 5015.7 5039.5 6206.3 6225.3 6244.8 6247.5 6247.7 1434.3 1465.9 1466.1 1468.5 1469.4 917.9 953.6 967.2 967.7 968.6 4793.2 5782.8 5785.2 5789.0 5806.0 5382.0 6066.7 6435.3 6435.6 6449.3 4764.8 4857.8 5766.9 5778.9 5785.3 3292.0 3353.6 3382.6 3388.0 3414.9 5765.5 5828.7 5850.7 6608.8 6662.4 6547.6 6552.5 6556.3 6559.8 6584.6 5428.8 6229.8 6502.8 6606.4 6773.9 5293.2 6464.2 6496.5 6504.6 6525.6 5704.6 6198.2 6373.2 6392.9 6409.6 6068.5 6121.9 6699.9 6705.6 6734.5 3205.0 4192.2 4198.7 4199.3 4220.4 5475.3 6215.5 6229.6 6448.9 6498.3 6223.2 6240.8 6258.3 6276.5 6294.2 4946.6 5256.8 5858.1 5939.3 6287.7 5050.8 5992.3 6116.4 6126.0 6137.6 5432.0 5458.3 5630.5 5939.2 6301.6 5126.0 6113.2 6165.3 6188.4 6231.0 13:13:20 INFO - PROCESS | 1671 | 13:13:20 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18372.56 Median:64977.84 stddev:26545.09 (40.9%) stddev-sans-first:26586.25 13:13:20 INFO - PROCESS | 1671 | Values: 662.3 669.2 740.5 754.8 755.2 14594.3 14667.9 15034.8 15087.6 15920.7 14426.9 14532.6 14544.7 14549.3 14559.7 727.4 749.6 895.7 916.2 917.4 872.9 899.9 909.4 911.2 913.3 950.3 955.4 960.1 961.8 962.7 758.0 924.1 950.6 951.0 953.6 714.8 718.2 718.2 718.7 720.4 15168.5 15255.5 15265.0 15302.3 15314.3 12412.3 12532.6 12630.7 12668.2 12869.5 9250.7 9821.0 9834.9 10226.9 10255.8 3460.9 3516.7 3522.1 3568.4 3778.6 88805.7 90540.5 91511.1 92622.5 92717.0 9547.1 9657.6 9693.4 9696.0 9952.6 21863.2 22012.8 22023.4 22046.2 22050.0 7574.5 7644.2 7667.2 7674.8 7692.7 4081.8 4161.7 4196.1 4215.5 4292.2 3517.8 3628.1 3629.6 3631.3 3633.1 622.4 631.4 634.4 638.2 638.9 518.1 552.5 580.4 585.0 589.5 7805.5 7967.7 8019.1 8044.6 8201.7 520.5 542.2 548.0 589.4 591.7 3769.5 3860.2 3863.3 3870.4 4074.4 90596.5 93800.0 94304.0 94354.6 95883.5 78420.6 79280.0 79983.0 80217.0 80340.2 71164.3 71672.0 71684.0 72379.0 72796.8 7520.3 7578.8 7753.4 7755.4 7999.4 44384.8 45296.0 45474.0 45795.0 46551.0 63695.0 64976.0 64979.7 65107.3 65445.3 9997.8 10232.0 10364.6 10409.3 10466.7 10827.7 10835.6 10865.7 10899.3 11108.7 10108.3 10277.4 10340.7 10547.8 10581.0 10118.5 10399.3 10575.3 10592.0 11310.9 9443.2 9888.6 10005.8 10909.2 10917.7 8587.5 8786.9 8793.7 8870.9 9117.1 8507.1 8685.2 8692.7 8839.3 8945.4 13:13:20 INFO - PROCESS | 1671 | -------- Summary: end -------- 13:13:20 INFO - PROCESS | 1671 | 13:13:21 INFO - TEST-INFO | 1671: exit 0 13:13:21 INFO - TEST-OK | dromaeo_css | took 1114691ms 13:13:21 INFO - TEST-START | kraken 13:13:21 INFO - operating with platform_type : mac_ 13:13:21 INFO - Initialising browser for kraken test... 13:13:21 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpPrM1eI/profile http://localhost:49274/getInfo.html) 13:13:23 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 13:13:23 INFO - PROCESS | 1676 | colorDepth:24 13:13:23 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 13:13:23 INFO - PROCESS | 1676 | __metrics 13:13:23 INFO - PROCESS | 1676 | 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" 13:13:23 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:13:24 INFO - TEST-INFO | 1676: exit 0 13:13:24 INFO - Browser initialized. 13:13:24 INFO - Running cycle 1/1 for kraken test... 13:13:24 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpPrM1eI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:36 INFO - PROCESS | 1678 | RSS: Main: 237219840 13:13:36 INFO - PROCESS | 1678 | 13:13:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:39 INFO - PROCESS | 1678 | RSS: Main: 284594176 13:13:39 INFO - PROCESS | 1678 | 13:13:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 13:13:43 INFO - PROCESS | 1678 | RSS: Main: 295514112 13:13:43 INFO - PROCESS | 1678 | 13:13:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 13:13:46 INFO - PROCESS | 1678 | RSS: Main: 280399872 13:13:46 INFO - PROCESS | 1678 | 13:13:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 13:13:49 INFO - PROCESS | 1678 | RSS: Main: 283930624 13:13:49 INFO - PROCESS | 1678 | 13:13:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:52 INFO - PROCESS | 1678 | RSS: Main: 283467776 13:13:52 INFO - PROCESS | 1678 | 13:13:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:55 INFO - PROCESS | 1678 | RSS: Main: 283529216 13:13:55 INFO - PROCESS | 1678 | 13:13:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:58 INFO - PROCESS | 1678 | RSS: Main: 283475968 13:13:58 INFO - PROCESS | 1678 | 13:14:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 13:14:02 INFO - PROCESS | 1678 | RSS: Main: 283803648 13:14:02 INFO - PROCESS | 1678 | 13:14:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:04 INFO - PROCESS | 1678 | RSS: Main: 318275584 13:14:04 INFO - PROCESS | 1678 | 13:14:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:06 INFO - PROCESS | 1678 | RSS: Main: 318660608 13:14:06 INFO - PROCESS | 1678 | 13:14:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:09 INFO - PROCESS | 1678 | RSS: Main: 325083136 13:14:09 INFO - PROCESS | 1678 | 13:14:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:13 INFO - PROCESS | 1678 | RSS: Main: 326471680 13:14:13 INFO - PROCESS | 1678 | 13:14:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:16 INFO - PROCESS | 1678 | RSS: Main: 326574080 13:14:16 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 13:14:18 INFO - PROCESS | 1678 | RSS: Main: 390885376 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | __start_tp_report 13:14:18 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 13:14:18 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 13:14:18 INFO - PROCESS | 1678 | |i|pagename|runs| 13:14:18 INFO - PROCESS | 1678 | |0;ai-astar;115;111;114;112;114;114;119;159;166;112 13:14:18 INFO - PROCESS | 1678 | |1;audio-beat-detection;156;148;180;185;122;141;138;119;160;117 13:14:18 INFO - PROCESS | 1678 | |2;audio-dft;185;187;188;184;185;185;182;181;182;183 13:14:18 INFO - PROCESS | 1678 | |3;audio-fft;79;73;74;114;56;75;74;84;151;56 13:14:18 INFO - PROCESS | 1678 | |4;audio-oscillator;88;95;125;77;78;81;119;79;76;119 13:14:18 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;85;88;86;89;86;88;86;88;84 13:14:18 INFO - PROCESS | 1678 | |6;imaging-darkroom;93;94;94;94;93;94;93;94;94;93 13:14:18 INFO - PROCESS | 1678 | |7;imaging-desaturate;88;87;85;87;87;85;86;87;87;85 13:14:18 INFO - PROCESS | 1678 | |8;json-parse-financial;57;53;53;53;53;52;55;65;55;53 13:14:18 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;67;63;71;79;69;71;67;69;70;67 13:14:18 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;85;86;85;86;85;84;85;84;83;86 13:14:18 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;146;143;143;142;139;151;149;148;142;143 13:14:18 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;214;221;152;213;202;166;167;173;168;170 13:14:18 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;70;72;63;58;71;91;94;96;94;69 13:14:18 INFO - PROCESS | 1678 | __end_tp_report 13:14:18 INFO - PROCESS | 1678 | __start_cc_report 13:14:18 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1279 13:14:18 INFO - PROCESS | 1678 | __end_cc_report 13:14:18 INFO - PROCESS | 1678 | __startTimestamp1460146458721__endTimestamp 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | ------- Summary: start ------- 13:14:18 INFO - PROCESS | 1678 | Number of tests: 14 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:123.60 Median:114.50 stddev:20.68 (18.1%) stddev-sans-first:21.70 13:14:18 INFO - PROCESS | 1678 | Values: 115.0 111.0 114.0 112.0 114.0 114.0 119.0 159.0 166.0 112.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:152.00 stddev:24.06 (15.8%) stddev-sans-first:25.27 13:14:18 INFO - PROCESS | 1678 | Values: 156.0 148.0 180.0 185.0 122.0 141.0 138.0 119.0 160.0 117.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:2.25 (1.2%) stddev-sans-first:2.37 13:14:18 INFO - PROCESS | 1678 | Values: 185.0 187.0 188.0 184.0 185.0 185.0 182.0 181.0 182.0 183.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:28.64 (38.7%) stddev-sans-first:30.33 13:14:18 INFO - PROCESS | 1678 | Values: 79.0 73.0 74.0 114.0 56.0 75.0 74.0 84.0 151.0 56.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:78.50 stddev:19.75 (25.2%) stddev-sans-first:20.84 13:14:18 INFO - PROCESS | 1678 | Values: 88.0 95.0 125.0 77.0 78.0 81.0 119.0 79.0 76.0 119.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:1.62 (1.8%) stddev-sans-first:1.66 13:14:18 INFO - PROCESS | 1678 | Values: 88.0 85.0 88.0 86.0 89.0 86.0 88.0 86.0 88.0 84.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:14:18 INFO - PROCESS | 1678 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 93.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.07 (1.2%) stddev-sans-first:0.97 13:14:18 INFO - PROCESS | 1678 | Values: 88.0 87.0 85.0 87.0 87.0 85.0 86.0 87.0 87.0 85.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:3.84 (7.1%) stddev-sans-first:4.00 13:14:18 INFO - PROCESS | 1678 | Values: 57.0 53.0 53.0 53.0 53.0 52.0 55.0 65.0 55.0 53.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:4.16 (6.0%) stddev-sans-first:4.33 13:14:18 INFO - PROCESS | 1678 | Values: 67.0 63.0 71.0 79.0 69.0 71.0 67.0 69.0 70.0 67.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 13:14:18 INFO - PROCESS | 1678 | Values: 85.0 86.0 85.0 86.0 85.0 84.0 85.0 84.0 83.0 86.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:144.50 stddev:3.75 (2.6%) stddev-sans-first:3.94 13:14:18 INFO - PROCESS | 1678 | Values: 146.0 143.0 143.0 142.0 139.0 151.0 149.0 148.0 142.0 143.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:187.50 stddev:25.03 (13.4%) stddev-sans-first:24.19 13:14:18 INFO - PROCESS | 1678 | Values: 214.0 221.0 152.0 213.0 202.0 166.0 167.0 173.0 168.0 170.0 13:14:18 INFO - PROCESS | 1678 | 13:14:18 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:81.50 stddev:14.37 (17.6%) stddev-sans-first:14.97 13:14:18 INFO - PROCESS | 1678 | Values: 70.0 72.0 63.0 58.0 71.0 91.0 94.0 96.0 94.0 69.0 13:14:18 INFO - PROCESS | 1678 | -------- Summary: end -------- 13:14:18 INFO - PROCESS | 1678 | 13:14:19 INFO - TEST-INFO | 1678: exit 0 13:14:19 INFO - TEST-OK | kraken | took 57979ms 13:14:19 INFO - SUITE-END | took 1172s 13:14:19 INFO - Completed test suite (00:19:33) 13:14:19 INFO - javascript benchmark 13:14:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.617605887293, 3409.863605455782, 3445.55207822983, 3449.5688038995127, 3491.3715531204375, 5599.1041433370665, 5615.354234263056, 5644.887102257958, 5652.858678533039, 5687.459691329317, 5591.077472217079, 5691.8577035574135, 5720.856978575538, 5771.942280577193, 5772.624779389347, 5119.462456442076, 5163.767630456619, 5188.42927278001, 5193.974030129844, 5278.049951008817, 5287.312649355597, 5295.523402893738, 5336.092864213093, 5338.839834804962, 5370.7046112463795, 5137.3064636274, 5177.171652535576, 5230.790768369298, 5255.947440525584, 5296.655717378358, 5238.030964271622, 5242.030224408459, 5251.317328747276, 5256.1852912798195, 5279.683219006872, 5188.870278243074, 5202.4537423570355, 5221.373435187764, 5254.238135470336, 5257.158854583248, 5459.071957767189, 5576.581756368248, 5583.3300003999375, 5587.245721827582, 5711.628744131618, 6196.938030619726, 6224.564280500367, 6229.4704950079295, 6248.218972628421, 6254.530910181755, 6229.6573688447115, 6297.055441683784, 6297.118403423525, 6309.148264984215, 6340.3659634036685, 5672.0, 5731.484166425042, 5785.508231800302, 5790.942090579082, 5851.736671849777, 6273.560850740496, 6294.937050629526, 6300.0, 6302.149209856702, 6304.716287767062, 5914.940850591525, 5925.585209035412, 5977.910331345033, 6009.969950150309, 6020.458158765732, 6131.651934473353, 6165.784197553064, 6177.289611694712, 6269.310375858652, 6284.025975973731, 5083.830718934666, 6016.127661489059, 6193.721282542297, 6195.132681424604, 6203.379662033761, 6226.813195604139, 6227.252729672468, 6229.345918678564, 6239.1577137085915, 6240.438360547572, 4853.781579828917, 4887.997960418105, 4895.681780684244, 4931.630127740434, 4979.128652485873, 4429.889252768642, 4437.5784300491405, 4451.287793952952, 4459.665525085632, 4492.236319825637, 5623.437656234344, 5656.547476201977, 5684.8294551163535, 5694.658320500783, 5697.116946873241, 6130.092410195624, 6167.198264225622, 6277.874442511215, 6291.276503202099, 6292.685365731695, 5660.490555849993, 5665.348484924287, 5700.714964251853, 5706.572007099484, 5710.885782284331, 5259.894802103937, 5372.462753724596, 5378.2470454136455, 5381.569474442035, 5388.838334849961, 6224.688765561795, 6274.1843560336865, 6277.5605707600025, 6280.685965701605, 6291.811245662638, 6239.4696450800375, 6254.843628909313, 6257.499400047895, 6261.092141639346, 6276.184096067482, 6196.132541444112, 6234.9688251558455, 6240.375962403723, 6255.155554000152, 6284.717187726655, 6117.021276595723, 6160.075988601567, 6177.752889884354, 6184.938150618436, 6185.103160041679, 5650.378458369658, 5870.8258348329655, 6073.969630151821, 6227.50179985591, 6238.344973777688, 5039.470855560114, 5914.172015917861, 5940.376260492586, 6056.424639659225, 6069.848253793514, 6052.303985041601, 6062.272527296753, 6082.665453400105, 6087.391260873877, 6127.325994140552, 5904.3800400959, 5907.9704601476715, 5919.704014799329, 5922.082077278029, 5927.377625349449, 5866.442687944638, 6008.759649613967, 6059.575829691879, 6075.1191077294425, 6081.5742897996715, 4938.75306234694, 5935.792247271324, 5936.643801371932, 5949.345571986992, 5973.850653733692], "value": 5667.801750757201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.427232954432, 529.5340100711373, 578.4042436290622, 580.5877826743011, 587.4742105815295, 29204.707952920464, 37313.813430932874, 38411.0, 38511.22977540448, 38520.22959540808, 42874.35688464675, 43579.0, 43624.12751744963, 43820.56179438205, 43847.34228986568, 9533.285003624738, 9682.612695492171, 9689.467079310634, 9693.757656058584, 9721.173700235453, 9558.856617150748, 9707.320487565874, 9722.368046077017, 9727.416355018722, 9742.269329800294, 9677.419354838697, 9729.56216970238, 9747.707568772912, 9768.853467197998, 9772.755681107994, 9668.661596844111, 9732.41605503672, 9735.56189971453, 9749.756256093584, 9758.219342452587, 9555.61777528898, 9664.468454235015, 9665.613375464973, 9673.0, 9681.757956051084, 39831.00422489432, 40275.798621007, 40395.79802101, 40423.0, 40504.59495405038, 3122.3443076953868, 3143.512755522898, 3209.7111259986714, 3292.259241670629, 3630.6550877666577, 28122.156335309974, 28433.147005589864, 29115.41769164605, 29118.417631647248, 29230.56154157689, 2630.053180854891, 2702.297402675299, 2754.187514683173, 2758.903438379667, 2776.819506732076, 377496.0, 386601.06699466606, 386652.0, 386867.0, 387185.12814872054, 65893.670531648, 65966.75415573054, 66693.66369699329, 66703.99944000844, 66765.33234667592, 70768.0, 71232.0, 71689.0, 71851.0, 71953.0, 16664.083475408726, 16855.0, 16903.915480422518, 16919.40782072646, 16919.577010574834, 12402.0, 12482.063845211645, 12496.375181240901, 12509.874901251053, 12510.0, 20059.699104513445, 20127.899360503103, 20424.876631785395, 20577.38267851967, 20632.0, 7388.298111679489, 8553.572321383906, 8638.13618638131, 8646.178613031752, 8654.307655387554, 916.5508900638772, 977.5210147028047, 998.9500524973722, 1061.506399524225, 1099.4887377369562, 23099.653505197435, 28514.429711405657, 28568.428631427254, 29380.971665991587, 29969.0, 1061.6708820265742, 1096.6490722968574, 1103.862017247844, 1131.2477202660139, 1168.3457263932225, 14944.476943306932, 14994.925025374803, 15471.303791329417, 15511.5346539604, 15570.688586228212, 584867.0, 589676.0, 595496.0, 595848.0, 596685.0331496629, 58908.7054564733, 59565.70217148887, 59658.0, 59832.102518462256, 59903.80192396128, 1227.1655274413486, 1350.6960933790015, 1356.1727346318935, 1432.6776475292975, 1476.3135142158947, 25882.482350353264, 26690.733092668826, 30056.69943300539, 30806.228820717435, 31564.526532101576, 52213.73893130662, 54175.72912135414, 54401.455985439636, 54455.0, 54482.72758636181, 347840.0, 353371.0, 354521.0, 354986.0, 356673.0, 34770.304593908484, 40740.0, 41867.581324186365, 42669.573304267804, 42772.0, 41743.58256417397, 42605.0, 43533.3469997944, 44129.77935110304, 45457.54542454533, 35900.0, 36949.81525092357, 37077.0, 37281.97493489754, 37816.81091594634, 29931.70068299289, 31013.0, 35016.249187541034, 36498.635013649524, 36652.0, 36664.816675917515, 36756.264874702894, 37028.25943481169, 37655.62344376631, 37763.62236377601, 27729.660162092692, 31676.208094797814, 31992.840035799672, 32049.83352164297, 32186.678133219306, 23364.415889602897, 23906.64140037866, 24064.87967560151, 24257.331693514054, 24344.391390215387], "value": 19708.13479289124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.6562179983518, 389.94735710679066, 395.7427672013191, 398.09234944326926, 403.21373322022043, 19583.0, 20902.790972090275, 21113.894430527827, 21189.894050529765, 21205.893970530145, 20099.899500502514, 20380.0, 20802.583948321062, 20931.37205883822, 21143.04856281467, 5225.973870130644, 5796.623219490741, 5999.970000149993, 6000.039993601024, 6033.456988871001, 4219.746815191098, 4468.575485328888, 4470.597646211841, 4474.865754027368, 4484.506704262529, 4459.866204013885, 5485.930243602499, 5641.351244606861, 6511.837204069912, 6516.902246466307, 6394.872102557946, 6442.903356449657, 6524.902126468107, 6559.672016399209, 6566.835829104287, 5487.176923461513, 5656.462636049569, 5671.432856714337, 5673.177389278531, 5679.318481782171, 19779.0, 22394.888025559932, 25691.84386702603, 26040.739592604023, 26138.86930565354, 2325.430269583946, 2335.988320058389, 2418.718079417911, 2528.810339224547, 2530.3800568860747, 14013.5095271665, 14685.412583496647, 15031.098134111988, 15131.940764146515, 15543.300551475098, 1708.7607734917121, 1710.529604358799, 1773.6786094359784, 1780.1455301455374, 1944.9983258621821, 89225.0, 111057.0, 116265.0, 120812.0, 123537.38231308966, 9562.091601297865, 11658.242214256046, 11704.47329870158, 11844.0, 11866.34735089561, 15191.240437978056, 15277.694446111016, 15287.61780955485, 15311.61720956985, 15329.540113796604, 8544.102869198645, 8704.738857834274, 8723.781905452288, 8819.603117859711, 8845.292376609856, 7102.786916392516, 8586.31309495239, 8589.398742087993, 8602.483386672377, 8721.825563488695, 3817.84728610858, 4615.353850460871, 4660.067986402733, 4813.927791083137, 4828.975855120702, 1824.6315263552335, 1872.4008317338594, 1896.952576185579, 1953.687410014391, 1995.2517805822818, 757.3184134279082, 885.7519894429441, 1034.2915103154364, 1053.641761800976, 1055.6516349604613, 19182.808171918383, 19966.30117945865, 20723.171073157206, 20824.895875520524, 20836.47908802292, 913.881195444588, 914.1863741270275, 929.256594724218, 941.6045260990263, 950.7670620697835, 8478.533680647624, 8484.957575212084, 10845.023947844731, 11119.944400277947, 11184.888151118384, 506901.4654926775, 614282.9285853542, 632183.8390808017, 635576.0, 638461.0, 120109.39945300217, 126435.0, 129360.0, 130044.0, 134202.0, 1024.1806554756165, 1026.97432564185, 1051.2851261142343, 1100.5102729285552, 1105.618561596248, 18056.277748889897, 18378.1729822161, 18453.723194152368, 18582.256709732, 18702.0, 47112.0, 48474.0, 50188.49811501838, 50356.49643503518, 50806.23790643217, 73513.0, 73687.631561844, 73968.0, 75586.62206688931, 76638.2336176631, 7938.206179382247, 8003.838963479711, 8082.7171049013, 8195.631196596287, 8312.584370781558, 10925.180611454014, 12547.372631368578, 12608.74782504363, 12661.81007284873, 12667.113302068767, 10495.685129446128, 10684.358938463716, 10688.946555267485, 10946.124310055337, 11120.388378639253, 10378.0, 10474.68575942723, 10630.84053739179, 10704.946475267574, 11030.393328367018, 10833.620823271147, 11019.118470522179, 11064.889351106385, 11146.0, 11253.381064041556, 8083.595820208849, 8155.021397432346, 8237.258646721824, 8348.206920342558, 8396.202360775716, 10213.693589192038, 10913.781724365626, 10938.945305273422, 11006.449677515931, 11164.49759760829], "value": 9560.250643625437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.2243765928736, 1576.6925449537341, 1609.364301101065, 1791.4088350844215, 1917.7890432052482, 7890.210978902107, 8570.957145214274, 8840.115988401156, 8842.204201621853, 8856.955715221415, 8474.135690148172, 8679.783005424868, 8699.043105258432, 8708.303335733142, 8713.477191368507, 2044.509317763741, 2132.957340853182, 2246.7303923529157, 2257.6500642400456, 2285.2915596165158, 2213.8671679699187, 2422.9394265143337, 2473.2951108933958, 2500.8874600643016, 2501.5997440409537, 2431.63525471179, 2456.4472993576483, 2469.3579669285937, 2471.864047477388, 2474.0, 2263.796258336741, 2265.207177487874, 2276.7950884420316, 2297.977020229793, 2299.011425087212, 2381.595128828086, 2384.6661467394406, 2452.3869032741813, 2454.1533171055958, 2459.7417271186446, 8654.826903461959, 8796.736097917073, 8810.823783524358, 8812.16284452976, 8834.646614135427, 5202.583793296565, 5383.111786555253, 5393.002294575477, 5393.9730301348245, 5396.487333703292, 3547.5742910850604, 3573.9992802015477, 3591.191981804099, 3634.7819130852236, 3648.8175591220333, 1027.7071034755058, 1039.864817573718, 1039.9480025998669, 1052.8420736889452, 1059.2532264753331, 11523.654290371302, 11555.19113662044, 11569.826452603218, 11604.767904641943, 11613.0, 4668.276417155346, 4671.5094915034115, 4895.412550493892, 4901.264810278415, 4918.458969513351, 9826.16477599412, 9826.803463930824, 9830.066143716336, 9833.754156146153, 9860.408375497493, 5343.973280133574, 5346.037713211659, 5355.651882627617, 5384.165454354581, 5390.703511306916, 4407.272799987966, 4572.337011133433, 4758.381410416693, 4880.1215781159735, 4908.0, 3927.0575061985487, 3978.1645854370904, 4043.7775922323967, 4072.328065869158, 4113.465249517543, 1327.5419980106847, 1335.365701291898, 1343.167236313492, 1343.5767733164023, 1349.3860293566404, 1040.7710303733168, 1071.4321409652896, 1074.4949873559415, 1078.6063086973197, 1229.9385030748426, 8083.959580202179, 8158.0, 8172.387070969582, 8183.468074575134, 8185.754427367188, 1107.2802678259195, 1118.7482816366253, 1121.2207515776456, 1130.4347826086957, 1165.3182888010608, 6233.563650544418, 6369.5541312108635, 6386.84032899172, 6387.744490220339, 6394.264659564116, 9597.0, 10670.51982660782, 10767.676969690921, 10773.192010599236, 10790.24468287228, 10250.897491024994, 10586.57653693859, 10649.627263045757, 10737.83893241602, 10755.83866242007, 7977.401694872908, 8137.186281371815, 8209.38429617781, 8212.301954333949, 8232.917670823335, 7839.216078392344, 7949.403794715535, 8077.717279895411, 8088.676452941816, 8098.75703728889, 9410.0, 9828.557714902703, 9942.15491683215, 9994.400335979864, 10078.748031299276, 10006.0, 10047.346922450017, 10246.077852993267, 10330.276880618285, 10335.793284134124, 6410.487161027013, 6697.933020669926, 6820.283870193558, 7043.36609705129, 7149.857002860018, 8270.627821748156, 8318.209770071833, 8343.624536895975, 8344.499330040217, 8359.665613375397, 7241.601711905896, 7293.0519032525435, 7296.087989001375, 7460.142083660448, 7474.738384156529, 7230.710771569078, 7418.295261950106, 7594.240575942362, 7684.731034413769, 7825.882611760942, 7633.6564854580565, 7713.537187768752, 7730.0, 7762.961185194038, 7772.145064043064, 6804.727810887509, 7038.648067596702, 7108.466864985044, 7115.857682846417, 7124.893126603209, 7144.106986626672, 7174.964125179341, 7192.352688258082, 7214.96392518034, 7223.530470519399], "value": 4896.402258396185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.39854512071605, 320.67932067932065, 324.4435792615664, 328.990130296091, 334.5149533176891, 5693.202951586781, 6001.48987336077, 6018.969905150469, 6029.4573488386095, 6039.6980150992495, 5285.0, 5872.5889187756875, 5885.8822823543505, 5894.88210235795, 5936.376680448556, 3648.4709717091005, 3720.6465385788306, 3748.9625103748886, 3883.961160388388, 4159.209750147477, 4100.405441211023, 4383.868483945471, 4390.934135987963, 4390.934135987963, 4408.603225709686, 4343.978280108595, 4358.629516491086, 4364.192624364487, 4370.934435983463, 4384.5834645708765, 3909.8270518844515, 3923.5487918889407, 4252.617264446215, 4373.169097871426, 4378.824847006116, 2893.985530072336, 3755.7746535207975, 3769.1707824278888, 3777.7922214278206, 3818.369968955119, 4811.542903424169, 5583.728447737484, 5663.32040155184, 5687.4881260686325, 5692.0323544997445, 4439.578240067189, 4680.251159814447, 4983.651144419892, 5011.398632164163, 5033.395992480926, 5817.243758311435, 6140.3552626974415, 6144.38556144382, 6157.261128664589, 6159.969200153971, 3252.975312776468, 3772.585015648304, 4092.1815636872743, 4134.834606615732, 4155.376693495969, 5271.393789714193, 5319.734013299359, 5328.49379308965, 6292.370762923717, 6436.292007879129, 3872.373603086654, 3883.417487376916, 3952.525696916331, 4195.517515485697, 4212.11470142953, 3462.9091836071557, 4260.892168036333, 4266.786660666954, 4291.935620965688, 4299.012186530332, 4736.194846876039, 4983.950160498349, 4985.975070124626, 5015.724135172528, 5039.546440820343, 6206.317305096436, 6225.346338634468, 6244.781432649836, 6247.500199983991, 6247.718852651642, 1434.3115304653616, 1465.8607432293916, 1466.0910235653962, 1468.4713503138862, 1469.3608280397848, 917.9311551633521, 953.575658831827, 967.1923943507251, 967.7145242153582, 968.6464440479315, 4793.18515852299, 5782.768689252467, 5785.1611516329895, 5789.015867302569, 5806.0, 5382.0, 6066.666333351708, 6435.292117867031, 6435.581687190318, 6449.258335291502, 4764.809407623726, 4857.80568777252, 5766.913496297559, 5778.942210577925, 5785.334686511105, 3291.9506207406907, 3353.564036675217, 3382.5771778527683, 3387.966120338765, 3414.9487757683655, 5765.463196193661, 5828.737706803204, 5850.736716847752, 6608.768693095719, 6662.400383965466, 6547.574407663486, 6552.541322107502, 6556.311587283267, 6559.8360040998405, 6584.6378449184795, 5428.782848686087, 6229.813105606839, 6502.7724029659685, 6606.372394622503, 6773.864522709617, 5293.232481290268, 6464.159659244457, 6496.480281577368, 6504.642244676588, 6525.575837570543, 5704.600677952503, 6198.194234749454, 6373.235211774617, 6392.9041064385, 6409.647469389229, 6068.4538391544975, 6121.8680237522785, 6699.866002680016, 6705.564138330993, 6734.494912881455, 3204.9839750801098, 4192.161567686414, 4198.664106871504, 4199.349100889367, 4220.391565211822, 5475.288212532345, 6215.502759779297, 6229.595076320024, 6448.935510644834, 6498.285188629342, 6223.172748759571, 6240.843978900564, 6258.280297765815, 6276.497880169484, 6294.244690637152, 4946.579540738933, 5256.843494431219, 5858.062709966385, 5939.316978547522, 6287.717052732546, 5050.823221187241, 5992.340842507234, 6116.418940200674, 6125.969370153299, 6137.649717062239, 5432.049391356418, 5458.2904222450825, 5630.5372196099925, 5939.168516407793, 6301.558890877778, 5125.974370128126, 6113.17472141273, 6165.300819508259, 6188.412100850412, 6231.0], "value": 4447.813576595616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.2681936460211, 669.2170160911733, 740.5311772559645, 754.8414832885094, 755.176857225624, 14594.343254553543, 14667.92666036671, 15034.77447838282, 15087.622809429757, 15920.681586368266, 14426.927865360658, 14532.636684082876, 14544.709105817878, 14549.345279462423, 14559.708805823877, 727.3526561360394, 749.5764892835558, 895.726803324984, 916.1937495004387, 917.4082716647791, 872.8908886389202, 899.928005759541, 909.417972497602, 911.225458360395, 913.2830727878617, 950.3015283766426, 955.4362925873733, 960.1118964957421, 961.8172547216042, 962.6919385796548, 758.0070108158275, 924.1082355526881, 950.5674917912368, 950.971470855872, 953.5661274120293, 714.760555214004, 718.1525799556521, 718.2314923032358, 718.7448455798169, 720.398467279822, 15168.544943651708, 15255.466058688004, 15265.007774494734, 15302.311395987208, 15314.310856011394, 12412.317322547256, 12532.561360352343, 12630.74738505234, 12668.176568523017, 12869.549565765246, 9250.676226332045, 9820.96879827622, 9834.901650983471, 10226.948865255627, 10255.846162307571, 3460.8615655373756, 3516.7010804081683, 3522.084258092889, 3568.3933731265747, 3778.565464971536, 88805.66791498133, 90540.54729726375, 91511.1366647504, 92622.53688731648, 92717.0, 9547.093026162504, 9657.565409556586, 9693.369930954465, 9695.951520242495, 9952.601895924226, 21863.234786782385, 22012.779872201394, 22023.449413764785, 22046.228382006553, 22050.0, 7574.469787114959, 7644.235576442311, 7667.156612772591, 7674.8081297968, 7692.730754423568, 4081.8163182656854, 4161.687873409446, 4196.097838964576, 4215.473065866767, 4292.163028209469, 3517.8416971235843, 3628.0748409155494, 3629.637036296402, 3631.291898079902, 3633.091727068233, 622.439804176236, 631.43171145969, 634.4068296143121, 638.2086213095728, 638.9009703495966, 518.098508595042, 552.5137878666748, 580.3818932836516, 584.9941500585024, 589.4757734388551, 7805.492642978302, 7967.681292748341, 8019.117897031322, 8044.557549334726, 8201.671933122609, 520.5445235419008, 542.1704791668753, 547.9889603681202, 589.3634874335708, 591.6509259536808, 3769.4722738816586, 3860.1700634363747, 3863.285292220948, 3870.4000879863665, 4074.3888416737727, 90596.54701726449, 93800.0, 94304.0, 94354.58468122984, 95883.52058239664, 78420.60789696015, 79280.0, 79983.0, 80217.0, 80340.19659803444, 71164.28835711577, 71672.0, 71684.0, 72379.0, 72796.81609551722, 7520.345523984714, 7578.810529736801, 7753.379729621504, 7755.379569634529, 7999.360051196007, 44384.77807610941, 45296.0, 45474.0, 45795.0, 46551.0, 63695.0, 64976.0, 64979.67510162608, 65107.34892651013, 65445.345546543926, 9997.750056248651, 10232.0, 10364.637237696645, 10409.323393979366, 10466.68599942003, 10827.729306767395, 10835.620753273597, 10865.674029779118, 10899.291546049799, 11108.666739997812, 10108.292419530562, 10277.383356998604, 10340.689779306633, 10547.841782373423, 10580.994805493467, 10118.544665490217, 10399.32404393712, 10575.312604680672, 10592.0, 11310.94344528272, 9443.197328227177, 9888.604455821975, 10005.84932732745, 10909.236353455182, 10917.672469825919, 8587.455278832156, 8786.912130878609, 8793.692220772242, 8870.911290887267, 9117.133872282122, 8507.064222935349, 8685.174908383693, 8692.695755648521, 8839.337049721167, 8945.37382383227], "value": 6782.290109029221, "unit": "score"}], "name": "dromaeo_css", "value": 7350.692238055044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 114.0, 112.0, 114.0, 114.0, 119.0, 159.0, 166.0, 112.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 148.0, 180.0, 185.0, 122.0, 141.0, 138.0, 119.0, 160.0, 117.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 188.0, 184.0, 185.0, 185.0, 182.0, 181.0, 182.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 74.0, 114.0, 56.0, 75.0, 74.0, 84.0, 151.0, 56.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 95.0, 125.0, 77.0, 78.0, 81.0, 119.0, 79.0, 76.0, 119.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 89.0, 86.0, 88.0, 86.0, 88.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 85.0, 87.0, 87.0, 85.0, 86.0, 87.0, 87.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 53.0, 52.0, 55.0, 65.0, 55.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 71.0, 79.0, 69.0, 71.0, 67.0, 69.0, 70.0, 67.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 85.0, 84.0, 85.0, 84.0, 83.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 143.0, 142.0, 139.0, 151.0, 149.0, 148.0, 142.0, 143.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 221.0, 152.0, 213.0, 202.0, 166.0, 167.0, 173.0, 168.0, 170.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 63.0, 58.0, 71.0, 91.0, 94.0, 96.0, 94.0, 69.0], "value": 77.8, "unit": "score"}], "name": "kraken", "value": 1514.5999999999997, "alertThreshold": 2.0}]} 13:14:19 INFO - Return code: 0 13:14:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:14:20 ERROR - # TBPL SUCCESS # 13:14:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:14:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:14:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:14:20 INFO - 2016-04-08 13:14:20.039 screenresolution[1682:11192] starting screenresolution argv=screenresolution get 13:14:20 INFO - 2016-04-08 13:14:20.042 screenresolution[1682:11192] Display 0: 1600x1200x32@60 13:14:20 INFO - 2016-04-08 13:14:20.048 screenresolution[1683:11195] starting screenresolution argv=screenresolution list 13:14:20 INFO - Available Modes on Display 0 13:14:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:14:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:14:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:14:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:14:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:14:20 INFO - Intel Iris: 13:14:20 INFO - Chipset Model: Intel Iris 13:14:20 INFO - Type: GPU 13:14:20 INFO - Bus: Built-In 13:14:20 INFO - VRAM (Dynamic, Max): 1536 MB 13:14:20 INFO - Vendor: Intel (0x8086) 13:14:20 INFO - Device ID: 0x0a2e 13:14:20 INFO - Revision ID: 0x0009 13:14:20 INFO - Displays: 13:14:20 INFO - Display: 13:14:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:14:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:14:20 INFO - Display Serial Number: 1600x1200 60 13:14:20 INFO - Main Display: Yes 13:14:20 INFO - Mirror: Off 13:14:20 INFO - Online: Yes 13:14:20 INFO - Rotation: Supported 13:14:20 INFO - Return code: 0 13:14:20 INFO - Running post-action listener: _resource_record_post_action 13:14:20 INFO - Running post-run listener: _resource_record_post_run 13:14:21 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 32529920; Write bytes: 694175232; Read time: 323; Write time: 2059 13:14:21 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 387645952; Write bytes: 381859328; Read time: 28542; Write time: 722 13:14:21 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 30748160; Write bytes: 299032576; Read time: 305; Write time: 1303 13:14:21 INFO - Running post-run listener: _upload_blobber_files 13:14:21 INFO - Blob upload gear active. 13:14:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:21 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 13:14:21 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'] 13:14:21 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 13:14:21 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:14:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:22 INFO - (blobuploader) - INFO - Done attempting. 13:14:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:14:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:23 INFO - (blobuploader) - INFO - Done attempting. 13:14:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:23 INFO - Return code: 0 13:14:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbf0cfc8ab37df1b666ae99e4d8981e9e395f01ebcefd84ce357795bbc0a5f2f1b7a8e5837d45976d3269405394f1b2cdb9d712beb504d71aaa2b5e0daec765d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cfdd19e59ad0bc299482b5d6d14d14f7f68e0ea9af6cd80a2f92af7d91dd66ba880bd2b00a20967a8d25edb11d55b543dbea4937b7780c040b7af41705c521b"} 13:14:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:23 INFO - Contents: 13:14:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbf0cfc8ab37df1b666ae99e4d8981e9e395f01ebcefd84ce357795bbc0a5f2f1b7a8e5837d45976d3269405394f1b2cdb9d712beb504d71aaa2b5e0daec765d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cfdd19e59ad0bc299482b5d6d14d14f7f68e0ea9af6cd80a2f92af7d91dd66ba880bd2b00a20967a8d25edb11d55b543dbea4937b7780c040b7af41705c521b"} 13:14:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:23 INFO - Copying logs to upload dir... 13:14:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.210982 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-04-08 13:14:23.589156) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 13:14:23.592255) ========= 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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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/bbf0cfc8ab37df1b666ae99e4d8981e9e395f01ebcefd84ce357795bbc0a5f2f1b7a8e5837d45976d3269405394f1b2cdb9d712beb504d71aaa2b5e0daec765d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cfdd19e59ad0bc299482b5d6d14d14f7f68e0ea9af6cd80a2f92af7d91dd66ba880bd2b00a20967a8d25edb11d55b543dbea4937b7780c040b7af41705c521b"} build_url:https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/EnOEZdy7RgW7rMyRoktnZA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbf0cfc8ab37df1b666ae99e4d8981e9e395f01ebcefd84ce357795bbc0a5f2f1b7a8e5837d45976d3269405394f1b2cdb9d712beb504d71aaa2b5e0daec765d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cfdd19e59ad0bc299482b5d6d14d14f7f68e0ea9af6cd80a2f92af7d91dd66ba880bd2b00a20967a8d25edb11d55b543dbea4937b7780c040b7af41705c521b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 13:14:23.620210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:14:23.620749) ========= 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.dMAuqJx2ab/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.0xvyikWdhw/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005273 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 13:14:23.670624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 13:14:23.670944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 13:14:23.671331) ========= ========= Total master_lag: 3.07 =========