builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0153 starttime: 1454761903.64 results: success (0) buildid: 20160206043137 builduid: 241568452d3d470d95813b212a08c1db revision: f5bd25c789b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.646595) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:43.647014) ========= ========= Started set props: basedir (results: 0, elapsed: 5 secs) (at 2016-02-06 04:31:43.647307) ========= 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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005722 basedir: '/builds/slave/test' ========= master_lag: 5.43 ========= ========= Finished set props: basedir (results: 0, elapsed: 5 secs) (at 2016-02-06 04:31:49.087035) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.087327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.166925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.167240) ========= 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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005401 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.222846) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.223116) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.223447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.223711) ========= 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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-06 04:31:49-- 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% 138M=0s 2016-02-06 04:31:49 (138 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.685305 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.959206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.959481) ========= 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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.019381 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.008751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:50.009114) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5bd25c789b6 --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 f5bd25c789b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-06 04:31:50,077 Setting DEBUG logging. 2016-02-06 04:31:50,077 attempt 1/10 2016-02-06 04:31:50,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5bd25c789b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:31:50,772 unpacking tar archive at: fx-team-f5bd25c789b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.943258 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:51.010751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.011068) ========= echo f5bd25c789b6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f5bd25c789b6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 f5bd25c789b6 program finished with exit code 0 elapsedTime=0.005909 script_repo_revision: 'f5bd25c789b6' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.039065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.039419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:51.058528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-06 04:31:51.058808) ========= /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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:31:51 INFO - MultiFileLogger online at 20160206 04:31:51 in /builds/slave/test 04:31:51 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 04:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:51 INFO - {'append_to_log': False, 04:31:51 INFO - 'base_work_dir': '/builds/slave/test', 04:31:51 INFO - 'blob_upload_branch': 'Fx-Team', 04:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:51 INFO - 'branch': 'Fx-Team', 04:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:51 INFO - 'config_files': ('talos/mac_config.py',), 04:31:51 INFO - 'default_actions': ('clobber', 04:31:51 INFO - 'read-buildbot-config', 04:31:51 INFO - 'download-and-extract', 04:31:51 INFO - 'populate-webroot', 04:31:51 INFO - 'create-virtualenv', 04:31:51 INFO - 'install', 04:31:51 INFO - 'run-tests'), 04:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:51 INFO - 'download_minidump_stackwalk': True, 04:31:51 INFO - 'download_symbols': 'ondemand', 04:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:51 INFO - 'installer_path': 'installer.exe', 04:31:51 INFO - 'log_level': 'info', 04:31:51 INFO - 'log_name': 'talos', 04:31:51 INFO - 'log_to_console': True, 04:31:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:51 INFO - 'opt_config_files': (), 04:31:51 INFO - 'pip_index': False, 04:31:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:51 INFO - 'cmd': ('bash', 04:31:51 INFO - '-c', 04:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:51 INFO - 'enabled': True, 04:31:51 INFO - 'halt_on_failure': False, 04:31:51 INFO - 'name': 'check_screen_resolution'},), 04:31:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:51 INFO - 'cmd': ('bash', 04:31:51 INFO - '-c', 04:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:51 INFO - 'enabled': True, 04:31:51 INFO - 'halt_on_failure': False, 04:31:51 INFO - 'name': 'check_screen_resolution'},), 04:31:51 INFO - 'run_cmd_checks_enabled': True, 04:31:51 INFO - 'sps_profile': False, 04:31:51 INFO - 'sps_profile_interval': 0, 04:31:51 INFO - 'suite': 'dromaeojs', 04:31:51 INFO - 'system_bits': '32', 04:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:51 INFO - 'title': 't-yosemite-r7-0153', 04:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:51 INFO - 'use_talos_json': True, 04:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:51 INFO - 'work_dir': 'build'} 04:31:51 INFO - ##### 04:31:51 INFO - ##### Running clobber step. 04:31:51 INFO - ##### 04:31:51 INFO - Running pre-action listener: _resource_record_pre_action 04:31:51 INFO - Running main action method: clobber 04:31:51 INFO - rmtree: /builds/slave/test/build 04:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:52 INFO - Running post-action listener: _resource_record_post_action 04:31:52 INFO - ##### 04:31:52 INFO - ##### Running read-buildbot-config step. 04:31:52 INFO - ##### 04:31:52 INFO - Running pre-action listener: _resource_record_pre_action 04:31:52 INFO - Running main action method: read_buildbot_config 04:31:52 INFO - Using buildbot properties: 04:31:52 INFO - { 04:31:52 INFO - "project": "", 04:31:52 INFO - "product": "firefox", 04:31:52 INFO - "script_repo_revision": "production", 04:31:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:31:52 INFO - "repository": "", 04:31:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:31:52 INFO - "buildid": "20160206043137", 04:31:52 INFO - "stage_platform": "macosx64", 04:31:52 INFO - "basedir": "/builds/slave/test", 04:31:52 INFO - "buildnumber": 333, 04:31:52 INFO - "platform": "yosemite_r7", 04:31:52 INFO - "mozci_request": { 04:31:52 INFO - "priority": -1, 04:31:52 INFO - "type": "trigger_all_talos_jobs", 04:31:52 INFO - "times": 6 04:31:52 INFO - }, 04:31:52 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:31:52 INFO - "slavebuilddir": "test", 04:31:52 INFO - "branch": "fx-team", 04:31:52 INFO - "revision": "f5bd25c789b6", 04:31:52 INFO - "slavename": "t-yosemite-r7-0153", 04:31:52 INFO - "builduid": "241568452d3d470d95813b212a08c1db", 04:31:52 INFO - "repo_path": "integration/fx-team" 04:31:52 INFO - } 04:31:52 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg. 04:31:52 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json. 04:31:52 INFO - Running post-action listener: _resource_record_post_action 04:31:52 INFO - ##### 04:31:52 INFO - ##### Running download-and-extract step. 04:31:52 INFO - ##### 04:31:52 INFO - Running pre-action listener: _resource_record_pre_action 04:31:52 INFO - Running main action method: download_and_extract 04:31:52 INFO - mkdir: /builds/slave/test/build/tests 04:31:52 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')]} 04:31:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json 04:31:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:53 INFO - Downloaded 1277 bytes. 04:31:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:53 INFO - Using the following test package requirements: 04:31:53 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:31:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'jsshell-mac.zip'], 04:31:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:31:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:31:53 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:31:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:31:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:53 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31: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')]} 04:31:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:53 INFO - Downloaded 17118738 bytes. 04:31:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:31:56 INFO - Return code: 0 04:31:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:59 INFO - Downloaded 17118738 bytes. 04:31:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:32:02 INFO - Return code: 0 04:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip 04:32:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:03 INFO - Downloaded 10706582 bytes. 04:32:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:32:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:32:03 INFO - Return code: 0 04:32: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')]} 04:32:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:32:06 INFO - Downloaded 111115296 bytes. 04:32:06 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:06 INFO - mkdir: /builds/slave/test/properties 04:32:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:06 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:06 INFO - Contents: 04:32:06 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:07 INFO - Running post-action listener: _resource_record_post_action 04:32:07 INFO - Running post-action listener: set_extra_try_arguments 04:32:07 INFO - ##### 04:32:07 INFO - ##### Running populate-webroot step. 04:32:07 INFO - ##### 04:32:07 INFO - Running pre-action listener: _resource_record_pre_action 04:32:07 INFO - Running main action method: populate_webroot 04:32:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:07 INFO - '--tppagecycles', 04:32:07 INFO - '7'], 04:32:07 INFO - 'tests': ['tsvgm']}}, 04:32:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:32:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:32:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'tests': ['damp', 'tps']}, 04:32:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['damp', 'tps']}, 04:32:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:32:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:07 INFO - 'other': {'tests': ['a11yr', 04:32:07 INFO - 'ts_paint', 04:32:07 INFO - 'tpaint', 04:32:07 INFO - 'sessionrestore', 04:32:07 INFO - 'sessionrestore_no_auto_restore']}, 04:32:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['a11yr', 04:32:07 INFO - 'ts_paint', 04:32:07 INFO - 'tpaint', 04:32:07 INFO - 'sessionrestore', 04:32:07 INFO - 'sessionrestore_no_auto_restore']}, 04:32:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['a11yr', 04:32:07 INFO - 'ts_paint', 04:32:07 INFO - 'tpaint', 04:32:07 INFO - 'sessionrestore', 04:32:07 INFO - 'sessionrestore_no_auto_restore']}, 04:32:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['a11yr', 04:32:07 INFO - 'ts_paint', 04:32:07 INFO - 'tpaint', 04:32:07 INFO - 'sessionrestore', 04:32:07 INFO - 'sessionrestore_no_auto_restore']}, 04:32:07 INFO - 'other_l64': {'tests': ['a11yr', 04:32:07 INFO - 'ts_paint', 04:32:07 INFO - 'tpaint', 04:32:07 INFO - 'sessionrestore', 04:32:07 INFO - 'sessionrestore_no_auto_restore']}, 04:32:07 INFO - 'other_nol64': {'tests': ['a11yr', 04:32:07 INFO - 'ts_paint', 04:32:07 INFO - 'tpaint', 04:32:07 INFO - 'sessionrestore', 04:32:07 INFO - 'sessionrestore_no_auto_restore']}, 04:32:07 INFO - 'svgr': {'tests': ['tsvgx', 04:32:07 INFO - 'tsvgr_opacity', 04:32:07 INFO - 'tart', 04:32:07 INFO - 'tscrollx', 04:32:07 INFO - 'cart']}, 04:32:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['tsvgx', 04:32:07 INFO - 'tsvgr_opacity', 04:32:07 INFO - 'tart', 04:32:07 INFO - 'tscrollx', 04:32:07 INFO - 'cart']}, 04:32:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'tests': ['tp5o']}, 04:32:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'talos_options': ['--e10s'], 04:32:07 INFO - 'tests': ['tp5o']}, 04:32:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'talos_options': ['--xperf_path', 04:32:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:07 INFO - 'tests': ['tp5n']}, 04:32:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:07 INFO - 'talos_options': ['--e10s', 04:32:07 INFO - '--xperf_path', 04:32:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:07 INFO - 'tests': ['tp5n']}}, 04:32:07 INFO - 'talos.zip': {'path': '', 04:32:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:07 INFO - Running post-action listener: _resource_record_post_action 04:32:07 INFO - ##### 04:32:07 INFO - ##### Running create-virtualenv step. 04:32:07 INFO - ##### 04:32:07 INFO - Running pre-action listener: _resource_record_pre_action 04:32:07 INFO - Running main action method: create_virtualenv 04:32:07 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:07 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 04:32:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:07 INFO - Using real prefix '/tools/python27' 04:32:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:10 INFO - Installing pip.................done. 04:32:10 INFO - Return code: 0 04:32:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:10 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 04:32:10 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 04:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:10 INFO - 'HOME': '/Users/cltbld', 04:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:10 INFO - 'LOGNAME': 'cltbld', 04:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:10 INFO - 'MOZ_NO_REMOTE': '1', 04:32:10 INFO - 'NO_EM_RESTART': '1', 04:32:10 INFO - 'PAGER': '/bin/cat', 04:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:10 INFO - 'PWD': '/builds/slave/test', 04:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:10 INFO - 'SHELL': '/bin/bash', 04:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:10 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:10 INFO - 'USER': 'cltbld', 04:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:10 INFO - 'XPC_FLAGS': '0x0', 04:32:10 INFO - 'XPC_SERVICE_NAME': '0', 04:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:10 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 04:32:10 INFO - Cleaning up... 04:32:11 INFO - Return code: 0 04:32:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:11 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:11 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 04:32:11 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 04:32:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:11 INFO - 'HOME': '/Users/cltbld', 04:32:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:11 INFO - 'LOGNAME': 'cltbld', 04:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:11 INFO - 'MOZ_NO_REMOTE': '1', 04:32:11 INFO - 'NO_EM_RESTART': '1', 04:32:11 INFO - 'PAGER': '/bin/cat', 04:32:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:11 INFO - 'PWD': '/builds/slave/test', 04:32:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:11 INFO - 'SHELL': '/bin/bash', 04:32:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:11 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:11 INFO - 'USER': 'cltbld', 04:32:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:11 INFO - 'XPC_FLAGS': '0x0', 04:32:11 INFO - 'XPC_SERVICE_NAME': '0', 04:32:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:11 INFO - Downloading/unpacking psutil>=0.7.1 04:32:11 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 04:32:11 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 04:32:11 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 04:32:11 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 04:32:11 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 04:32:11 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 04:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:14 INFO - Installing collected packages: psutil 04:32:14 INFO - Running setup.py install for psutil 04:32:14 INFO - building 'psutil._psutil_osx' extension 04:32:14 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 04:32:14 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 04:32:14 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 04:32:14 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 04:32:14 INFO - building 'psutil._psutil_posix' extension 04:32:14 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 04:32:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:14 INFO - ^ 04:32:14 INFO - 1 warning generated. 04:32:14 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 04:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:14 INFO - Successfully installed psutil 04:32:14 INFO - Cleaning up... 04:32:14 INFO - Return code: 0 04:32:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:14 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 04:32:14 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 04:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:14 INFO - 'HOME': '/Users/cltbld', 04:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:14 INFO - 'LOGNAME': 'cltbld', 04:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:14 INFO - 'MOZ_NO_REMOTE': '1', 04:32:14 INFO - 'NO_EM_RESTART': '1', 04:32:14 INFO - 'PAGER': '/bin/cat', 04:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:14 INFO - 'PWD': '/builds/slave/test', 04:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:14 INFO - 'SHELL': '/bin/bash', 04:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:14 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:14 INFO - 'USER': 'cltbld', 04:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:14 INFO - 'XPC_FLAGS': '0x0', 04:32:14 INFO - 'XPC_SERVICE_NAME': '0', 04:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:32:17 INFO - Installing collected packages: mozsystemmonitor 04:32:17 INFO - Running setup.py install for mozsystemmonitor 04:32:17 INFO - Successfully installed mozsystemmonitor 04:32:17 INFO - Cleaning up... 04:32:17 INFO - Return code: 0 04:32:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:17 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')]} 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:17 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')]} 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:17 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:17 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 04:32:17 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 04:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:17 INFO - 'HOME': '/Users/cltbld', 04:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:17 INFO - 'LOGNAME': 'cltbld', 04:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:17 INFO - 'MOZ_NO_REMOTE': '1', 04:32:17 INFO - 'NO_EM_RESTART': '1', 04:32:17 INFO - 'PAGER': '/bin/cat', 04:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:17 INFO - 'PWD': '/builds/slave/test', 04:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:17 INFO - 'SHELL': '/bin/bash', 04:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:17 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:17 INFO - 'USER': 'cltbld', 04:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:17 INFO - 'XPC_FLAGS': '0x0', 04:32:17 INFO - 'XPC_SERVICE_NAME': '0', 04:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:18 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 04:32:18 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 04:32:18 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 04:32:18 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 04:32:18 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 04:32:18 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 04:32:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:21 INFO - Downloading docopt-0.6.1.tar.gz 04:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:21 INFO - Running setup.py install for blobuploader 04:32:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:21 INFO - Running setup.py install for requests 04:32:22 INFO - Running setup.py install for docopt 04:32:22 INFO - Successfully installed blobuploader requests docopt 04:32:22 INFO - Cleaning up... 04:32:22 INFO - Return code: 0 04:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:22 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:22 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 04:32:22 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 04:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:22 INFO - 'HOME': '/Users/cltbld', 04:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:22 INFO - 'LOGNAME': 'cltbld', 04:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:22 INFO - 'MOZ_NO_REMOTE': '1', 04:32:22 INFO - 'NO_EM_RESTART': '1', 04:32:22 INFO - 'PAGER': '/bin/cat', 04:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:22 INFO - 'PWD': '/builds/slave/test', 04:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:22 INFO - 'SHELL': '/bin/bash', 04:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:22 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:22 INFO - 'USER': 'cltbld', 04:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:22 INFO - 'XPC_FLAGS': '0x0', 04:32:22 INFO - 'XPC_SERVICE_NAME': '0', 04:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:22 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-wa5s4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:22 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-URGVpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:22 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-j1Kevm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AZzXtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-QsDtGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-GoDX8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EBWdQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-m6KnbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fGXbPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4vGOio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_ZclOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-0nU_G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-dwRjIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_NShUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-TFwncr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-4Cgysn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-r5UxxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:24 INFO - Running setup.py install for manifestparser 04:32:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Running setup.py install for mozcrash 04:32:24 INFO - Running setup.py install for mozdebug 04:32:24 INFO - Running setup.py install for mozdevice 04:32:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozfile 04:32:25 INFO - Running setup.py install for mozhttpd 04:32:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozinfo 04:32:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozInstall 04:32:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozleak 04:32:25 INFO - Running setup.py install for mozlog 04:32:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for moznetwork 04:32:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozprocess 04:32:26 INFO - Running setup.py install for mozprofile 04:32:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozrunner 04:32:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozscreenshot 04:32:26 INFO - Running setup.py install for moztest 04:32:26 INFO - Running setup.py install for mozversion 04:32:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:27 INFO - Cleaning up... 04:32:27 INFO - Return code: 0 04:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:27 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')]} 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:27 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')]} 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:27 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:27 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 04:32:27 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 04:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:27 INFO - 'HOME': '/Users/cltbld', 04:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:27 INFO - 'LOGNAME': 'cltbld', 04:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:27 INFO - 'MOZ_NO_REMOTE': '1', 04:32:27 INFO - 'NO_EM_RESTART': '1', 04:32:27 INFO - 'PAGER': '/bin/cat', 04:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:27 INFO - 'PWD': '/builds/slave/test', 04:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:27 INFO - 'SHELL': '/bin/bash', 04:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:27 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:27 INFO - 'USER': 'cltbld', 04:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:27 INFO - 'XPC_FLAGS': '0x0', 04:32:27 INFO - 'XPC_SERVICE_NAME': '0', 04:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Um1mYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-iJ5hRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-W8hDHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-tDly31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VsOvWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-3RsmFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:27 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AFogrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-h9Ah7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-6w70ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7DXKom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-s4poBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fkj9r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-jyjhaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-reu4Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-k6YvsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-wbBIcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:29 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)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fyPP7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:29 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)) 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:31 INFO - Downloading blessings-1.6.tar.gz 04:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:31 INFO - Installing collected packages: blessings 04:32:31 INFO - Running setup.py install for blessings 04:32:31 INFO - Successfully installed blessings 04:32:31 INFO - Cleaning up... 04:32:31 INFO - Return code: 0 04:32:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:32 INFO - Reading from file tmpfile_stdout 04:32:32 INFO - Current package versions: 04:32:32 INFO - blessings == 1.6 04:32:32 INFO - blobuploader == 1.2.4 04:32:32 INFO - docopt == 0.6.1 04:32:32 INFO - manifestparser == 1.1 04:32:32 INFO - mozInstall == 1.12 04:32:32 INFO - mozcrash == 0.16 04:32:32 INFO - mozdebug == 0.1 04:32:32 INFO - mozdevice == 0.48 04:32:32 INFO - mozfile == 1.2 04:32:32 INFO - mozhttpd == 0.7 04:32:32 INFO - mozinfo == 0.9 04:32:32 INFO - mozleak == 0.1 04:32:32 INFO - mozlog == 3.1 04:32:32 INFO - moznetwork == 0.27 04:32:32 INFO - mozprocess == 0.22 04:32:32 INFO - mozprofile == 0.28 04:32:32 INFO - mozrunner == 6.11 04:32:32 INFO - mozscreenshot == 0.1 04:32:32 INFO - mozsystemmonitor == 0.0 04:32:32 INFO - moztest == 0.7 04:32:32 INFO - mozversion == 1.4 04:32:32 INFO - psutil == 3.1.1 04:32:32 INFO - requests == 1.2.3 04:32:32 INFO - wsgiref == 0.1.2 04:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:32 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')]} 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:32 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 04:32:32 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 04:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:32 INFO - 'HOME': '/Users/cltbld', 04:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PAGER': '/bin/cat', 04:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:32 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - 'XPC_FLAGS': '0x0', 04:32:32 INFO - 'XPC_SERVICE_NAME': '0', 04:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 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)) 04:32:32 INFO - Cleaning up... 04:32:32 INFO - Return code: 0 04:32:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:32 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')]} 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:32 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 04:32:32 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 04:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:32 INFO - 'HOME': '/Users/cltbld', 04:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PAGER': '/bin/cat', 04:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:32 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - 'XPC_FLAGS': '0x0', 04:32:32 INFO - 'XPC_SERVICE_NAME': '0', 04:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:32 INFO - Downloading/unpacking jsonschema 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:34 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 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 04:32:34 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 04:32:35 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:35 INFO - warning: no files found matching '*.txt' 04:32:35 INFO - no previously-included directories found matching 'build' 04:32:35 INFO - no previously-included directories found matching 'dist' 04:32:35 INFO - no previously-included directories found matching '.git*' 04:32:35 INFO - Installing collected packages: jsonschema, functools32 04:32:35 INFO - Running setup.py install for functools32 04:32:35 INFO - warning: no files found matching '*.txt' 04:32:35 INFO - no previously-included directories found matching 'build' 04:32:35 INFO - no previously-included directories found matching 'dist' 04:32:35 INFO - no previously-included directories found matching '.git*' 04:32:35 INFO - Successfully installed jsonschema functools32 04:32:35 INFO - Cleaning up... 04:32:35 INFO - Return code: 0 04:32:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:35 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')]} 04:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:35 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')]} 04:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:35 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 0x1091b4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091bb4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3c1485b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, '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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 04:32:35 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 04:32:35 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 04:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:35 INFO - 'HOME': '/Users/cltbld', 04:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:35 INFO - 'LOGNAME': 'cltbld', 04:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:35 INFO - 'MOZ_NO_REMOTE': '1', 04:32:35 INFO - 'NO_EM_RESTART': '1', 04:32:35 INFO - 'PAGER': '/bin/cat', 04:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:35 INFO - 'PWD': '/builds/slave/test', 04:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:35 INFO - 'SHELL': '/bin/bash', 04:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:32:35 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:35 INFO - 'USER': 'cltbld', 04:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:35 INFO - 'XPC_FLAGS': '0x0', 04:32:35 INFO - 'XPC_SERVICE_NAME': '0', 04:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:35 INFO - Downloading/unpacking flake8 04:32:35 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 04:32:35 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 04:32:35 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 04:32:35 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 04:32:35 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 04:32:35 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 04:32:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:39 INFO - no previously-included directories found matching 'docs/_build' 04:32:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:39 INFO - Running setup.py install for pep8 04:32:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:39 INFO - no previously-included directories found matching 'docs/_build' 04:32:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:39 INFO - Cleaning up... 04:32:39 INFO - Return code: 0 04:32:39 INFO - Running post-action listener: _resource_record_post_action 04:32:39 INFO - Running post-action listener: _start_resource_monitoring 04:32:39 INFO - Starting resource monitoring. 04:32:39 INFO - ##### 04:32:39 INFO - ##### Running install step. 04:32:39 INFO - ##### 04:32:39 INFO - Running pre-action listener: _resource_record_pre_action 04:32:39 INFO - Running main action method: install 04:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:40 INFO - Reading from file tmpfile_stdout 04:32:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:40 INFO - Reading from file tmpfile_stdout 04:32:40 INFO - Output received: 04:32:40 INFO - Usage: mozinstall [options] installer 04:32:40 INFO - Options: 04:32:40 INFO - -h, --help show this help message and exit 04:32:40 INFO - -d DEST, --destination=DEST 04:32:40 INFO - Directory to install application into. [default: 04:32:40 INFO - "/builds/slave/test"] 04:32:40 INFO - --app=APP Application being installed. [default: firefox] 04:32:40 INFO - mkdir: /builds/slave/test/build/application 04:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:14 INFO - Reading from file tmpfile_stdout 04:33:14 INFO - Output received: 04:33:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:14 INFO - Running post-action listener: _resource_record_post_action 04:33:14 INFO - ##### 04:33:14 INFO - ##### Running run-tests step. 04:33:14 INFO - ##### 04:33:14 INFO - Running pre-action listener: _resource_record_pre_action 04:33:14 INFO - Running main action method: run_tests 04:33:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:14 INFO - 2016-02-06 04:33:14.800 screenresolution[2644:27669] starting screenresolution argv=screenresolution get 04:33:14 INFO - 2016-02-06 04:33:14.803 screenresolution[2644:27669] Display 0: 1600x1200x32@60 04:33:14 INFO - 2016-02-06 04:33:14.809 screenresolution[2645:27671] starting screenresolution argv=screenresolution list 04:33:14 INFO - Available Modes on Display 0 04:33:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:15 INFO - Intel Iris: 04:33:15 INFO - Chipset Model: Intel Iris 04:33:15 INFO - Type: GPU 04:33:15 INFO - Bus: Built-In 04:33:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:15 INFO - Vendor: Intel (0x8086) 04:33:15 INFO - Device ID: 0x0a2e 04:33:15 INFO - Revision ID: 0x0009 04:33:15 INFO - Displays: 04:33:15 INFO - Display: 04:33:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:15 INFO - Display Serial Number: 1600x1200 60 04:33:15 INFO - Main Display: Yes 04:33:15 INFO - Mirror: Off 04:33:15 INFO - Online: Yes 04:33:15 INFO - Rotation: Supported 04:33:15 INFO - Return code: 0 04:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:15 INFO - Python 2.7.3 04:33:15 INFO - Return code: 0 04:33:15 INFO - grabbing minidump binary from tooltool 04:33:15 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')]} 04:33:15 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 0x109059d30>, '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 0x108e7cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10904fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:15 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 04:33:15 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 04:33:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:15 INFO - Return code: 0 04:33:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:16 INFO - Return code: 0 04:33:16 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 04:33:16 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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 04:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y3hzqy6VsG/Render', 04:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:16 INFO - 'HOME': '/Users/cltbld', 04:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:16 INFO - 'LOGNAME': 'cltbld', 04:33:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:16 INFO - 'MOZ_NO_REMOTE': '1', 04:33:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:16 INFO - 'NO_EM_RESTART': '1', 04:33:16 INFO - 'PAGER': '/bin/cat', 04:33:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:16 INFO - 'PWD': '/builds/slave/test', 04:33:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:16 INFO - 'SHELL': '/bin/bash', 04:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MRwUpOY0eh/Listeners', 04:33:16 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 04:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:16 INFO - 'USER': 'cltbld', 04:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:16 INFO - 'XPC_FLAGS': '0x0', 04:33:16 INFO - 'XPC_SERVICE_NAME': '0', 04:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:16 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 04:33:16 INFO - mozversion application_buildid: 20160203075643 04:33:16 INFO - mozversion application_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:16 INFO - mozversion application_display_name: Nightly 04:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:16 INFO - mozversion application_name: Firefox 04:33:16 INFO - mozversion application_remotingname: firefox 04:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:33:16 INFO - mozversion application_vendor: Mozilla 04:33:16 INFO - mozversion application_version: 47.0a1 04:33:16 INFO - mozversion platform_buildid: 20160203075643 04:33:16 INFO - mozversion platform_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:33:16 INFO - mozversion platform_version: 47.0a1 04:33:16 INFO - using testdate: 1454761996 04:33:16 INFO - actual date: 1454761996 04:33:16 INFO - starting webserver on 'localhost:50557' 04:33:16 INFO - SUITE-START | Running 2 tests 04:33:16 INFO - TEST-START | dromaeo_css 04:33:16 INFO - operating with platform_type : mac_ 04:33:16 INFO - Initialising browser for dromaeo_css test... 04:33:16 INFO - TEST-INFO | started process 2663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpcxS3Zp/profile http://localhost:50557/getInfo.html) 04:33:16 INFO - PROCESS | 2663 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:33:18 INFO - PROCESS | 2663 | __metrics Screen width/height:1600/1200 04:33:18 INFO - PROCESS | 2663 | colorDepth:24 04:33:18 INFO - PROCESS | 2663 | Browser inner width/height: 1024/689 04:33:18 INFO - PROCESS | 2663 | __metrics 04:33:18 INFO - PROCESS | 2663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:18 INFO - PROCESS | 2663 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:19 INFO - TEST-INFO | 2663: exit 0 04:33:19 INFO - Browser initialized. 04:33:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:19 INFO - TEST-INFO | started process 2666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpcxS3Zp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:31 INFO - PROCESS | 2666 | RSS: Main: 242991104 04:33:31 INFO - PROCESS | 2666 | 04:34:22 INFO - PROCESS | 2666 | 1454762062586 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] 04:36:33 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50557/tests/dromaeo/cssquery-ext.html) 04:36:34 INFO - PROCESS | 2666 | RSS: Main: 366706688 04:36:34 INFO - PROCESS | 2666 | 04:39:37 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-ext.html (next: http://localhost:50557/tests/dromaeo/cssquery-jquery.html) 04:39:37 INFO - PROCESS | 2666 | RSS: Main: 371634176 04:39:37 INFO - PROCESS | 2666 | 04:42:39 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50557/tests/dromaeo/cssquery-mootools.html) 04:42:40 INFO - PROCESS | 2666 | RSS: Main: 373944320 04:42:40 INFO - PROCESS | 2666 | 04:45:42 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50557/tests/dromaeo/cssquery-prototype.html) 04:45:43 INFO - PROCESS | 2666 | RSS: Main: 337575936 04:45:43 INFO - PROCESS | 2666 | 04:48:46 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50557/tests/dromaeo/cssquery-yui.html) 04:48:46 INFO - PROCESS | 2666 | RSS: Main: 341282816 04:48:46 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50557/tests/dromaeo/cssquery-yui.html (next: http://localhost:50557/tests/dromaeo/cssquery-dojo.html) 04:51:49 INFO - PROCESS | 2666 | RSS: Main: 390537216 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | __start_tp_report 04:51:49 INFO - PROCESS | 2666 | _x_x_mozilla_page_load 04:51:49 INFO - PROCESS | 2666 | _x_x_mozilla_page_load_details 04:51:49 INFO - PROCESS | 2666 | |i|pagename|runs| 04:51:49 INFO - PROCESS | 2666 | |0;dojo.html;3020.2147441665174;3430.3996800559903;3459.2908453766995;3491.581010278767;3504.264104538047;5632.633878797876;5699.800506982257;5718.370979192291;5722.942770572298;5725.370209276982;5636.351819540754;5701.885962280752;5704.229928959589;5710.77156913723;5711.657300561958;5151.922721159186;5188.844334669966;5216.165413533835;5227.738613069331;5278.234655974881;5273.2617433559335;5280.551153151987;5282.841514754564;5286.154215325549;5289;5259.421463639016;5268.657537260085;5273.920891186616;5274.551663108621;5278.1291086970605;5184.455632158607;5198.740062996835;5287.894242115175;5304.098303288451;5307.177387504943;5179.482051794828;5232.058229518685;5233.476652334774;5247.10799164143;5325.227841962933;5592.6085174037835;5603.7478313475995;5688.4311568843195;5691.630044047124;5696.344920334173;6138.263408390977;6168.691565421711;6169;6273.937260627381;6284.622922624611;6144.600600960924;6228.37716228378;6270.184875966141;6273.247210334789;6279.434850863398;5801.9129713054335;5802.071668533014;5807.912881306784;5809.535237181015;5813.273340832396;6142.867137759775;6179.196704428486;6202.968985155046;6218.31598524162;6242.531810114259;6131.754729810847;6140.17107690456;6151.138840562325;6155.353687862799;6180.938190618126;6251.374862513803;6253.968095264321;6255.906161407583;6260.217472815898;6265.216847894013;6086.452219300284;6107.006761825686;6135.961889924213;6167.6916154193;6224.968875155595;6210.782622608187;6218.22272215973;6235.844103897439;6246.812595622138;6268.843278918063;4910.312556242129;4918;4922.138625740481;4924.285978533093;4954.975225123923;3841.2509560635967;4233.920350310713;4398.670099742532;4404.603585677304;4417.977910110429;5685.914711279334;5753.194552762617;5756.625819321731;5759.049756790167;5760.36635970043;5227.424983251839;6153.907691384633;6227.626342419469;6245.812625621239;6250.1874756281395;5770.942290577124;5825.359210486843;5833.183354330397;5840.941590584125;5885.176075349455;5353.892922141536;5372.543333816591;5373.38206106295;5377.166539186433;5446.700431476307;6151.661658608819;6236.407541283571;6237.563370564017;6295.307516173218;6299.779507717208;6146.985747351637;6214.40963108504;6214.943459611786;6230.470410015199;6238.968805155945;6247.718852651551;6283.120363149254;6295.024271237966;6295.087212354275;6296.307406185224;6081.483073938764;6117.401149625394;6145.0782382642965;6181.196444462191;6199.256089269316;6146.139540464249;6152.200213972155;6225.066240063846;6236.158118653923;6239.937600623935;4639.44326680787;5596.3284405871555;6108.908366374597;6119.2350956130485;6125.754969801158;5932.347441781314;6120.908186377297;6126.5711400203345;6141.232345956755;6142;5005;5918.644881307136;5920.111983202381;5935.732892019783;6000.099388759166;6080.179175811209;6115.266168059861;6121.204243448323;6137.3248942617165;6146.78486252979;5945.078512830518;5990;5990.460858522754;5994.0109881869;5997.4002599741425 04:51:49 INFO - PROCESS | 2666 | |1;ext.html;553.06808028472;571.2373980735716;582.7936172123703;586.222812251676;618.9690515474225;28953.565696514543;29163.270918227056;29202.977895773653;29209.415811683753;29401;30033.849830750816;31031.689683103163;38251.234975300475;38269;38320.658776942815;9381.624735010608;9606.903930960705;9620.567074481665;9626.807463850719;9642.614295428175;9391.953040234823;9540.093691099335;9551.80896382072;9558.56986435612;9578.473183974878;8251;9480.525973701322;9587.328886977913;9646.083622055894;9675.70972870815;8695.173958473935;9400.730901328301;9494.620215191384;9669.323147379686;9673.467959262238;9401.858972115424;9529.428234305895;9531.571079301448;9533.427994320364;9550.90449095507;36785.81607091974;37001.814990924875;37150.256994860225;37204.44193337102;38705.806470967465;2747.219897166075;3252.235724604716;3261.347730453895;3271.2149084219855;3627.3470775260444;28447;28855.711442885724;28988;29543.852280738458;29636.851815741;2706.9729302707115;2765.405437830876;2805.466961277351;2815.6902740698506;2850.116463896178;482453;483341;484327;485052.5747371276;486094.99999999645;53591.19613205805;54563;54695.726521367935;62175;63171.368286316545;60175;60697.39302606917;60929.781404371664;61116;61479.692601536706;14590.197539135237;15667.059976401453;15805.288762005737;15864.762028569581;15865.20673966297;10972.396518191576;11021.173411994132;12183.817242741366;12535.435905384098;12537.247765134121;16495.103063147653;18522;18898.338558150397;19019.61960760777;19070.42788716341;7192.82017949545;7353.742619008416;8256.876146857801;8299.045609754956;8545.444546104483;920.7467946314817;937.6624415210518;943.7027336389153;949.6913503111516;952.3952290295712;23112.65331020036;28152.577711334347;28247.858760706065;29794.851025745167;30364;1051;1066.5253961986996;1083.8970297821852;1124.707576030238;1172.648205538335;11323.37721425313;13475.393607287695;13639.704228098315;13750.518731844537;13770.724585508233;533898.3305083449;546709;547809;548813;549650;51777.741111294956;51815;51964;52037.7398113007;52117.218241726405;1387.549046559872;1408.8943329250142;1409.7603407420763;1418.276678893751;1541.7533194688797;27179;27264.86367568229;27828.582571261853;27879.024234151708;27979;46423.76788116173;47822.5217747832;47862.52137478581;47915.28127078166;48300.27549586689;496278;503853;507914.4604276955;562522;643831;30220.24449388783;30223.546646799874;30425.391492170475;30477.695223047485;30547.694523054484;42361.36457953072;42570.14859702851;42578.78710606427;43132.56867431411;43870.561294387924;31030;35902;36156.63843361533;36495.63504365028;36684.81657591695;27780.861095694392;30087.94692185763;34088.65911340855;34479;34961.475577865844;33506.994790156336;34250.48624270688;34480.65519344775;34558;34569.654303457646;30709.53935691011;31083.22291942629;31611.84194079015;32210.194745130622;32410.675893240765;22890.885545572164;24055.51888962246;31414.52878206783;31751.68248317487;32473.863414780368 04:51:49 INFO - PROCESS | 2666 | |2;jquery.html;362.14533700466893;368.7105622086661;370.457280084676;372.2814967113472;377.8998565380173;14968.625784355369;15540.145292008934;18681.346152884653;19308.90345548272;20177.798222017795;15715.135667538309;17221;18471.076446177703;19301.324453644127;19319.4204173875;4642.767861606923;5142.254373115905;5709.200711900337;5889.823305300848;5893.911591326134;3870.767753934773;4055.776932268724;4058.269511487931;4815.807367705288;5647.548196144298;5846.093855452412;5890.204822348992;5904.2324497815225;5909.704514774266;6182.227221597301;6189.783357582485;6343.238811342622;6344.587601805868;6351.714172862232;6382.521310901701;5515.61390702651;5559.749811258463;5567.8886422271735;5573.08044172711;5578.748956296977;13028.934855325662;13283.45175247091;17153.313867445286;23624.40938976522;24072;2061.938141855747;2160.3087012156116;2238.608243557387;2258.627326491127;2313.4100804294967;9692.127708506268;9805.901940980642;9951.955044720273;11428.885711142866;14124.364403601863;1676.8155502894672;1704.1053446940332;1775.2366482412558;1789.2306308287432;1819.1904602451914;84541.57729211314;86328.56835715781;88588;98868.51697224619;101025.49487252516;7964.960175199087;9029.729108126767;10827.891721082688;10870.510827012804;10886.455677216107;12881.549145779853;12959.870401295866;13082.495513015934;13246.072774905664;13266.204027758366;8268.338532917352;8288.668453261922;8320.750377488685;8384.161583841567;8412.62143203545;8432.229231861254;8436.957815210884;8443.873341899876;8502.532360720095;8544.829103417896;4016.457778199964;4297.763623000765;4416.227160246944;4422.447194100738;4435.068635586563;1743.5902562897709;1791.6506281275026;1791.802901680814;1848.510144811626;1850.3986204483597;866.1252135343223;871.350843621506;901.6078006067381;935.0976307862945;1003.8193125237527;16262.430814921658;16507.3225198639;19898;20209.36231478348;20406;954.6491714224295;979.2019504104132;981.4896253947907;999.9250056245811;1024.779672370444;10635.41505217205;10852.348859068481;10856.674299771019;10873.510692018877;10949.945250273699;701931;733260;733849;744585;746307;110469;112938;113606;114538;115152;1136.3863513702508;1136.8237923121928;1187.252031220343;1191.600813727411;1202.380773901459;17349.566260843076;17677.734833977243;17949.820501795337;18174;18387.632247355246;49364;50107;50383;50509.73725656888;50532;68024.3197568018;69461.65269173622;70154.64922675354;70493.23766905868;70945.6452717733;7234.9871018056465;7323.780286591411;7454.366378857858;7604.733834315773;7605.163432022584;9052;9234.769130771785;11652.883471165518;11885;11887.346195959306;9245.583948722458;9921.851172232278;10137.543810528396;10188;10331.483425828828;9750.122488976027;9928.553215105481;10060.346077504939;10115.747106322106;10214.948925255623;8708.825823483621;9667.371620844622;10351.96480351989;10586.788264234518;10625.309354891908;7426;7496.212897645669;7581.810454738676;7601.277878601524;7603.923960760321;8381;9411.4823684698;10186.847197292194;10272.126869216201;10367.481625918825 04:51:49 INFO - PROCESS | 2666 | |3;mootools.html;1382.7856682214258;1403.9298035098243;1536.0553259745257;1745.5897864001965;1931.6812725900227;7888.9211107888905;8098.2306680865295;8507.787305317363;8683.392162548624;8684.218420342168;8432.620532076056;8529.97640283167;8636.956815215915;8655.48067115972;8657.870131948026;2179.063002908749;2213.7786221377814;2468.580341341967;2491.5266099441137;2492.0903870087377;1985.5135491804529;2204.7023651806962;2498.1381423408984;2502.024210557884;2502.06172685243;2420.3586049696755;2461.938451538717;2468.6297055441737;2474.7030356357263;2478.9752102478924;2419.552382809186;2457.2628211536558;2459.7417271186628;2462.6059830427134;2479.2438306316567;2455.8280920335583;2457.4716435966175;2458.6557881896547;2466;2468.987655061731;8748.431351962103;8785.297176225886;8817.823643527157;8828.205461508494;8834.425762325493;5326;5485.451454854522;5505.421930697299;5513.641613295123;5516.7517461714315;3617.963820361815;3682.4476328550663;3767.2653832502674;3771.7548359356556;3792;1048.3028785857396;1064.7604289034982;1073.313079629038;1093.557109370706;1102.2394547762099;11805.527778888834;11808.055355571534;11816.527338906433;11822.645320640395;11871.347075910822;4871.196252618349;4910.803567857317;4942;5010.323606313101;5017.222330538772;10189.388636681822;10224.795504089876;10235.232357573212;10254.743631409274;10279.845802312972;4730.290456431563;5538.972305138448;5544.861378465571;5545.77816887328;5563.221149039137;4924.8276310328965;4974.37820272466;5043.142665746832;5043.596512279082;5044.646874718808;3687.760295580779;3764.247150569897;3772.8490860365278;3978.980105099514;4004.4994375703036;1282.8909542688975;1297.1049975516862;1298.1237664576374;1311.3705421397592;1315.1254415813569;1313.1530163044974;1320.4718112754783;1332.2006795922368;1333.6665833541615;1354.925479098659;6692.163479565054;7930.682772689028;7958.84082318362;7982.361411087099;7990.760277191694;1172.0447835014436;1177.4407156600716;1184.514349116858;1184.579474286633;1203.1638011582043;6192.071189321638;6281.403266689657;6287.151234583364;6292.559520833498;6295.716692748837;9970.850437243302;10251.231157663206;10259;10422.957704229668;10426.270161088803;10157.238207134495;10313.690589282334;10364.740881478023;10406.635767748245;10432.217583681255;8028.799280017929;8163.959180204061;8246.628901699438;8252.711155109662;8254.669813207525;7258.891116633149;7704.422168337509;7850.764477065697;8003.039635243808;8014.19858014194;9373.68768372442;9374.250059995047;9447.433154010781;9456.101670341306;9595.904040959502;9625.71122866315;9883.901160988298;9925.95777443358;9992.00079991995;10015.449150296512;7267.7819665410125;7386.778396648109;7537.095548534211;7553.697852085855;7568.318851303409;7371.852562948819;7587.886181707168;7591.430642701709;8174.182581741778;8294.29498492635;6154.415330543591;7603.923960760543;7691.269329413697;7709.80725481845;7766.262205090507;6717.227518835396;7560.054993125859;7604.5437273763755;7627;7742.187070357757;7735.613219339123;7779.57212353326;7797.493162944391;7836.138024817152;7874.488158269694;7069.469789765685;7095.751648692478;7100.964495177698;7111.466640002124;7112.964435177791;7140.750073747394;7176.712931482891;7201.567905925661;7227.385672217921;7241.312075352833 04:51:49 INFO - PROCESS | 2666 | |4;prototype.html;318.20448877805484;324.0650722665112;327.95736554247975;329.3363871798326;334.6736931491794;6288.496920246381;6468.482521398289;6484.124643173182;6576.243731970819;6651.60090394576;6302.684865756705;6443.420092191702;6455.128557644716;6465.9977703455925;6501.967490162554;4836.081144582518;4872.805087796484;4879;4879.316895634614;4884.998575292075;4583.8166473341025;4864.659473836833;4865.294532292815;4887.120318342697;4899.951000489985;4479.17135329965;4759.738214398207;4793.7363445010515;4816.97591512042;4838.467768545457;4802.903941921177;4805.879853003668;4836.516348365135;4849.3453383793085;4855.344528488662;4128.112455821983;4143.482064741907;4145.626893579592;4161.979190104061;4172;5958.225430694026;6181.979973304399;6211.47202487789;6251.781187658456;6260;5061.721605311706;5639.605227634067;5655.26481557399;5660.405657405954;5676.063449530822;6486.837829054264;6905.240423553405;6905.861882762317;6928.4803639726715;6946.895796563055;4591.701539399928;4599.517050709695;4617.353570500132;4618.607418369443;4620.884477888046;5869.677167755772;6991.8601627967155;7236.407990242138;7287.708491660327;7375.59434231117;4515.961328894373;4546.40896683429;4548.795304211319;4553.954460455419;4561.2245918193985;3622.8188590570894;4442.044960333544;4458.108378324348;4603.987122832971;4620.44554653437;4700.529947005272;5339.279197308391;5408.59435542328;5444.265024221759;5469.890602187934;6855.6572171391235;6872.450203983669;6938.861222775517;6958.373746362851;6969.128858892638;1569.4899157773768;1599.8160211575585;1600.7918970533756;1603.8315976822498;1607.2044338052738;770.7186876789931;1002.0780881588955;1031.7265924530006;1044.1646682653848;1044.3577200021932;6497.480201583862;6513.544051916415;6514.185726784152;6528.51036172289;6536.117624120778;7179.030830837874;7183.06620139389;7204.603746793977;7204.855902882018;7205.207427183006;6243.656598887105;6513.120728701565;6515.576487528296;6537.771178008747;6541.116949211891;3768.6419790119894;3818.59904710007;3818.694504439638;3820.9301395609273;3825.464434979105;7494.276316447248;7499.6250187490405;7522.774316770506;7530.209328020588;7532.246775322424;6032.4570788629235;7111.679974401164;7414.406847452191;7432.108147022283;7466.477346585795;6107.877842443127;7520.285572870568;7554.773356799305;7560.659770310349;7578.280063393969;7216.314450127229;7220.277972202738;7225.24134965842;7259.382952449101;7265.7093716252875;6875.449964002968;7109.289071093056;7109.431245500244;7131.322524360177;7144.106986626672;7541;7544.396448284234;7545.132309784445;7559.244075592397;7564.697412103455;3772.5095737553943;4505.662075344297;4555.908881822279;4560.52114527983;4566.657500687395;6975.581465112109;7162.247963963709;7191.640417978975;7202.135743710788;7231.5299505531975;6945.479089068239;6962.756303529352;6972.546784458994;6982.79051628452;6982.825429364103;6743.494237932076;6949.861002780017;6957.8956315654295;6960.408365289007;6969.30306969299;6751;6779;6784.151981002375;6784.626845523544;6797.694103765243;6934.930650693428;6938.653067346713;6941.514094013371;6948.305169483011;6952.026716259828;6526.347365263436;6806.353396427331;6812.352826481477;6816.386525212754;6827.317268273332 04:51:49 INFO - PROCESS | 2666 | |5;yui.html;665.2349797732606;730.1566690472505;734.9338559529641;751.5978951261077;756.6216891554219;14216.786748198772;14381.280935953188;14387.992840501156;14394.064385814941;14402.495912643046;15125.848741512582;15466.690666186669;15472.767908481383;15480.845191548082;15504.147271900069;686.5777546808702;702.4906942466696;832.7543374704461;863.1196179896501;869.5130726792985;701.6141122382695;705.0552259971637;705.4039336760455;705.5942832871119;839.2237180607913;901.1304091551651;911.9452832830018;913.4291068082448;913.7624217703411;914.3142643017736;903.9819203615924;904.5296445848188;906.8730377747088;907.850204716221;908.6592527802075;526.2028027538282;537.9838604841862;538.2437675066537;538.5126460553206;540.2139886465224;12219.26684398939;14542.054766440147;14833;14846;14856.62858428537;10975.890241097566;11037.889621103766;12092.274463532216;12670.80993785094;12933.611991640266;10207.846882296772;10285.02292282232;10317.174626029975;10380.221483388701;10983.340999540053;3478.3912815257227;3577.159367548624;3585.2829434113282;3585.587657419378;3591.0842735102383;78086.21913780904;79647.6017619914;80151.19848801495;80261;80874.97812554674;9636.951815240878;9637.42175469474;9670.178034867115;9871.358361706467;9955.402675839472;21970.231041913456;21984.45038874041;21992.45018874509;22028.669569956463;22047.559048818934;7462.85074298511;7535.472516923763;7611.4291428143115;7646.120696119906;7770.572618505923;4096.713230073926;4137.50349958007;4173.603507666767;4183.707140500136;4238.87283381499;3629.8911032668534;3687.410014397737;3689.631036896289;3689.985254055103;3715.981420092882;661.3122352753082;671.6977360187935;682.2324884504932;682.6450245872119;683.3883674111643;476.6901514015848;551.203510926707;581.2327727399876;606.1967892542399;623.8128561431553;8283.668653253802;8375.8324833503;8403.478468637562;8681.522516261666;8769.605367758466;511.1412826451523;588.1383772772823;598.2671227745976;602.5179856115091;616.5468380740152;3812.426238814474;3973.5231772186944;3985.7608543487486;4107.240160570244;4140.937885931713;82761;83536;84214.57892710497;90105;90551;75699.62150189324;76234;76909.61545192238;78338;78837;55235.514401852015;58167.12749308764;66030.0095498568;67596.3100922471;68329;6508.284088750328;8030.799230019296;8138.771776310613;8273.793155170928;8294.212049855254;44816.10367792561;45327.32009019933;45554;45560.08879822451;46904.82737931579;61359;61742.382576173666;62055.689721551105;63179.36820631919;66487.66756166189;10221.9488902555;10224.335418197794;10357.4303413313;10363.94818025905;10950.959658832398;10387.792244155225;11649;11791.469383877919;12319.630411087322;12680.809787853004;11203.271787333797;11222.214444988773;11228.214025018171;11539.538418463504;12226.938865305616;11272;11473.541058357572;11617.709557261136;11643.243189192675;11948.701282468008;10680.038796508352;10877.945610271898;11078.889211107786;11254.7749045017;11562.901524355173;9085.091490851126;9294.9535252326;9307.813843723223;9378.95310523443;9380.437173769596;8879.600417981335;9159.450432974043;9254.629814807602;9658.3722058066;9993.800123997335 04:51:49 INFO - PROCESS | 2666 | __end_tp_report 04:51:49 INFO - PROCESS | 2666 | __start_cc_report 04:51:49 INFO - PROCESS | 2666 | _x_x_mozilla_cycle_collect,1076 04:51:49 INFO - PROCESS | 2666 | __end_cc_report 04:51:49 INFO - PROCESS | 2666 | __startTimestamp1454763109649__endTimestamp 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | ------- Summary: start ------- 04:51:49 INFO - PROCESS | 2666 | Number of tests: 6 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | [#0] dojo.html Cycles:165 Average:5722.75 Median:5935.73 stddev:643.38 (10.8%) stddev-sans-first:609.43 04:51:49 INFO - PROCESS | 2666 | Values: 3020.2 3430.4 3459.3 3491.6 3504.3 5632.6 5699.8 5718.4 5722.9 5725.4 5636.4 5701.9 5704.2 5710.8 5711.7 5151.9 5188.8 5216.2 5227.7 5278.2 5273.3 5280.6 5282.8 5286.2 5289.0 5259.4 5268.7 5273.9 5274.6 5278.1 5184.5 5198.7 5287.9 5304.1 5307.2 5179.5 5232.1 5233.5 5247.1 5325.2 5592.6 5603.7 5688.4 5691.6 5696.3 6138.3 6168.7 6169.0 6273.9 6284.6 6144.6 6228.4 6270.2 6273.2 6279.4 5801.9 5802.1 5807.9 5809.5 5813.3 6142.9 6179.2 6203.0 6218.3 6242.5 6131.8 6140.2 6151.1 6155.4 6180.9 6251.4 6254.0 6255.9 6260.2 6265.2 6086.5 6107.0 6136.0 6167.7 6225.0 6210.8 6218.2 6235.8 6246.8 6268.8 4910.3 4918.0 4922.1 4924.3 4955.0 3841.3 4233.9 4398.7 4404.6 4418.0 5685.9 5753.2 5756.6 5759.0 5760.4 5227.4 6153.9 6227.6 6245.8 6250.2 5770.9 5825.4 5833.2 5840.9 5885.2 5353.9 5372.5 5373.4 5377.2 5446.7 6151.7 6236.4 6237.6 6295.3 6299.8 6147.0 6214.4 6214.9 6230.5 6239.0 6247.7 6283.1 6295.0 6295.1 6296.3 6081.5 6117.4 6145.1 6181.2 6199.3 6146.1 6152.2 6225.1 6236.2 6239.9 4639.4 5596.3 6108.9 6119.2 6125.8 5932.3 6120.9 6126.6 6141.2 6142.0 5005.0 5918.6 5920.1 5935.7 6000.1 6080.2 6115.3 6121.2 6137.3 6146.8 5945.1 5990.0 5990.5 5994.0 5997.4 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | [#1] ext.html Cycles:180 Average:64904.72 Median:36590.23 stddev:140385.24 (383.7%) stddev-sans-first:140695.91 04:51:49 INFO - PROCESS | 2666 | Values: 553.1 571.2 582.8 586.2 619.0 28953.6 29163.3 29203.0 29209.4 29401.0 30033.8 31031.7 38251.2 38269.0 38320.7 9381.6 9606.9 9620.6 9626.8 9642.6 9392.0 9540.1 9551.8 9558.6 9578.5 8251.0 9480.5 9587.3 9646.1 9675.7 8695.2 9400.7 9494.6 9669.3 9673.5 9401.9 9529.4 9531.6 9533.4 9550.9 36785.8 37001.8 37150.3 37204.4 38705.8 2747.2 3252.2 3261.3 3271.2 3627.3 28447.0 28855.7 28988.0 29543.9 29636.9 2707.0 2765.4 2805.5 2815.7 2850.1 482453.0 483341.0 484327.0 485052.6 486095.0 53591.2 54563.0 54695.7 62175.0 63171.4 60175.0 60697.4 60929.8 61116.0 61479.7 14590.2 15667.1 15805.3 15864.8 15865.2 10972.4 11021.2 12183.8 12535.4 12537.2 16495.1 18522.0 18898.3 19019.6 19070.4 7192.8 7353.7 8256.9 8299.0 8545.4 920.7 937.7 943.7 949.7 952.4 23112.7 28152.6 28247.9 29794.9 30364.0 1051.0 1066.5 1083.9 1124.7 1172.6 11323.4 13475.4 13639.7 13750.5 13770.7 533898.3 546709.0 547809.0 548813.0 549650.0 51777.7 51815.0 51964.0 52037.7 52117.2 1387.5 1408.9 1409.8 1418.3 1541.8 27179.0 27264.9 27828.6 27879.0 27979.0 46423.8 47822.5 47862.5 47915.3 48300.3 496278.0 503853.0 507914.5 562522.0 643831.0 30220.2 30223.5 30425.4 30477.7 30547.7 42361.4 42570.1 42578.8 43132.6 43870.6 31030.0 35902.0 36156.6 36495.6 36684.8 27780.9 30087.9 34088.7 34479.0 34961.5 33507.0 34250.5 34480.7 34558.0 34569.7 30709.5 31083.2 31611.8 32210.2 32410.7 22890.9 24055.5 31414.5 31751.7 32473.9 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | [#2] jquery.html Cycles:180 Average:36558.18 Median:4057.02 stddev:120498.69 (2970.1%) stddev-sans-first:120806.07 04:51:49 INFO - PROCESS | 2666 | Values: 362.1 368.7 370.5 372.3 377.9 14968.6 15540.1 18681.3 19308.9 20177.8 15715.1 17221.0 18471.1 19301.3 19319.4 4642.8 5142.3 5709.2 5889.8 5893.9 3870.8 4055.8 4058.3 4815.8 5647.5 5846.1 5890.2 5904.2 5909.7 6182.2 6189.8 6343.2 6344.6 6351.7 6382.5 5515.6 5559.7 5567.9 5573.1 5578.7 13028.9 13283.5 17153.3 23624.4 24072.0 2061.9 2160.3 2238.6 2258.6 2313.4 9692.1 9805.9 9952.0 11428.9 14124.4 1676.8 1704.1 1775.2 1789.2 1819.2 84541.6 86328.6 88588.0 98868.5 101025.5 7965.0 9029.7 10827.9 10870.5 10886.5 12881.5 12959.9 13082.5 13246.1 13266.2 8268.3 8288.7 8320.8 8384.2 8412.6 8432.2 8437.0 8443.9 8502.5 8544.8 4016.5 4297.8 4416.2 4422.4 4435.1 1743.6 1791.7 1791.8 1848.5 1850.4 866.1 871.4 901.6 935.1 1003.8 16262.4 16507.3 19898.0 20209.4 20406.0 954.6 979.2 981.5 999.9 1024.8 10635.4 10852.3 10856.7 10873.5 10949.9 701931.0 733260.0 733849.0 744585.0 746307.0 110469.0 112938.0 113606.0 114538.0 115152.0 1136.4 1136.8 1187.3 1191.6 1202.4 17349.6 17677.7 17949.8 18174.0 18387.6 49364.0 50107.0 50383.0 50509.7 50532.0 68024.3 69461.7 70154.6 70493.2 70945.6 7235.0 7323.8 7454.4 7604.7 7605.2 9052.0 9234.8 11652.9 11885.0 11887.3 9245.6 9921.9 10137.5 10188.0 10331.5 9750.1 9928.6 10060.3 10115.7 10214.9 8708.8 9667.4 10352.0 10586.8 10625.3 7426.0 7496.2 7581.8 7601.3 7603.9 8381.0 9411.5 10186.8 10272.1 10367.5 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | [#3] mootools.html Cycles:180 Average:6023.72 Median:5185.32 stddev:3131.84 (60.4%) stddev-sans-first:3121.19 04:51:49 INFO - PROCESS | 2666 | Values: 1382.8 1403.9 1536.1 1745.6 1931.7 7888.9 8098.2 8507.8 8683.4 8684.2 8432.6 8530.0 8637.0 8655.5 8657.9 2179.1 2213.8 2468.6 2491.5 2492.1 1985.5 2204.7 2498.1 2502.0 2502.1 2420.4 2461.9 2468.6 2474.7 2479.0 2419.6 2457.3 2459.7 2462.6 2479.2 2455.8 2457.5 2458.7 2466.0 2469.0 8748.4 8785.3 8817.8 8828.2 8834.4 5326.0 5485.5 5505.4 5513.6 5516.8 3618.0 3682.4 3767.3 3771.8 3792.0 1048.3 1064.8 1073.3 1093.6 1102.2 11805.5 11808.1 11816.5 11822.6 11871.3 4871.2 4910.8 4942.0 5010.3 5017.2 10189.4 10224.8 10235.2 10254.7 10279.8 4730.3 5539.0 5544.9 5545.8 5563.2 4924.8 4974.4 5043.1 5043.6 5044.6 3687.8 3764.2 3772.8 3979.0 4004.5 1282.9 1297.1 1298.1 1311.4 1315.1 1313.2 1320.5 1332.2 1333.7 1354.9 6692.2 7930.7 7958.8 7982.4 7990.8 1172.0 1177.4 1184.5 1184.6 1203.2 6192.1 6281.4 6287.2 6292.6 6295.7 9970.9 10251.2 10259.0 10423.0 10426.3 10157.2 10313.7 10364.7 10406.6 10432.2 8028.8 8164.0 8246.6 8252.7 8254.7 7258.9 7704.4 7850.8 8003.0 8014.2 9373.7 9374.3 9447.4 9456.1 9595.9 9625.7 9883.9 9926.0 9992.0 10015.4 7267.8 7386.8 7537.1 7553.7 7568.3 7371.9 7587.9 7591.4 8174.2 8294.3 6154.4 7603.9 7691.3 7709.8 7766.3 6717.2 7560.1 7604.5 7627.0 7742.2 7735.6 7779.6 7797.5 7836.1 7874.5 7069.5 7095.8 7101.0 7111.5 7113.0 7140.8 7176.7 7201.6 7227.4 7241.3 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | [#4] prototype.html Cycles:180 Average:5668.61 Median:6492.16 stddev:1818.95 (28.0%) stddev-sans-first:1779.17 04:51:49 INFO - PROCESS | 2666 | Values: 318.2 324.1 328.0 329.3 334.7 6288.5 6468.5 6484.1 6576.2 6651.6 6302.7 6443.4 6455.1 6466.0 6502.0 4836.1 4872.8 4879.0 4879.3 4885.0 4583.8 4864.7 4865.3 4887.1 4900.0 4479.2 4759.7 4793.7 4817.0 4838.5 4802.9 4805.9 4836.5 4849.3 4855.3 4128.1 4143.5 4145.6 4162.0 4172.0 5958.2 6182.0 6211.5 6251.8 6260.0 5061.7 5639.6 5655.3 5660.4 5676.1 6486.8 6905.2 6905.9 6928.5 6946.9 4591.7 4599.5 4617.4 4618.6 4620.9 5869.7 6991.9 7236.4 7287.7 7375.6 4516.0 4546.4 4548.8 4554.0 4561.2 3622.8 4442.0 4458.1 4604.0 4620.4 4700.5 5339.3 5408.6 5444.3 5469.9 6855.7 6872.5 6938.9 6958.4 6969.1 1569.5 1599.8 1600.8 1603.8 1607.2 770.7 1002.1 1031.7 1044.2 1044.4 6497.5 6513.5 6514.2 6528.5 6536.1 7179.0 7183.1 7204.6 7204.9 7205.2 6243.7 6513.1 6515.6 6537.8 6541.1 3768.6 3818.6 3818.7 3820.9 3825.5 7494.3 7499.6 7522.8 7530.2 7532.2 6032.5 7111.7 7414.4 7432.1 7466.5 6107.9 7520.3 7554.8 7560.7 7578.3 7216.3 7220.3 7225.2 7259.4 7265.7 6875.4 7109.3 7109.4 7131.3 7144.1 7541.0 7544.4 7545.1 7559.2 7564.7 3772.5 4505.7 4555.9 4560.5 4566.7 6975.6 7162.2 7191.6 7202.1 7231.5 6945.5 6962.8 6972.5 6982.8 6982.8 6743.5 6949.9 6957.9 6960.4 6969.3 6751.0 6779.0 6784.2 6784.6 6797.7 6934.9 6938.7 6941.5 6948.3 6952.0 6526.3 6806.4 6812.4 6816.4 6827.3 04:51:49 INFO - PROCESS | 2666 | 04:51:49 INFO - PROCESS | 2666 | [#5] yui.html Cycles:180 Average:17608.62 Median:29377.63 stddev:24347.53 (82.9%) stddev-sans-first:24382.59 04:51:49 INFO - PROCESS | 2666 | Values: 665.2 730.2 734.9 751.6 756.6 14216.8 14381.3 14388.0 14394.1 14402.5 15125.8 15466.7 15472.8 15480.8 15504.1 686.6 702.5 832.8 863.1 869.5 701.6 705.1 705.4 705.6 839.2 901.1 911.9 913.4 913.8 914.3 904.0 904.5 906.9 907.9 908.7 526.2 538.0 538.2 538.5 540.2 12219.3 14542.1 14833.0 14846.0 14856.6 10975.9 11037.9 12092.3 12670.8 12933.6 10207.8 10285.0 10317.2 10380.2 10983.3 3478.4 3577.2 3585.3 3585.6 3591.1 78086.2 79647.6 80151.2 80261.0 80875.0 9637.0 9637.4 9670.2 9871.4 9955.4 21970.2 21984.5 21992.5 22028.7 22047.6 7462.9 7535.5 7611.4 7646.1 7770.6 4096.7 4137.5 4173.6 4183.7 4238.9 3629.9 3687.4 3689.6 3690.0 3716.0 661.3 671.7 682.2 682.6 683.4 476.7 551.2 581.2 606.2 623.8 8283.7 8375.8 8403.5 8681.5 8769.6 511.1 588.1 598.3 602.5 616.5 3812.4 3973.5 3985.8 4107.2 4140.9 82761.0 83536.0 84214.6 90105.0 90551.0 75699.6 76234.0 76909.6 78338.0 78837.0 55235.5 58167.1 66030.0 67596.3 68329.0 6508.3 8030.8 8138.8 8273.8 8294.2 44816.1 45327.3 45554.0 45560.1 46904.8 61359.0 61742.4 62055.7 63179.4 66487.7 10221.9 10224.3 10357.4 10363.9 10951.0 10387.8 11649.0 11791.5 12319.6 12680.8 11203.3 11222.2 11228.2 11539.5 12226.9 11272.0 11473.5 11617.7 11643.2 11948.7 10680.0 10877.9 11078.9 11254.8 11562.9 9085.1 9295.0 9307.8 9379.0 9380.4 8879.6 9159.5 9254.6 9658.4 9993.8 04:51:49 INFO - PROCESS | 2666 | -------- Summary: end -------- 04:51:49 INFO - PROCESS | 2666 | 04:51:50 INFO - TEST-INFO | 2666: exit 0 04:51:50 INFO - TEST-OK | dromaeo_css | took 1113675ms 04:51:50 INFO - TEST-START | kraken 04:51:50 INFO - operating with platform_type : mac_ 04:51:50 INFO - Initialising browser for kraken test... 04:51:50 INFO - TEST-INFO | started process 2672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp12Ljje/profile http://localhost:50557/getInfo.html) 04:51:50 INFO - PROCESS | 2672 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:51:52 INFO - PROCESS | 2672 | __metrics Screen width/height:1600/1200 04:51:52 INFO - PROCESS | 2672 | colorDepth:24 04:51:52 INFO - PROCESS | 2672 | Browser inner width/height: 1024/689 04:51:52 INFO - PROCESS | 2672 | __metrics 04:51:52 INFO - PROCESS | 2672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:51:52 INFO - PROCESS | 2672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:53 INFO - TEST-INFO | 2672: exit 0 04:51:53 INFO - Browser initialized. 04:51:53 INFO - Running cycle 1/1 for kraken test... 04:51:53 INFO - TEST-INFO | started process 2674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp12Ljje/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:05 INFO - PROCESS | 2674 | RSS: Main: 243609600 04:52:05 INFO - PROCESS | 2674 | 04:52:07 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:08 INFO - PROCESS | 2674 | RSS: Main: 289517568 04:52:08 INFO - PROCESS | 2674 | 04:52:10 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-dft) 04:52:11 INFO - PROCESS | 2674 | RSS: Main: 300367872 04:52:11 INFO - PROCESS | 2674 | 04:52:14 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-fft) 04:52:15 INFO - PROCESS | 2674 | RSS: Main: 288514048 04:52:15 INFO - PROCESS | 2674 | 04:52:17 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50557/tests/kraken/driver.html?testName=audio-oscillator) 04:52:17 INFO - PROCESS | 2674 | RSS: Main: 291184640 04:52:17 INFO - PROCESS | 2674 | 04:52:20 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:20 INFO - PROCESS | 2674 | RSS: Main: 292003840 04:52:20 INFO - PROCESS | 2674 | 04:52:23 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50557/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:24 INFO - PROCESS | 2674 | RSS: Main: 292368384 04:52:24 INFO - PROCESS | 2674 | 04:52:26 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50557/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:27 INFO - PROCESS | 2674 | RSS: Main: 291467264 04:52:27 INFO - PROCESS | 2674 | 04:52:30 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50557/tests/kraken/driver.html?testName=json-parse-financial) 04:52:30 INFO - PROCESS | 2674 | RSS: Main: 293007360 04:52:30 INFO - PROCESS | 2674 | 04:52:32 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:32 INFO - PROCESS | 2674 | RSS: Main: 326025216 04:52:32 INFO - PROCESS | 2674 | 04:52:34 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:35 INFO - PROCESS | 2674 | RSS: Main: 326750208 04:52:35 INFO - PROCESS | 2674 | 04:52:37 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:37 INFO - PROCESS | 2674 | RSS: Main: 332386304 04:52:37 INFO - PROCESS | 2674 | 04:52:40 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:41 INFO - PROCESS | 2674 | RSS: Main: 333209600 04:52:41 INFO - PROCESS | 2674 | 04:52:43 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:44 INFO - PROCESS | 2674 | RSS: Main: 333774848 04:52:44 INFO - PROCESS | 2674 | 04:52:45 INFO - PROCESS | 2674 | Cycle 1(1): loaded http://localhost:50557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50557/tests/kraken/driver.html?testName=ai-astar) 04:52:46 INFO - PROCESS | 2674 | RSS: Main: 394612736 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | __start_tp_report 04:52:46 INFO - PROCESS | 2674 | _x_x_mozilla_page_load 04:52:46 INFO - PROCESS | 2674 | _x_x_mozilla_page_load_details 04:52:46 INFO - PROCESS | 2674 | |i|pagename|runs| 04:52:46 INFO - PROCESS | 2674 | |0;ai-astar;111;108;111;111;112;112;115;112;111;111 04:52:46 INFO - PROCESS | 2674 | |1;audio-beat-detection;159;120;149;163;115;145;138;119;160;120 04:52:46 INFO - PROCESS | 2674 | |2;audio-dft;188;183;186;187;190;187;186;187;185;185 04:52:46 INFO - PROCESS | 2674 | |3;audio-fft;84;75;90;82;76;78;82;96;79;56 04:52:46 INFO - PROCESS | 2674 | |4;audio-oscillator;97;101;128;79;80;80;108;81;109;140 04:52:46 INFO - PROCESS | 2674 | |5;imaging-gaussian-blur;87;121;87;92;85;90;84;90;87;93 04:52:46 INFO - PROCESS | 2674 | |6;imaging-darkroom;95;94;95;94;95;95;95;94;95;105 04:52:46 INFO - PROCESS | 2674 | |7;imaging-desaturate;86;85;84;94;83;86;85;84;86;89 04:52:46 INFO - PROCESS | 2674 | |8;json-parse-financial;54;55;54;53;54;52;55;63;52;51 04:52:46 INFO - PROCESS | 2674 | |9;json-stringify-tinderbox;65;63;68;78;73;68;68;68;67;73 04:52:46 INFO - PROCESS | 2674 | |10;stanford-crypto-aes;82;82;80;82;82;84;83;83;84;83 04:52:46 INFO - PROCESS | 2674 | |11;stanford-crypto-ccm;131;127;117;120;123;120;132;123;117;125 04:52:46 INFO - PROCESS | 2674 | |12;stanford-crypto-pbkdf2;138;126;141;139;138;125;140;169;168;136 04:52:46 INFO - PROCESS | 2674 | |13;stanford-crypto-sha256-iterative;66;68;65;65;67;67;67;67;66;66 04:52:46 INFO - PROCESS | 2674 | __end_tp_report 04:52:46 INFO - PROCESS | 2674 | __start_cc_report 04:52:46 INFO - PROCESS | 2674 | _x_x_mozilla_cycle_collect,1206 04:52:46 INFO - PROCESS | 2674 | __end_cc_report 04:52:46 INFO - PROCESS | 2674 | __startTimestamp1454763166208__endTimestamp 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | ------- Summary: start ------- 04:52:46 INFO - PROCESS | 2674 | Number of tests: 14 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.71 (1.5%) stddev-sans-first:1.81 04:52:46 INFO - PROCESS | 2674 | Values: 111.0 108.0 111.0 111.0 112.0 112.0 115.0 112.0 111.0 111.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:147.00 stddev:19.01 (12.9%) stddev-sans-first:18.70 04:52:46 INFO - PROCESS | 2674 | Values: 159.0 120.0 149.0 163.0 115.0 145.0 138.0 119.0 160.0 120.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#2] audio-dft Cycles:10 Average:186.40 Median:187.00 stddev:1.90 (1.0%) stddev-sans-first:1.92 04:52:46 INFO - PROCESS | 2674 | Values: 188.0 183.0 186.0 187.0 190.0 187.0 186.0 187.0 185.0 185.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#3] audio-fft Cycles:10 Average:79.80 Median:82.00 stddev:10.55 (12.9%) stddev-sans-first:11.08 04:52:46 INFO - PROCESS | 2674 | Values: 84.0 75.0 90.0 82.0 76.0 78.0 82.0 96.0 79.0 56.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:79.50 stddev:21.45 (27.0%) stddev-sans-first:22.72 04:52:46 INFO - PROCESS | 2674 | Values: 97.0 101.0 128.0 79.0 80.0 80.0 108.0 81.0 109.0 140.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:88.50 stddev:10.73 (12.1%) stddev-sans-first:11.25 04:52:46 INFO - PROCESS | 2674 | Values: 87.0 121.0 87.0 92.0 85.0 90.0 84.0 90.0 87.0 93.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.00 stddev:3.30 (3.5%) stddev-sans-first:3.49 04:52:46 INFO - PROCESS | 2674 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 105.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:3.19 (3.7%) stddev-sans-first:3.38 04:52:46 INFO - PROCESS | 2674 | Values: 86.0 85.0 84.0 94.0 83.0 86.0 85.0 84.0 86.0 89.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:3.33 (6.2%) stddev-sans-first:3.54 04:52:46 INFO - PROCESS | 2674 | Values: 54.0 55.0 54.0 53.0 54.0 52.0 55.0 63.0 52.0 51.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.00 stddev:4.38 (6.4%) stddev-sans-first:4.39 04:52:46 INFO - PROCESS | 2674 | Values: 65.0 63.0 68.0 78.0 73.0 68.0 68.0 68.0 67.0 73.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 04:52:46 INFO - PROCESS | 2674 | Values: 82.0 82.0 80.0 82.0 82.0 84.0 83.0 83.0 84.0 83.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.00 stddev:5.30 (4.3%) stddev-sans-first:4.87 04:52:46 INFO - PROCESS | 2674 | Values: 131.0 127.0 117.0 120.0 123.0 120.0 132.0 123.0 117.0 125.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:139.50 stddev:15.03 (10.8%) stddev-sans-first:15.87 04:52:46 INFO - PROCESS | 2674 | Values: 138.0 126.0 141.0 139.0 138.0 125.0 140.0 169.0 168.0 136.0 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - PROCESS | 2674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 04:52:46 INFO - PROCESS | 2674 | Values: 66.0 68.0 65.0 65.0 67.0 67.0 67.0 67.0 66.0 66.0 04:52:46 INFO - PROCESS | 2674 | -------- Summary: end -------- 04:52:46 INFO - PROCESS | 2674 | 04:52:46 INFO - TEST-INFO | 2674: exit 0 04:52:46 INFO - TEST-OK | kraken | took 56654ms 04:52:46 INFO - SUITE-END | took 1170s 04:52:47 INFO - Completed test suite (00:19:30) 04:52:47 INFO - Working with test: dromaeo_css 04:52:47 INFO - Generating results file: dromaeo_css 04:52:47 INFO - Working with test: kraken 04:52:47 INFO - Generating results file: kraken 04:52:47 INFO - javascript benchmark 04:52:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:52:47 INFO - process_Request line: dromaeo_css 7384.21 graph.html#tests=[[72,64,59]] 04:52:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:47 INFO - process_Request line: kraken 1428.00 graph.html#tests=[[232,64,59]] 04:52:47 INFO - RETURN: dromaeo_css: 7384.21 04:52:47 INFO - RETURN: kraken: 1428.00 04:52:47 INFO - javascript benchmark 04:52:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3020.2147441665174, 3430.3996800559903, 3459.2908453766995, 3491.581010278767, 3504.264104538047, 5632.633878797876, 5699.800506982257, 5718.370979192291, 5722.942770572298, 5725.370209276982, 5636.351819540754, 5701.885962280752, 5704.229928959589, 5710.77156913723, 5711.657300561958, 5151.922721159186, 5188.844334669966, 5216.165413533835, 5227.738613069331, 5278.234655974881, 5273.2617433559335, 5280.551153151987, 5282.841514754564, 5286.154215325549, 5289.0, 5259.421463639016, 5268.657537260085, 5273.920891186616, 5274.551663108621, 5278.1291086970605, 5184.455632158607, 5198.740062996835, 5287.894242115175, 5304.098303288451, 5307.177387504943, 5179.482051794828, 5232.058229518685, 5233.476652334774, 5247.10799164143, 5325.227841962933, 5592.6085174037835, 5603.7478313475995, 5688.4311568843195, 5691.630044047124, 5696.344920334173, 6138.263408390977, 6168.691565421711, 6169.0, 6273.937260627381, 6284.622922624611, 6144.600600960924, 6228.37716228378, 6270.184875966141, 6273.247210334789, 6279.434850863398, 5801.9129713054335, 5802.071668533014, 5807.912881306784, 5809.535237181015, 5813.273340832396, 6142.867137759775, 6179.196704428486, 6202.968985155046, 6218.31598524162, 6242.531810114259, 6131.754729810847, 6140.17107690456, 6151.138840562325, 6155.353687862799, 6180.938190618126, 6251.374862513803, 6253.968095264321, 6255.906161407583, 6260.217472815898, 6265.216847894013, 6086.452219300284, 6107.006761825686, 6135.961889924213, 6167.6916154193, 6224.968875155595, 6210.782622608187, 6218.22272215973, 6235.844103897439, 6246.812595622138, 6268.843278918063, 4910.312556242129, 4918.0, 4922.138625740481, 4924.285978533093, 4954.975225123923, 3841.2509560635967, 4233.920350310713, 4398.670099742532, 4404.603585677304, 4417.977910110429, 5685.914711279334, 5753.194552762617, 5756.625819321731, 5759.049756790167, 5760.36635970043, 5227.424983251839, 6153.907691384633, 6227.626342419469, 6245.812625621239, 6250.1874756281395, 5770.942290577124, 5825.359210486843, 5833.183354330397, 5840.941590584125, 5885.176075349455, 5353.892922141536, 5372.543333816591, 5373.38206106295, 5377.166539186433, 5446.700431476307, 6151.661658608819, 6236.407541283571, 6237.563370564017, 6295.307516173218, 6299.779507717208, 6146.985747351637, 6214.40963108504, 6214.943459611786, 6230.470410015199, 6238.968805155945, 6247.718852651551, 6283.120363149254, 6295.024271237966, 6295.087212354275, 6296.307406185224, 6081.483073938764, 6117.401149625394, 6145.0782382642965, 6181.196444462191, 6199.256089269316, 6146.139540464249, 6152.200213972155, 6225.066240063846, 6236.158118653923, 6239.937600623935, 4639.44326680787, 5596.3284405871555, 6108.908366374597, 6119.2350956130485, 6125.754969801158, 5932.347441781314, 6120.908186377297, 6126.5711400203345, 6141.232345956755, 6142.0, 5005.0, 5918.644881307136, 5920.111983202381, 5935.732892019783, 6000.099388759166, 6080.179175811209, 6115.266168059861, 6121.204243448323, 6137.3248942617165, 6146.78486252979, 5945.078512830518, 5990.0, 5990.460858522754, 5994.0109881869, 5997.4002599741425], "unit": "score", "name": "dojo.html", "value": 5682.07187786507}, {"lowerIsBetter": false, "replicates": [553.06808028472, 571.2373980735716, 582.7936172123703, 586.222812251676, 618.9690515474225, 28953.565696514543, 29163.270918227056, 29202.977895773653, 29209.415811683753, 29401.0, 30033.849830750816, 31031.689683103163, 38251.234975300475, 38269.0, 38320.658776942815, 9381.624735010608, 9606.903930960705, 9620.567074481665, 9626.807463850719, 9642.614295428175, 9391.953040234823, 9540.093691099335, 9551.80896382072, 9558.56986435612, 9578.473183974878, 8251.0, 9480.525973701322, 9587.328886977913, 9646.083622055894, 9675.70972870815, 8695.173958473935, 9400.730901328301, 9494.620215191384, 9669.323147379686, 9673.467959262238, 9401.858972115424, 9529.428234305895, 9531.571079301448, 9533.427994320364, 9550.90449095507, 36785.81607091974, 37001.814990924875, 37150.256994860225, 37204.44193337102, 38705.806470967465, 2747.219897166075, 3252.235724604716, 3261.347730453895, 3271.2149084219855, 3627.3470775260444, 28447.0, 28855.711442885724, 28988.0, 29543.852280738458, 29636.851815741, 2706.9729302707115, 2765.405437830876, 2805.466961277351, 2815.6902740698506, 2850.116463896178, 482453.0, 483341.0, 484327.0, 485052.5747371276, 486094.99999999645, 53591.19613205805, 54563.0, 54695.726521367935, 62175.0, 63171.368286316545, 60175.0, 60697.39302606917, 60929.781404371664, 61116.0, 61479.692601536706, 14590.197539135237, 15667.059976401453, 15805.288762005737, 15864.762028569581, 15865.20673966297, 10972.396518191576, 11021.173411994132, 12183.817242741366, 12535.435905384098, 12537.247765134121, 16495.103063147653, 18522.0, 18898.338558150397, 19019.61960760777, 19070.42788716341, 7192.82017949545, 7353.742619008416, 8256.876146857801, 8299.045609754956, 8545.444546104483, 920.7467946314817, 937.6624415210518, 943.7027336389153, 949.6913503111516, 952.3952290295712, 23112.65331020036, 28152.577711334347, 28247.858760706065, 29794.851025745167, 30364.0, 1051.0, 1066.5253961986996, 1083.8970297821852, 1124.707576030238, 1172.648205538335, 11323.37721425313, 13475.393607287695, 13639.704228098315, 13750.518731844537, 13770.724585508233, 533898.3305083449, 546709.0, 547809.0, 548813.0, 549650.0, 51777.741111294956, 51815.0, 51964.0, 52037.7398113007, 52117.218241726405, 1387.549046559872, 1408.8943329250142, 1409.7603407420763, 1418.276678893751, 1541.7533194688797, 27179.0, 27264.86367568229, 27828.582571261853, 27879.024234151708, 27979.0, 46423.76788116173, 47822.5217747832, 47862.52137478581, 47915.28127078166, 48300.27549586689, 496278.0, 503853.0, 507914.4604276955, 562522.0, 643831.0, 30220.24449388783, 30223.546646799874, 30425.391492170475, 30477.695223047485, 30547.694523054484, 42361.36457953072, 42570.14859702851, 42578.78710606427, 43132.56867431411, 43870.561294387924, 31030.0, 35902.0, 36156.63843361533, 36495.63504365028, 36684.81657591695, 27780.861095694392, 30087.94692185763, 34088.65911340855, 34479.0, 34961.475577865844, 33506.994790156336, 34250.48624270688, 34480.65519344775, 34558.0, 34569.654303457646, 30709.53935691011, 31083.22291942629, 31611.84194079015, 32210.194745130622, 32410.675893240765, 22890.885545572164, 24055.51888962246, 31414.52878206783, 31751.68248317487, 32473.863414780368], "unit": "score", "name": "ext.html", "value": 18976.110090590046}, {"lowerIsBetter": false, "replicates": [362.14533700466893, 368.7105622086661, 370.457280084676, 372.2814967113472, 377.8998565380173, 14968.625784355369, 15540.145292008934, 18681.346152884653, 19308.90345548272, 20177.798222017795, 15715.135667538309, 17221.0, 18471.076446177703, 19301.324453644127, 19319.4204173875, 4642.767861606923, 5142.254373115905, 5709.200711900337, 5889.823305300848, 5893.911591326134, 3870.767753934773, 4055.776932268724, 4058.269511487931, 4815.807367705288, 5647.548196144298, 5846.093855452412, 5890.204822348992, 5904.2324497815225, 5909.704514774266, 6182.227221597301, 6189.783357582485, 6343.238811342622, 6344.587601805868, 6351.714172862232, 6382.521310901701, 5515.61390702651, 5559.749811258463, 5567.8886422271735, 5573.08044172711, 5578.748956296977, 13028.934855325662, 13283.45175247091, 17153.313867445286, 23624.40938976522, 24072.0, 2061.938141855747, 2160.3087012156116, 2238.608243557387, 2258.627326491127, 2313.4100804294967, 9692.127708506268, 9805.901940980642, 9951.955044720273, 11428.885711142866, 14124.364403601863, 1676.8155502894672, 1704.1053446940332, 1775.2366482412558, 1789.2306308287432, 1819.1904602451914, 84541.57729211314, 86328.56835715781, 88588.0, 98868.51697224619, 101025.49487252516, 7964.960175199087, 9029.729108126767, 10827.891721082688, 10870.510827012804, 10886.455677216107, 12881.549145779853, 12959.870401295866, 13082.495513015934, 13246.072774905664, 13266.204027758366, 8268.338532917352, 8288.668453261922, 8320.750377488685, 8384.161583841567, 8412.62143203545, 8432.229231861254, 8436.957815210884, 8443.873341899876, 8502.532360720095, 8544.829103417896, 4016.457778199964, 4297.763623000765, 4416.227160246944, 4422.447194100738, 4435.068635586563, 1743.5902562897709, 1791.6506281275026, 1791.802901680814, 1848.510144811626, 1850.3986204483597, 866.1252135343223, 871.350843621506, 901.6078006067381, 935.0976307862945, 1003.8193125237527, 16262.430814921658, 16507.3225198639, 19898.0, 20209.36231478348, 20406.0, 954.6491714224295, 979.2019504104132, 981.4896253947907, 999.9250056245811, 1024.779672370444, 10635.41505217205, 10852.348859068481, 10856.674299771019, 10873.510692018877, 10949.945250273699, 701931.0, 733260.0, 733849.0, 744585.0, 746307.0, 110469.0, 112938.0, 113606.0, 114538.0, 115152.0, 1136.3863513702508, 1136.8237923121928, 1187.252031220343, 1191.600813727411, 1202.380773901459, 17349.566260843076, 17677.734833977243, 17949.820501795337, 18174.0, 18387.632247355246, 49364.0, 50107.0, 50383.0, 50509.73725656888, 50532.0, 68024.3197568018, 69461.65269173622, 70154.64922675354, 70493.23766905868, 70945.6452717733, 7234.9871018056465, 7323.780286591411, 7454.366378857858, 7604.733834315773, 7605.163432022584, 9052.0, 9234.769130771785, 11652.883471165518, 11885.0, 11887.346195959306, 9245.583948722458, 9921.851172232278, 10137.543810528396, 10188.0, 10331.483425828828, 9750.122488976027, 9928.553215105481, 10060.346077504939, 10115.747106322106, 10214.948925255623, 8708.825823483621, 9667.371620844622, 10351.96480351989, 10586.788264234518, 10625.309354891908, 7426.0, 7496.212897645669, 7581.810454738676, 7601.277878601524, 7603.923960760321, 8381.0, 9411.4823684698, 10186.847197292194, 10272.126869216201, 10367.481625918825], "unit": "score", "name": "jquery.html", "value": 8972.672756494536}, {"lowerIsBetter": false, "replicates": [1382.7856682214258, 1403.9298035098243, 1536.0553259745257, 1745.5897864001965, 1931.6812725900227, 7888.9211107888905, 8098.2306680865295, 8507.787305317363, 8683.392162548624, 8684.218420342168, 8432.620532076056, 8529.97640283167, 8636.956815215915, 8655.48067115972, 8657.870131948026, 2179.063002908749, 2213.7786221377814, 2468.580341341967, 2491.5266099441137, 2492.0903870087377, 1985.5135491804529, 2204.7023651806962, 2498.1381423408984, 2502.024210557884, 2502.06172685243, 2420.3586049696755, 2461.938451538717, 2468.6297055441737, 2474.7030356357263, 2478.9752102478924, 2419.552382809186, 2457.2628211536558, 2459.7417271186628, 2462.6059830427134, 2479.2438306316567, 2455.8280920335583, 2457.4716435966175, 2458.6557881896547, 2466.0, 2468.987655061731, 8748.431351962103, 8785.297176225886, 8817.823643527157, 8828.205461508494, 8834.425762325493, 5326.0, 5485.451454854522, 5505.421930697299, 5513.641613295123, 5516.7517461714315, 3617.963820361815, 3682.4476328550663, 3767.2653832502674, 3771.7548359356556, 3792.0, 1048.3028785857396, 1064.7604289034982, 1073.313079629038, 1093.557109370706, 1102.2394547762099, 11805.527778888834, 11808.055355571534, 11816.527338906433, 11822.645320640395, 11871.347075910822, 4871.196252618349, 4910.803567857317, 4942.0, 5010.323606313101, 5017.222330538772, 10189.388636681822, 10224.795504089876, 10235.232357573212, 10254.743631409274, 10279.845802312972, 4730.290456431563, 5538.972305138448, 5544.861378465571, 5545.77816887328, 5563.221149039137, 4924.8276310328965, 4974.37820272466, 5043.142665746832, 5043.596512279082, 5044.646874718808, 3687.760295580779, 3764.247150569897, 3772.8490860365278, 3978.980105099514, 4004.4994375703036, 1282.8909542688975, 1297.1049975516862, 1298.1237664576374, 1311.3705421397592, 1315.1254415813569, 1313.1530163044974, 1320.4718112754783, 1332.2006795922368, 1333.6665833541615, 1354.925479098659, 6692.163479565054, 7930.682772689028, 7958.84082318362, 7982.361411087099, 7990.760277191694, 1172.0447835014436, 1177.4407156600716, 1184.514349116858, 1184.579474286633, 1203.1638011582043, 6192.071189321638, 6281.403266689657, 6287.151234583364, 6292.559520833498, 6295.716692748837, 9970.850437243302, 10251.231157663206, 10259.0, 10422.957704229668, 10426.270161088803, 10157.238207134495, 10313.690589282334, 10364.740881478023, 10406.635767748245, 10432.217583681255, 8028.799280017929, 8163.959180204061, 8246.628901699438, 8252.711155109662, 8254.669813207525, 7258.891116633149, 7704.422168337509, 7850.764477065697, 8003.039635243808, 8014.19858014194, 9373.68768372442, 9374.250059995047, 9447.433154010781, 9456.101670341306, 9595.904040959502, 9625.71122866315, 9883.901160988298, 9925.95777443358, 9992.00079991995, 10015.449150296512, 7267.7819665410125, 7386.778396648109, 7537.095548534211, 7553.697852085855, 7568.318851303409, 7371.852562948819, 7587.886181707168, 7591.430642701709, 8174.182581741778, 8294.29498492635, 6154.415330543591, 7603.923960760543, 7691.269329413697, 7709.80725481845, 7766.262205090507, 6717.227518835396, 7560.054993125859, 7604.5437273763755, 7627.0, 7742.187070357757, 7735.613219339123, 7779.57212353326, 7797.493162944391, 7836.138024817152, 7874.488158269694, 7069.469789765685, 7095.751648692478, 7100.964495177698, 7111.466640002124, 7112.964435177791, 7140.750073747394, 7176.712931482891, 7201.567905925661, 7227.385672217921, 7241.312075352833], "unit": "score", "name": "mootools.html", "value": 4935.068856060664}, {"lowerIsBetter": false, "replicates": [318.20448877805484, 324.0650722665112, 327.95736554247975, 329.3363871798326, 334.6736931491794, 6288.496920246381, 6468.482521398289, 6484.124643173182, 6576.243731970819, 6651.60090394576, 6302.684865756705, 6443.420092191702, 6455.128557644716, 6465.9977703455925, 6501.967490162554, 4836.081144582518, 4872.805087796484, 4879.0, 4879.316895634614, 4884.998575292075, 4583.8166473341025, 4864.659473836833, 4865.294532292815, 4887.120318342697, 4899.951000489985, 4479.17135329965, 4759.738214398207, 4793.7363445010515, 4816.97591512042, 4838.467768545457, 4802.903941921177, 4805.879853003668, 4836.516348365135, 4849.3453383793085, 4855.344528488662, 4128.112455821983, 4143.482064741907, 4145.626893579592, 4161.979190104061, 4172.0, 5958.225430694026, 6181.979973304399, 6211.47202487789, 6251.781187658456, 6260.0, 5061.721605311706, 5639.605227634067, 5655.26481557399, 5660.405657405954, 5676.063449530822, 6486.837829054264, 6905.240423553405, 6905.861882762317, 6928.4803639726715, 6946.895796563055, 4591.701539399928, 4599.517050709695, 4617.353570500132, 4618.607418369443, 4620.884477888046, 5869.677167755772, 6991.8601627967155, 7236.407990242138, 7287.708491660327, 7375.59434231117, 4515.961328894373, 4546.40896683429, 4548.795304211319, 4553.954460455419, 4561.2245918193985, 3622.8188590570894, 4442.044960333544, 4458.108378324348, 4603.987122832971, 4620.44554653437, 4700.529947005272, 5339.279197308391, 5408.59435542328, 5444.265024221759, 5469.890602187934, 6855.6572171391235, 6872.450203983669, 6938.861222775517, 6958.373746362851, 6969.128858892638, 1569.4899157773768, 1599.8160211575585, 1600.7918970533756, 1603.8315976822498, 1607.2044338052738, 770.7186876789931, 1002.0780881588955, 1031.7265924530006, 1044.1646682653848, 1044.3577200021932, 6497.480201583862, 6513.544051916415, 6514.185726784152, 6528.51036172289, 6536.117624120778, 7179.030830837874, 7183.06620139389, 7204.603746793977, 7204.855902882018, 7205.207427183006, 6243.656598887105, 6513.120728701565, 6515.576487528296, 6537.771178008747, 6541.116949211891, 3768.6419790119894, 3818.59904710007, 3818.694504439638, 3820.9301395609273, 3825.464434979105, 7494.276316447248, 7499.6250187490405, 7522.774316770506, 7530.209328020588, 7532.246775322424, 6032.4570788629235, 7111.679974401164, 7414.406847452191, 7432.108147022283, 7466.477346585795, 6107.877842443127, 7520.285572870568, 7554.773356799305, 7560.659770310349, 7578.280063393969, 7216.314450127229, 7220.277972202738, 7225.24134965842, 7259.382952449101, 7265.7093716252875, 6875.449964002968, 7109.289071093056, 7109.431245500244, 7131.322524360177, 7144.106986626672, 7541.0, 7544.396448284234, 7545.132309784445, 7559.244075592397, 7564.697412103455, 3772.5095737553943, 4505.662075344297, 4555.908881822279, 4560.52114527983, 4566.657500687395, 6975.581465112109, 7162.247963963709, 7191.640417978975, 7202.135743710788, 7231.5299505531975, 6945.479089068239, 6962.756303529352, 6972.546784458994, 6982.79051628452, 6982.825429364103, 6743.494237932076, 6949.861002780017, 6957.8956315654295, 6960.408365289007, 6969.30306969299, 6751.0, 6779.0, 6784.151981002375, 6784.626845523544, 6797.694103765243, 6934.930650693428, 6938.653067346713, 6941.514094013371, 6948.305169483011, 6952.026716259828, 6526.347365263436, 6806.353396427331, 6812.352826481477, 6816.386525212754, 6827.317268273332], "unit": "score", "name": "prototype.html", "value": 5054.372482387913}, {"lowerIsBetter": false, "replicates": [665.2349797732606, 730.1566690472505, 734.9338559529641, 751.5978951261077, 756.6216891554219, 14216.786748198772, 14381.280935953188, 14387.992840501156, 14394.064385814941, 14402.495912643046, 15125.848741512582, 15466.690666186669, 15472.767908481383, 15480.845191548082, 15504.147271900069, 686.5777546808702, 702.4906942466696, 832.7543374704461, 863.1196179896501, 869.5130726792985, 701.6141122382695, 705.0552259971637, 705.4039336760455, 705.5942832871119, 839.2237180607913, 901.1304091551651, 911.9452832830018, 913.4291068082448, 913.7624217703411, 914.3142643017736, 903.9819203615924, 904.5296445848188, 906.8730377747088, 907.850204716221, 908.6592527802075, 526.2028027538282, 537.9838604841862, 538.2437675066537, 538.5126460553206, 540.2139886465224, 12219.26684398939, 14542.054766440147, 14833.0, 14846.0, 14856.62858428537, 10975.890241097566, 11037.889621103766, 12092.274463532216, 12670.80993785094, 12933.611991640266, 10207.846882296772, 10285.02292282232, 10317.174626029975, 10380.221483388701, 10983.340999540053, 3478.3912815257227, 3577.159367548624, 3585.2829434113282, 3585.587657419378, 3591.0842735102383, 78086.21913780904, 79647.6017619914, 80151.19848801495, 80261.0, 80874.97812554674, 9636.951815240878, 9637.42175469474, 9670.178034867115, 9871.358361706467, 9955.402675839472, 21970.231041913456, 21984.45038874041, 21992.45018874509, 22028.669569956463, 22047.559048818934, 7462.85074298511, 7535.472516923763, 7611.4291428143115, 7646.120696119906, 7770.572618505923, 4096.713230073926, 4137.50349958007, 4173.603507666767, 4183.707140500136, 4238.87283381499, 3629.8911032668534, 3687.410014397737, 3689.631036896289, 3689.985254055103, 3715.981420092882, 661.3122352753082, 671.6977360187935, 682.2324884504932, 682.6450245872119, 683.3883674111643, 476.6901514015848, 551.203510926707, 581.2327727399876, 606.1967892542399, 623.8128561431553, 8283.668653253802, 8375.8324833503, 8403.478468637562, 8681.522516261666, 8769.605367758466, 511.1412826451523, 588.1383772772823, 598.2671227745976, 602.5179856115091, 616.5468380740152, 3812.426238814474, 3973.5231772186944, 3985.7608543487486, 4107.240160570244, 4140.937885931713, 82761.0, 83536.0, 84214.57892710497, 90105.0, 90551.0, 75699.62150189324, 76234.0, 76909.61545192238, 78338.0, 78837.0, 55235.514401852015, 58167.12749308764, 66030.0095498568, 67596.3100922471, 68329.0, 6508.284088750328, 8030.799230019296, 8138.771776310613, 8273.793155170928, 8294.212049855254, 44816.10367792561, 45327.32009019933, 45554.0, 45560.08879822451, 46904.82737931579, 61359.0, 61742.382576173666, 62055.689721551105, 63179.36820631919, 66487.66756166189, 10221.9488902555, 10224.335418197794, 10357.4303413313, 10363.94818025905, 10950.959658832398, 10387.792244155225, 11649.0, 11791.469383877919, 12319.630411087322, 12680.809787853004, 11203.271787333797, 11222.214444988773, 11228.214025018171, 11539.538418463504, 12226.938865305616, 11272.0, 11473.541058357572, 11617.709557261136, 11643.243189192675, 11948.701282468008, 10680.038796508352, 10877.945610271898, 11078.889211107786, 11254.7749045017, 11562.901524355173, 9085.091490851126, 9294.9535252326, 9307.813843723223, 9378.95310523443, 9380.437173769596, 8879.600417981335, 9159.450432974043, 9254.629814807602, 9658.3722058066, 9993.800123997335], "unit": "score", "name": "yui.html", "value": 6717.319217210747}], "name": "dromaeo_css", "value": 7384.213866432767}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 111.0, 112.0, 112.0, 115.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 149.0, 163.0, 115.0, 145.0, 138.0, 119.0, 160.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 138.8}, {"lowerIsBetter": true, "replicates": [188.0, 183.0, 186.0, 187.0, 190.0, 187.0, 186.0, 187.0, 185.0, 185.0], "unit": "score", "name": "audio-dft", "value": 186.4}, {"lowerIsBetter": true, "replicates": [84.0, 75.0, 90.0, 82.0, 76.0, 78.0, 82.0, 96.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [97.0, 101.0, 128.0, 79.0, 80.0, 80.0, 108.0, 81.0, 109.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 100.3}, {"lowerIsBetter": true, "replicates": [87.0, 121.0, 87.0, 92.0, 85.0, 90.0, 84.0, 90.0, 87.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 105.0], "unit": "score", "name": "imaging-darkroom", "value": 95.7}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 94.0, 83.0, 86.0, 85.0, 84.0, 86.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 54.0, 53.0, 54.0, 52.0, 55.0, 63.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 68.0, 78.0, 73.0, 68.0, 68.0, 68.0, 67.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 80.0, 82.0, 82.0, 84.0, 83.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [131.0, 127.0, 117.0, 120.0, 123.0, 120.0, 132.0, 123.0, 117.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 141.0, 139.0, 138.0, 125.0, 140.0, 169.0, 168.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 65.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1428.0}]} 04:52:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1428.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7384.21"}}} 04:52:47 INFO - Return code: 0 04:52:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:47 INFO - # TBPL SUCCESS # 04:52:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:47 INFO - 2016-02-06 04:52:47.962 screenresolution[2678:29669] starting screenresolution argv=screenresolution get 04:52:47 INFO - 2016-02-06 04:52:47.964 screenresolution[2678:29669] Display 0: 1600x1200x32@60 04:52:47 INFO - 2016-02-06 04:52:47.970 screenresolution[2679:29672] starting screenresolution argv=screenresolution list 04:52:47 INFO - Available Modes on Display 0 04:52:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:48 INFO - Intel Iris: 04:52:48 INFO - Chipset Model: Intel Iris 04:52:48 INFO - Type: GPU 04:52:48 INFO - Bus: Built-In 04:52:48 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:48 INFO - Vendor: Intel (0x8086) 04:52:48 INFO - Device ID: 0x0a2e 04:52:48 INFO - Revision ID: 0x0009 04:52:48 INFO - Displays: 04:52:48 INFO - Display: 04:52:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:48 INFO - Display Serial Number: 1600x1200 60 04:52:48 INFO - Main Display: Yes 04:52:48 INFO - Mirror: Off 04:52:48 INFO - Online: Yes 04:52:48 INFO - Rotation: Supported 04:52:48 INFO - Return code: 0 04:52:48 INFO - Running post-action listener: _resource_record_post_action 04:52:48 INFO - Running post-run listener: _resource_record_post_run 04:52:49 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2338816; Write bytes: 711135232; Read time: 34; Write time: 1870 04:52:49 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386482688; Write bytes: 382055936; Read time: 29521; Write time: 697 04:52:49 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2338816; Write bytes: 303700480; Read time: 34; Write time: 1119 04:52:49 INFO - Running post-run listener: _upload_blobber_files 04:52:49 INFO - Blob upload gear active. 04:52:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:49 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 04:52:49 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'] 04:52:49 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 04:52:49 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:50 INFO - (blobuploader) - INFO - Done attempting. 04:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:51 INFO - (blobuploader) - INFO - Done attempting. 04:52:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:51 INFO - Return code: 0 04:52:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4b13dff4332ba6583b5686caa12bd4cedad15646d454255ceda6069c14cbc395849ba18728803c4a1cc0afa3e20850afda2d1267eae41fd3fb7dd7e79774ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d243e34e591f36b027a2d235a83c2f0363747274b3f1bafec4d35035748fa5f6eba2f7445165c7d3a3dbf7b5c4977ab2a1d37d036661f47d05ef68ab7193ba8c"} 04:52:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:51 INFO - Contents: 04:52:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4b13dff4332ba6583b5686caa12bd4cedad15646d454255ceda6069c14cbc395849ba18728803c4a1cc0afa3e20850afda2d1267eae41fd3fb7dd7e79774ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d243e34e591f36b027a2d235a83c2f0363747274b3f1bafec4d35035748fa5f6eba2f7445165c7d3a3dbf7b5c4977ab2a1d37d036661f47d05ef68ab7193ba8c"} 04:52:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:51 INFO - Copying logs to upload dir... 04:52:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.525685 ========= master_lag: 17.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-06 04:53:08.979683) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-06 04:53:08.983385) ========= 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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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/1b4b13dff4332ba6583b5686caa12bd4cedad15646d454255ceda6069c14cbc395849ba18728803c4a1cc0afa3e20850afda2d1267eae41fd3fb7dd7e79774ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d243e34e591f36b027a2d235a83c2f0363747274b3f1bafec4d35035748fa5f6eba2f7445165c7d3a3dbf7b5c4977ab2a1d37d036661f47d05ef68ab7193ba8c"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010685 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b4b13dff4332ba6583b5686caa12bd4cedad15646d454255ceda6069c14cbc395849ba18728803c4a1cc0afa3e20850afda2d1267eae41fd3fb7dd7e79774ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d243e34e591f36b027a2d235a83c2f0363747274b3f1bafec4d35035748fa5f6eba2f7445165c7d3a3dbf7b5c4977ab2a1d37d036661f47d05ef68ab7193ba8c"}' ========= master_lag: 1.66 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-06 04:53:10.658804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 16 secs) (at 2016-02-06 04:53:10.659105) ========= 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.Y3hzqy6VsG/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.MRwUpOY0eh/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005338 ========= master_lag: 16.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 16 secs) (at 2016-02-06 04:53:26.806415) ========= ========= Started reboot skipped (results: 3, elapsed: 14 secs) (at 2016-02-06 04:53:26.806825) ========= ========= Finished reboot skipped (results: 3, elapsed: 14 secs) (at 2016-02-06 04:53:41.089055) ========= ========= Total master_lag: 40.85 =========