builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1458579105.43 results: success (0) buildid: 20160321080446 builduid: dc52b6ce138d4d7ab12e2f03841ba24c revision: af22a2e633c03d496fdb832a0abc9d9253fff148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 09:51:45.432886) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 09:51:45.433351) ========= ========= Started set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-21 09:51:45.433652) ========= 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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005709 basedir: '/builds/slave/test' ========= master_lag: 7.82 ========= ========= Finished set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-21 09:51:53.264005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 50 secs) (at 2016-03-21 09:51:53.264480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 50 secs) (at 2016-03-21 09:52:43.399371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-21 09:52:43.399641) ========= 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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005477 ========= master_lag: 6.80 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-21 09:52:50.202760) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 09:52:50.203049) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 09:52:50.203396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-21 09:52:50.210135) ========= 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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-21 09:52:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.67M=0.002s 2016-03-21 09:52:51 (7.67 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133847 ========= master_lag: 8.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-21 09:52:58.603348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2016-03-21 09:52:58.603670) ========= 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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.033574 ========= master_lag: 9.61 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2016-03-21 09:53:08.245579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-21 09:53:08.245897) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af22a2e633c03d496fdb832a0abc9d9253fff148 --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 af22a2e633c03d496fdb832a0abc9d9253fff148 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-21 09:53:09,119 truncating revision to first 12 chars 2016-03-21 09:53:09,120 Setting DEBUG logging. 2016-03-21 09:53:09,120 attempt 1/10 2016-03-21 09:53:09,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af22a2e633c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 09:53:10,699 unpacking tar archive at: fx-team-af22a2e633c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.829453 ========= master_lag: 7.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-21 09:53:17.241929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 8 secs) (at 2016-03-21 09:53:17.244471) ========= echo af22a2e633c03d496fdb832a0abc9d9253fff148 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'af22a2e633c03d496fdb832a0abc9d9253fff148'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 af22a2e633c03d496fdb832a0abc9d9253fff148 program finished with exit code 0 elapsedTime=0.005907 script_repo_revision: 'af22a2e633c03d496fdb832a0abc9d9253fff148' ========= master_lag: 8.10 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 8 secs) (at 2016-03-21 09:53:25.349138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2016-03-21 09:53:25.349458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2016-03-21 09:53:50.731846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-21 09:53:50.732101) ========= /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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:53:50 INFO - MultiFileLogger online at 20160321 09:53:50 in /builds/slave/test 09:53:50 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 09:53:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:53:50 INFO - {'append_to_log': False, 09:53:50 INFO - 'base_work_dir': '/builds/slave/test', 09:53:50 INFO - 'blob_upload_branch': 'Fx-Team', 09:53:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:53:50 INFO - 'branch': 'Fx-Team', 09:53:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:53:50 INFO - 'config_files': ('talos/mac_config.py',), 09:53:50 INFO - 'default_actions': ('clobber', 09:53:50 INFO - 'read-buildbot-config', 09:53:50 INFO - 'download-and-extract', 09:53:50 INFO - 'populate-webroot', 09:53:50 INFO - 'create-virtualenv', 09:53:50 INFO - 'install', 09:53:50 INFO - 'run-tests'), 09:53:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:53:50 INFO - 'download_minidump_stackwalk': True, 09:53:50 INFO - 'download_symbols': 'ondemand', 09:53:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:53:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:53:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:53:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:53:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:53:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:53:50 INFO - 'installer_path': 'installer.exe', 09:53:50 INFO - 'log_level': 'info', 09:53:50 INFO - 'log_name': 'talos', 09:53:50 INFO - 'log_to_console': True, 09:53:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:53:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:53:50 INFO - 'opt_config_files': (), 09:53:50 INFO - 'pip_index': False, 09:53:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:50 INFO - 'cmd': ('bash', 09:53:50 INFO - '-c', 09:53:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:50 INFO - 'enabled': True, 09:53:50 INFO - 'halt_on_failure': False, 09:53:50 INFO - 'name': 'check_screen_resolution'},), 09:53:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:53:50 INFO - 'cmd': ('bash', 09:53:50 INFO - '-c', 09:53:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:53:50 INFO - 'enabled': True, 09:53:50 INFO - 'halt_on_failure': False, 09:53:50 INFO - 'name': 'check_screen_resolution'},), 09:53:50 INFO - 'run_cmd_checks_enabled': True, 09:53:50 INFO - 'sps_profile': False, 09:53:50 INFO - 'sps_profile_interval': 0, 09:53:50 INFO - 'suite': 'dromaeojs', 09:53:50 INFO - 'system_bits': '32', 09:53:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:53:50 INFO - 'title': 't-yosemite-r7-0138', 09:53:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:53:50 INFO - 'use_talos_json': True, 09:53:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:53:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:53:50 INFO - 'work_dir': 'build'} 09:53:50 INFO - ##### 09:53:50 INFO - ##### Running clobber step. 09:53:50 INFO - ##### 09:53:50 INFO - Running pre-action listener: _resource_record_pre_action 09:53:50 INFO - Running main action method: clobber 09:53:50 INFO - rmtree: /builds/slave/test/build 09:53:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:53:52 INFO - Running post-action listener: _resource_record_post_action 09:53:52 INFO - ##### 09:53:52 INFO - ##### Running read-buildbot-config step. 09:53:52 INFO - ##### 09:53:52 INFO - Running pre-action listener: _resource_record_pre_action 09:53:52 INFO - Running main action method: read_buildbot_config 09:53:52 INFO - Using buildbot properties: 09:53:52 INFO - { 09:53:52 INFO - "project": "", 09:53:52 INFO - "product": "firefox", 09:53:52 INFO - "script_repo_revision": "production", 09:53:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:53:52 INFO - "repository": "", 09:53:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:53:52 INFO - "buildid": "20160321080446", 09:53:52 INFO - "pgo_build": "False", 09:53:52 INFO - "basedir": "/builds/slave/test", 09:53:52 INFO - "buildnumber": 595, 09:53:52 INFO - "slavename": "t-yosemite-r7-0138", 09:53:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:53:52 INFO - "platform": "yosemite_r7", 09:53:52 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:53:52 INFO - "branch": "fx-team", 09:53:52 INFO - "repo_path": "integration/fx-team", 09:53:52 INFO - "revision": "af22a2e633c03d496fdb832a0abc9d9253fff148", 09:53:52 INFO - "stage_platform": "macosx64", 09:53:52 INFO - "builduid": "dc52b6ce138d4d7ab12e2f03841ba24c", 09:53:52 INFO - "slavebuilddir": "test" 09:53:52 INFO - } 09:53:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:53:52 INFO - Running post-action listener: _resource_record_post_action 09:53:52 INFO - ##### 09:53:52 INFO - ##### Running download-and-extract step. 09:53:52 INFO - ##### 09:53:52 INFO - Running pre-action listener: _resource_record_pre_action 09:53:52 INFO - Running main action method: download_and_extract 09:53:52 INFO - mkdir: /builds/slave/test/build/tests 09:53: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')]} 09:53:52 INFO - https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:53:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:53:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:53:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:53:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 09:53:54 INFO - Downloaded 1199 bytes. 09:53:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:53:54 INFO - Using the following test package requirements: 09:53:54 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:53:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:53:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:53:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'jsshell-mac.zip'], 09:53:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:53:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:53:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:53:54 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:53:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:53:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:53:54 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:53:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:54 INFO - https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:53:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:53:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:53:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:53:55 INFO - Downloaded 17858225 bytes. 09:53:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:53:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:53:58 INFO - Return code: 0 09:53:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:58 INFO - https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:54:00 INFO - Downloaded 17858225 bytes. 09:54:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:54:04 INFO - Return code: 0 09:54:04 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')]} 09:54:04 INFO - https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:54:05 INFO - Downloaded 10847637 bytes. 09:54:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:54:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:54:05 INFO - Return code: 0 09:54:05 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')]} 09:54:05 INFO - https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:54:11 INFO - Downloaded 111261035 bytes. 09:54:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:54:11 INFO - mkdir: /builds/slave/test/properties 09:54:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:54:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:54:11 INFO - Contents: 09:54:11 INFO - build_url:https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:54:11 INFO - Running post-action listener: _resource_record_post_action 09:54:11 INFO - Running post-action listener: set_extra_try_arguments 09:54:11 INFO - ##### 09:54:11 INFO - ##### Running populate-webroot step. 09:54:11 INFO - ##### 09:54:11 INFO - Running pre-action listener: _resource_record_pre_action 09:54:11 INFO - Running main action method: populate_webroot 09:54:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:54:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:54:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:54:11 INFO - '--tppagecycles', 09:54:11 INFO - '7'], 09:54:11 INFO - 'tests': ['tsvgm']}}, 09:54:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:54:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:54:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:54:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:54:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:54:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'tests': ['damp', 'tps']}, 09:54:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['damp', 'tps']}, 09:54:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:54:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:54:11 INFO - 'other': {'tests': ['a11yr', 09:54:11 INFO - 'ts_paint', 09:54:11 INFO - 'tpaint', 09:54:11 INFO - 'sessionrestore', 09:54:11 INFO - 'sessionrestore_no_auto_restore', 09:54:11 INFO - 'tabpaint']}, 09:54:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['a11yr', 09:54:11 INFO - 'ts_paint', 09:54:11 INFO - 'tpaint', 09:54:11 INFO - 'sessionrestore', 09:54:11 INFO - 'sessionrestore_no_auto_restore', 09:54:11 INFO - 'tabpaint']}, 09:54:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['a11yr', 09:54:11 INFO - 'ts_paint', 09:54:11 INFO - 'tpaint', 09:54:11 INFO - 'sessionrestore', 09:54:11 INFO - 'sessionrestore_no_auto_restore', 09:54:11 INFO - 'tabpaint']}, 09:54:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['a11yr', 09:54:11 INFO - 'ts_paint', 09:54:11 INFO - 'tpaint', 09:54:11 INFO - 'sessionrestore', 09:54:11 INFO - 'sessionrestore_no_auto_restore', 09:54:11 INFO - 'tabpaint']}, 09:54:11 INFO - 'other_l64': {'tests': ['a11yr', 09:54:11 INFO - 'ts_paint', 09:54:11 INFO - 'tpaint', 09:54:11 INFO - 'sessionrestore', 09:54:11 INFO - 'sessionrestore_no_auto_restore', 09:54:11 INFO - 'tabpaint']}, 09:54:11 INFO - 'other_nol64': {'tests': ['a11yr', 09:54:11 INFO - 'ts_paint', 09:54:11 INFO - 'tpaint', 09:54:11 INFO - 'sessionrestore', 09:54:11 INFO - 'sessionrestore_no_auto_restore', 09:54:11 INFO - 'tabpaint']}, 09:54:11 INFO - 'svgr': {'tests': ['tsvgx', 09:54:11 INFO - 'tsvgr_opacity', 09:54:11 INFO - 'tart', 09:54:11 INFO - 'tscrollx', 09:54:11 INFO - 'cart']}, 09:54:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['tsvgx', 09:54:11 INFO - 'tsvgr_opacity', 09:54:11 INFO - 'tart', 09:54:11 INFO - 'tscrollx', 09:54:11 INFO - 'cart']}, 09:54:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'tests': ['tp5o']}, 09:54:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'talos_options': ['--e10s'], 09:54:11 INFO - 'tests': ['tp5o']}, 09:54:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'talos_options': ['--xperf_path', 09:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:11 INFO - 'tests': ['tp5n']}, 09:54:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:54:11 INFO - 'talos_options': ['--e10s', 09:54:11 INFO - '--xperf_path', 09:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:54:11 INFO - 'tests': ['tp5n']}}, 09:54:11 INFO - 'talos.zip': {'path': '', 09:54:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:54:11 INFO - Running post-action listener: _resource_record_post_action 09:54:11 INFO - ##### 09:54:11 INFO - ##### Running create-virtualenv step. 09:54:11 INFO - ##### 09:54:11 INFO - Running pre-action listener: _resource_record_pre_action 09:54:11 INFO - Running main action method: create_virtualenv 09:54:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:54:11 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 09:54:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:54:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:54:12 INFO - Using real prefix '/tools/python27' 09:54:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:54:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:54:15 INFO - Installing pip.................done. 09:54:15 INFO - Return code: 0 09:54:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:15 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:15 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 09:54:15 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 09:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:15 INFO - 'HOME': '/Users/cltbld', 09:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:15 INFO - 'LOGNAME': 'cltbld', 09:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:15 INFO - 'MOZ_NO_REMOTE': '1', 09:54:15 INFO - 'NO_EM_RESTART': '1', 09:54:15 INFO - 'PAGER': '/bin/cat', 09:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:15 INFO - 'PWD': '/builds/slave/test', 09:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:15 INFO - 'SHELL': '/bin/bash', 09:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:15 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:15 INFO - 'USER': 'cltbld', 09:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:15 INFO - 'XPC_FLAGS': '0x0', 09:54:15 INFO - 'XPC_SERVICE_NAME': '0', 09:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:15 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 09:54:15 INFO - Cleaning up... 09:54:15 INFO - Return code: 0 09:54:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:15 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:15 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 09:54:15 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 09:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:15 INFO - 'HOME': '/Users/cltbld', 09:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:15 INFO - 'LOGNAME': 'cltbld', 09:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:15 INFO - 'MOZ_NO_REMOTE': '1', 09:54:15 INFO - 'NO_EM_RESTART': '1', 09:54:15 INFO - 'PAGER': '/bin/cat', 09:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:15 INFO - 'PWD': '/builds/slave/test', 09:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:15 INFO - 'SHELL': '/bin/bash', 09:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:15 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:15 INFO - 'USER': 'cltbld', 09:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:15 INFO - 'XPC_FLAGS': '0x0', 09:54:15 INFO - 'XPC_SERVICE_NAME': '0', 09:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:16 INFO - Downloading/unpacking psutil>=0.7.1 09:54:16 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 09:54:16 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 09:54:16 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 09:54:16 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 09:54:16 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 09:54:16 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 09:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:19 INFO - Installing collected packages: psutil 09:54:19 INFO - Running setup.py install for psutil 09:54:19 INFO - building 'psutil._psutil_osx' extension 09:54:19 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 09:54:20 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 09:54:20 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 09:54:20 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 09:54:20 INFO - building 'psutil._psutil_posix' extension 09:54:20 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 09:54:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:54:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:54:20 INFO - ^ 09:54:20 INFO - 1 warning generated. 09:54:20 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 09:54:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:20 INFO - Successfully installed psutil 09:54:20 INFO - Cleaning up... 09:54:20 INFO - Return code: 0 09:54:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:20 INFO - 'HOME': '/Users/cltbld', 09:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:20 INFO - 'LOGNAME': 'cltbld', 09:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:20 INFO - 'MOZ_NO_REMOTE': '1', 09:54:20 INFO - 'NO_EM_RESTART': '1', 09:54:20 INFO - 'PAGER': '/bin/cat', 09:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:20 INFO - 'PWD': '/builds/slave/test', 09:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:20 INFO - 'SHELL': '/bin/bash', 09:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:20 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:20 INFO - 'USER': 'cltbld', 09:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:20 INFO - 'XPC_FLAGS': '0x0', 09:54:20 INFO - 'XPC_SERVICE_NAME': '0', 09:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:54:23 INFO - Installing collected packages: mozsystemmonitor 09:54:23 INFO - Running setup.py install for mozsystemmonitor 09:54:23 INFO - Successfully installed mozsystemmonitor 09:54:23 INFO - Cleaning up... 09:54:23 INFO - Return code: 0 09:54:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:23 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:23 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 09:54:23 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 09:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:23 INFO - 'HOME': '/Users/cltbld', 09:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:23 INFO - 'LOGNAME': 'cltbld', 09:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:23 INFO - 'MOZ_NO_REMOTE': '1', 09:54:23 INFO - 'NO_EM_RESTART': '1', 09:54:23 INFO - 'PAGER': '/bin/cat', 09:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:23 INFO - 'PWD': '/builds/slave/test', 09:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:23 INFO - 'SHELL': '/bin/bash', 09:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:23 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:23 INFO - 'USER': 'cltbld', 09:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:23 INFO - 'XPC_FLAGS': '0x0', 09:54:23 INFO - 'XPC_SERVICE_NAME': '0', 09:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:54:23 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 09:54:23 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 09:54:23 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 09:54:23 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 09:54:23 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 09:54:23 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 09:54:26 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:27 INFO - Downloading docopt-0.6.1.tar.gz 09:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:27 INFO - Running setup.py install for blobuploader 09:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:27 INFO - Running setup.py install for requests 09:54:28 INFO - Running setup.py install for docopt 09:54:28 INFO - Successfully installed blobuploader requests docopt 09:54:28 INFO - Cleaning up... 09:54:28 INFO - Return code: 0 09:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:28 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:28 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 09:54:28 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 09:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:28 INFO - 'HOME': '/Users/cltbld', 09:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:28 INFO - 'LOGNAME': 'cltbld', 09:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:28 INFO - 'MOZ_NO_REMOTE': '1', 09:54:28 INFO - 'NO_EM_RESTART': '1', 09:54:28 INFO - 'PAGER': '/bin/cat', 09:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:28 INFO - 'PWD': '/builds/slave/test', 09:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:28 INFO - 'SHELL': '/bin/bash', 09:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:28 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:28 INFO - 'USER': 'cltbld', 09:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:28 INFO - 'XPC_FLAGS': '0x0', 09:54:28 INFO - 'XPC_SERVICE_NAME': '0', 09:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-oZh4S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-UVrNX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-s71ePC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-28Us3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8THinE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-MVhRhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-N7VQGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-wIny_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-MWK_TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-xw687z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-6VKnfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-MLcEzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:30 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-78Jyue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:30 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-x8IsVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:30 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-sYJtas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:30 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-7SYo3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:30 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-jfGjp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:54:30 INFO - Running setup.py install for manifestparser 09:54:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:54:30 INFO - Running setup.py install for mozcrash 09:54:30 INFO - Running setup.py install for mozdebug 09:54:30 INFO - Running setup.py install for mozdevice 09:54:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Running setup.py install for mozfile 09:54:31 INFO - Running setup.py install for mozhttpd 09:54:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Running setup.py install for mozinfo 09:54:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Running setup.py install for mozInstall 09:54:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:54:31 INFO - Running setup.py install for mozleak 09:54:31 INFO - Running setup.py install for mozlog 09:54:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for moznetwork 09:54:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozprocess 09:54:32 INFO - Running setup.py install for mozprofile 09:54:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozrunner 09:54:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:54:32 INFO - Running setup.py install for mozscreenshot 09:54:32 INFO - Running setup.py install for moztest 09:54:32 INFO - Running setup.py install for mozversion 09:54:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:54:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:54:33 INFO - Cleaning up... 09:54:33 INFO - Return code: 0 09:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:33 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:33 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 09:54:33 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 09:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:33 INFO - 'HOME': '/Users/cltbld', 09:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:33 INFO - 'LOGNAME': 'cltbld', 09:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:33 INFO - 'MOZ_NO_REMOTE': '1', 09:54:33 INFO - 'NO_EM_RESTART': '1', 09:54:33 INFO - 'PAGER': '/bin/cat', 09:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:33 INFO - 'PWD': '/builds/slave/test', 09:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:33 INFO - 'SHELL': '/bin/bash', 09:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:33 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:33 INFO - 'USER': 'cltbld', 09:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:33 INFO - 'XPC_FLAGS': '0x0', 09:54:33 INFO - 'XPC_SERVICE_NAME': '0', 09:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:33 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-S8SIGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:33 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)) 09:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:33 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-yGuid5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:33 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-bE9rA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:33 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)) 09:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:33 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-gda18S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:33 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)) 09:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:33 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-lAoxqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:33 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)) 09:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:33 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-0bAGTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:33 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-y5kjxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-xG3svf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-urcNxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-J9CGUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-2YsIM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-H4GcW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-QPVQkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-xMsf2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-cGLOW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:34 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)) 09:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-yeZ0J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:35 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)) 09:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-W0ocH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:35 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)) 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:54:35 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)) 09:54:35 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)) 09:54:35 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)) 09:54:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:37 INFO - Downloading blessings-1.6.tar.gz 09:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:54:37 INFO - Installing collected packages: blessings 09:54:37 INFO - Running setup.py install for blessings 09:54:37 INFO - Successfully installed blessings 09:54:37 INFO - Cleaning up... 09:54:38 INFO - Return code: 0 09:54:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:38 INFO - Reading from file tmpfile_stdout 09:54:38 INFO - Current package versions: 09:54:38 INFO - blessings == 1.6 09:54:38 INFO - blobuploader == 1.2.4 09:54:38 INFO - docopt == 0.6.1 09:54:38 INFO - manifestparser == 1.1 09:54:38 INFO - mozInstall == 1.12 09:54:38 INFO - mozcrash == 0.17 09:54:38 INFO - mozdebug == 0.1 09:54:38 INFO - mozdevice == 0.48 09:54:38 INFO - mozfile == 1.2 09:54:38 INFO - mozhttpd == 0.7 09:54:38 INFO - mozinfo == 0.9 09:54:38 INFO - mozleak == 0.1 09:54:38 INFO - mozlog == 3.1 09:54:38 INFO - moznetwork == 0.27 09:54:38 INFO - mozprocess == 0.22 09:54:38 INFO - mozprofile == 0.28 09:54:38 INFO - mozrunner == 6.11 09:54:38 INFO - mozscreenshot == 0.1 09:54:38 INFO - mozsystemmonitor == 0.0 09:54:38 INFO - moztest == 0.7 09:54:38 INFO - mozversion == 1.4 09:54:38 INFO - psutil == 3.1.1 09:54:38 INFO - requests == 1.2.3 09:54:38 INFO - wsgiref == 0.1.2 09:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:38 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:38 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 09:54:38 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 09:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:38 INFO - 'HOME': '/Users/cltbld', 09:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:38 INFO - 'LOGNAME': 'cltbld', 09:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:38 INFO - 'MOZ_NO_REMOTE': '1', 09:54:38 INFO - 'NO_EM_RESTART': '1', 09:54:38 INFO - 'PAGER': '/bin/cat', 09:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:38 INFO - 'PWD': '/builds/slave/test', 09:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:38 INFO - 'SHELL': '/bin/bash', 09:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:38 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:38 INFO - 'USER': 'cltbld', 09:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:38 INFO - 'XPC_FLAGS': '0x0', 09:54:38 INFO - 'XPC_SERVICE_NAME': '0', 09:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 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)) 09:54:38 INFO - Cleaning up... 09:54:38 INFO - Return code: 0 09:54:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:38 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 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:38 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 09:54:38 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 09:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:38 INFO - 'HOME': '/Users/cltbld', 09:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:38 INFO - 'LOGNAME': 'cltbld', 09:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:38 INFO - 'MOZ_NO_REMOTE': '1', 09:54:38 INFO - 'NO_EM_RESTART': '1', 09:54:38 INFO - 'PAGER': '/bin/cat', 09:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:38 INFO - 'PWD': '/builds/slave/test', 09:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:38 INFO - 'SHELL': '/bin/bash', 09:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:38 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:38 INFO - 'USER': 'cltbld', 09:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:38 INFO - 'XPC_FLAGS': '0x0', 09:54:38 INFO - 'XPC_SERVICE_NAME': '0', 09:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:38 INFO - Downloading/unpacking jsonschema 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:54:41 INFO - Downloading/unpacking functools32 (from jsonschema) 09:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:41 INFO - Downloading functools32-3.2.3-2.tar.gz 09:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:54:41 INFO - warning: no files found matching '*.txt' 09:54:41 INFO - no previously-included directories found matching 'build' 09:54:41 INFO - no previously-included directories found matching 'dist' 09:54:41 INFO - no previously-included directories found matching '.git*' 09:54:41 INFO - Installing collected packages: jsonschema, functools32 09:54:41 INFO - Running setup.py install for functools32 09:54:41 INFO - warning: no files found matching '*.txt' 09:54:41 INFO - no previously-included directories found matching 'build' 09:54:41 INFO - no previously-included directories found matching 'dist' 09:54:41 INFO - no previously-included directories found matching '.git*' 09:54:41 INFO - Successfully installed jsonschema functools32 09:54:41 INFO - Cleaning up... 09:54:41 INFO - Return code: 0 09:54:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d56a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8980cd45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, '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.E9GlifiIHH/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.wzzlqFMs5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:41 INFO - 'HOME': '/Users/cltbld', 09:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:41 INFO - 'LOGNAME': 'cltbld', 09:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:41 INFO - 'MOZ_NO_REMOTE': '1', 09:54:41 INFO - 'NO_EM_RESTART': '1', 09:54:41 INFO - 'PAGER': '/bin/cat', 09:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:41 INFO - 'PWD': '/builds/slave/test', 09:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:41 INFO - 'SHELL': '/bin/bash', 09:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:54:41 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:41 INFO - 'USER': 'cltbld', 09:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:41 INFO - 'XPC_FLAGS': '0x0', 09:54:41 INFO - 'XPC_SERVICE_NAME': '0', 09:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:42 INFO - Downloading/unpacking flake8 09:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:54:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:54:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 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 09:54:44 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 09:54:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:54:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:54:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:54:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:54:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:54:45 INFO - no previously-included directories found matching 'docs/_build' 09:54:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:54:45 INFO - Running setup.py install for pep8 09:54:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:54:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:54:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:54:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:54:46 INFO - no previously-included directories found matching 'docs/_build' 09:54:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:54:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:54:46 INFO - Cleaning up... 09:54:46 INFO - Return code: 0 09:54:46 INFO - Running post-action listener: _resource_record_post_action 09:54:46 INFO - Running post-action listener: _start_resource_monitoring 09:54:46 INFO - Starting resource monitoring. 09:54:46 INFO - ##### 09:54:46 INFO - ##### Running install step. 09:54:46 INFO - ##### 09:54:46 INFO - Running pre-action listener: _resource_record_pre_action 09:54:46 INFO - Running main action method: install 09:54:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:46 INFO - Reading from file tmpfile_stdout 09:54:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:54:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:54:46 INFO - Reading from file tmpfile_stdout 09:54:46 INFO - Output received: 09:54:46 INFO - Usage: mozinstall [options] installer 09:54:46 INFO - Options: 09:54:46 INFO - -h, --help show this help message and exit 09:54:46 INFO - -d DEST, --destination=DEST 09:54:46 INFO - Directory to install application into. [default: 09:54:46 INFO - "/builds/slave/test"] 09:54:46 INFO - --app=APP Application being installed. [default: firefox] 09:54:46 INFO - mkdir: /builds/slave/test/build/application 09:54:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:55:20 INFO - Reading from file tmpfile_stdout 09:55:20 INFO - Output received: 09:55:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:55:20 INFO - Running post-action listener: _resource_record_post_action 09:55:20 INFO - ##### 09:55:20 INFO - ##### Running run-tests step. 09:55:20 INFO - ##### 09:55:20 INFO - Running pre-action listener: _resource_record_pre_action 09:55:20 INFO - Running main action method: run_tests 09:55:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:55:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:55:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:55:20 INFO - 2016-03-21 09:55:20.952 screenresolution[1647:8195] starting screenresolution argv=screenresolution get 09:55:20 INFO - 2016-03-21 09:55:20.954 screenresolution[1647:8195] Display 0: 1600x1200x32@60 09:55:20 INFO - 2016-03-21 09:55:20.960 screenresolution[1648:8197] starting screenresolution argv=screenresolution list 09:55:20 INFO - Available Modes on Display 0 09:55:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:55:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:55:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:55:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:55:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:55:21 INFO - Intel Iris: 09:55:21 INFO - Chipset Model: Intel Iris 09:55:21 INFO - Type: GPU 09:55:21 INFO - Bus: Built-In 09:55:21 INFO - VRAM (Dynamic, Max): 1536 MB 09:55:21 INFO - Vendor: Intel (0x8086) 09:55:21 INFO - Device ID: 0x0a2e 09:55:21 INFO - Revision ID: 0x0009 09:55:21 INFO - Displays: 09:55:21 INFO - Display: 09:55:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:55:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:55:21 INFO - Display Serial Number: 1600x1200 60 09:55:21 INFO - Main Display: Yes 09:55:21 INFO - Mirror: Off 09:55:21 INFO - Online: Yes 09:55:21 INFO - Rotation: Supported 09:55:21 INFO - Return code: 0 09:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:55:21 INFO - Python 2.7.3 09:55:21 INFO - Return code: 0 09:55:21 INFO - grabbing minidump binary from tooltool 09:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:21 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 0x104bf5e00>, '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 0x104a1edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bf0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:55:21 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 09:55:21 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 09:55:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:55:21 INFO - Return code: 0 09:55:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:55:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:55:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:55:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:55:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:55:22 INFO - Return code: 0 09:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 09:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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 09:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E9GlifiIHH/Render', 09:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:22 INFO - 'HOME': '/Users/cltbld', 09:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:22 INFO - 'LOGNAME': 'cltbld', 09:55:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:55:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:22 INFO - 'MOZ_NO_REMOTE': '1', 09:55:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:55:22 INFO - 'NO_EM_RESTART': '1', 09:55:22 INFO - 'PAGER': '/bin/cat', 09:55:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:22 INFO - 'PWD': '/builds/slave/test', 09:55:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:22 INFO - 'SHELL': '/bin/bash', 09:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wzzlqFMs5E/Listeners', 09:55:22 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:22 INFO - 'USER': 'cltbld', 09:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:22 INFO - 'XPC_FLAGS': '0x0', 09:55:22 INFO - 'XPC_SERVICE_NAME': '0', 09:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 09:55:22 INFO - mozversion application_buildid: 20160321080446 09:55:22 INFO - mozversion application_changeset: af22a2e633c03d496fdb832a0abc9d9253fff148 09:55:22 INFO - mozversion application_display_name: Nightly 09:55:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:55:22 INFO - mozversion application_name: Firefox 09:55:22 INFO - mozversion application_remotingname: firefox 09:55:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:55:22 INFO - mozversion application_vendor: Mozilla 09:55:22 INFO - mozversion application_version: 48.0a1 09:55:22 INFO - mozversion platform_buildid: 20160321080446 09:55:22 INFO - mozversion platform_changeset: af22a2e633c03d496fdb832a0abc9d9253fff148 09:55:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:55:22 INFO - mozversion platform_version: 48.0a1 09:55:22 INFO - using testdate: 1458579322 09:55:22 INFO - actual date: 1458579322 09:55:22 INFO - starting webserver on 'localhost:49270' 09:55:22 INFO - SUITE-START | Running 2 tests 09:55:22 INFO - TEST-START | dromaeo_css 09:55:22 INFO - operating with platform_type : mac_ 09:55:22 INFO - Initialising browser for dromaeo_css test... 09:55:22 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpNndf_o/profile http://localhost:49270/getInfo.html) 09:55:24 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 09:55:24 INFO - PROCESS | 1666 | colorDepth:24 09:55:24 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 09:55:24 INFO - PROCESS | 1666 | __metrics 09:55:25 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:55:25 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:55:25 INFO - TEST-INFO | 1666: exit 0 09:55:25 INFO - Browser initialized. 09:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:55:25 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpNndf_o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:37 INFO - PROCESS | 1670 | RSS: Main: 245579776 09:55:37 INFO - PROCESS | 1670 | 09:56:28 INFO - PROCESS | 1670 | 1458579388905 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] 09:58:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 09:58:40 INFO - PROCESS | 1670 | RSS: Main: 382013440 09:58:40 INFO - PROCESS | 1670 | 10:01:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 10:01:43 INFO - PROCESS | 1670 | RSS: Main: 379940864 10:01:43 INFO - PROCESS | 1670 | 10:04:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 10:04:46 INFO - PROCESS | 1670 | RSS: Main: 376639488 10:04:46 INFO - PROCESS | 1670 | 10:07:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 10:07:49 INFO - PROCESS | 1670 | RSS: Main: 335941632 10:07:49 INFO - PROCESS | 1670 | 10:10:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 10:10:53 INFO - PROCESS | 1670 | RSS: Main: 336482304 10:10:53 INFO - PROCESS | 1670 | 10:13:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 10:13:56 INFO - PROCESS | 1670 | RSS: Main: 385208320 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | __start_tp_report 10:13:56 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 10:13:56 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 10:13:56 INFO - PROCESS | 1670 | |i|pagename|runs| 10:13:56 INFO - PROCESS | 1670 | |0;dojo.html;3253.951190732139;3465.9826700866493;3501.5447991761075;3505.1938054247507;3534.0988048047743;5290.39160496543;5392.056390131721;5620.5784566157545;5628.409017053206;5632.239647647566;5587;5605.467480589347;5644.74598643062;5741.598088133832;5751.482366587006;5038.571721403685;5041.067402530525;5064.79740810369;5074.959633275188;5178.637495375326;5215.191645294985;5221.660592061504;5272.630915835893;5276.709780962045;5316.76074576645;5005.6496045276845;5023.196288593826;5084.034033533654;5128.897422051576;5204.115300398904;5105.540501354859;5116.565091967187;5118.59051275897;5136.049830781318;5142.971405718871;5025.14572522672;5088.567471764904;5089.160288552384;5090.440051594359;5104.897902041938;5374.301340825707;5478.616496845222;5514.283143191399;5567.972160139214;5580.330360356743;6153.7230824613;6160.0759886017;6175.104609831549;6176.197094377702;6196.81409557714;6151.876962460726;6210.782622608187;6230.844228894269;6238.688065596702;6244.313125556185;5593.272874526327;5622.32532096151;5697.800576979827;5704.286964129484;5710.65736055838;6226.003839385677;6235.469985051322;6237.875242495124;6245.000799871998;6254.2807577129215;5955.940440595626;6002.129691194752;6006.879862402728;6007.8197654070445;6007.849803754853;6198.845028874314;6224.06639004153;6229.719662615194;6232.501399887998;6239.875202496016;6098.14625952367;6132.478739307209;6138.1099740537375;6145.016797312409;6145.907811382833;5971.850703732442;6127.877442451126;6148.1085242639565;6169.56813023093;6184.938150618436;4823.348847905558;4867.513248675175;4873.122837889214;4904.485029071968;4925.458199598042;4268.87193384199;4275.87172384829;4328.372386004012;4330.566943305707;4361.847335343247;5516.172574113915;5628.380878103405;5635.267415236075;5642.689652069093;5647.491725744702;5968.37332080134;6078.75684972605;6083.8174854754425;6087.665178415141;6129.233845769279;5594.580406469531;5599.160125981135;5604.047311956977;5634.830955071355;5635.154726790932;5179.171332586843;5287.365516138088;5293.920591191135;5302.1781623848365;5302.1781623848365;6161.199044124235;6218.657973811303;6229;6229.937700623026;6241.875162496815;6011.398860113954;6017.70619316849;6021.578489505692;6025;6093.360197179232;6127.908081378872;6216.067589861557;6227.0970709246;6229.096780966644;6232.532560057924;6021.578489505868;6042.637441753509;6055.3944605540855;6077.270727512727;6125.387461253839;6150.354212807591;6173.074038894202;6177.135201071764;6181.134641150333;6187.474064704551;5866.735996880236;5981.222441082631;5999.340072592098;6016.007358785751;6042.335343112342;5937.614055086406;5989.251343582052;6011.008183649649;6023.3374328824675;6064.332923378513;4786;5561.249231353715;5566.721663916707;5630.296212973379;5637.098064309691;5688.5733569981585;5752.6836024019085;5814.854628634149;5831.912521312099;5890.9116363253725;5855.238818953509;5884.411558844081;5884.882302353843;5886.558508111823;5924.170616113662 10:13:56 INFO - PROCESS | 1670 | |1;ext.html;508.2757071173577;573.9971300143499;579.32508627449;617.2685367839113;637.6684124255387;29794.95717649883;30140;37938.8103059485;38030;38108.61891381085;40081.799591002;40510.79744601273;40525.392119118165;40567.188656226856;40820.99999999993;9362.578683959222;9552.42685438876;9559.56981935811;9588.568514416833;9593.04069593042;9362.391444556117;9528.285378596598;9532.80934381312;9536.856947145798;9547.570359333846;9479.620815167385;9546.904530954705;9661;9666.90333096667;9678.37090589113;9568.808623827554;9635.084666956627;9638.614455421775;9653.324267301292;9656.034396560359;9468.195203407719;9608.95195524018;9616.423014619075;9630.036996300383;9631.71104866855;34094.6590534094;35953.82023089894;39076.609233907584;40501.39247911284;40552.797236013634;3239.3683231769814;3295.2915123248617;3303.4178927702606;3693.519842420495;4106.466159399289;28054.43891122166;28347.433051339063;28422;28967.275818104506;29119.41761164786;2713.9321516962036;2736.6031925370708;2790.2326860113426;2799.7760179185616;2838.7728981681416;366057;367206.9999999973;368306.15846920863;370135;370344;45541;46161.76919115383;46205;46232.84417889579;64720.67639661772;44785.55214447879;44861.10277794426;44892.87767805831;44915.32627010597;44972;15491.690166196839;15638.84361156374;15651.452199172974;15654.686906261812;15655.217239138225;12355.93822030884;12472.438740256528;12567.937160314323;12621.349516601616;12720.491180352683;13070.758277963578;14110.929445352707;14681.77977330341;14704.779428308584;14749.188794616184;6259.342769009279;6362.300146983828;6366.554341196164;6410.8717825643225;6427.839304017437;925.842606756853;930.3022732950287;1019.50553981319;1100.9889901100887;1131.9264247823864;28237.43525129527;28586.85706571454;28810.12734172272;29031.85484072566;29397.412051758845;1058.6771034834296;1067.6103222323795;1092.470151976291;1104.5471356743697;1126.2904370246692;14642.974991750476;14654.48709295191;14662.706745865024;15019.849801501845;15106.924465377602;510806;519026;522963;524750;524838;57325.713371432874;57928;57995.13007304894;58052;58073.41926580764;1327.1373607155426;1372.1561239837429;1464.5825939607162;1490.4559835659907;1513.6594266290217;28124.296892577848;28651.710673019348;28700.712992870638;28849.278768030967;29432.822687092277;45828.541714582425;46519.767401162775;46851;46928.29607555958;46954.76522617365;361595;362533.37466624996;364121.35878640873;364198;365185.1740741279;28104;32425.351492969538;32588.51117233196;32851.85018524436;33050.504242436866;40552.797236013634;41294.76115716533;41735;41788.3731744018;42333.153336933705;34303;34351.31297374088;34524;35346;35423.291534169686;33841.49237761386;34122.658773411946;34404.48393274153;34707.305853883285;34767.9569612912;29662.154630531673;30698.846505767327;30981.690183097882;35662.64337356593;35822.8208858954;30277.94027209125;31099.378012440076;31115.53326700056;31196;31229.843850780602;23475;23501.764982349956;23676.763232368146;24109.75890241075;24171.51656966886 10:13:56 INFO - PROCESS | 1670 | |2;jquery.html;357.20343633696854;358.652107455768;362.37671205526493;367.83998960452203;372.0809600287293;16317;19959.800401995977;20303.898480507596;20755.584888302226;20770.89614551925;19956.90021549894;20731.378058658265;21008.264710735126;21241.893790531063;21245.68131478029;5811.360750317462;5979.880402391949;6015.82691375182;6031.788887388942;6034.125051867477;3678.2643471305714;4327.632151267146;5188.533032027117;6020.367861374536;6679.766208182715;6579.572327798678;6613.338666133396;6613.603183808987;6630.867382652344;6632.1709786276715;5207.713575753313;5653.180288858113;5933;5934.5252379809945;6595.307492713268;3821.4458903458844;5516.668999860021;5656.773729050833;5729.341125770548;5749.568782341341;13272.867271327355;13462.798058029137;13482.460701571925;16140.677186456205;24432.511349772903;1964.8526360522876;2235.58641651295;2294.6328587426096;2455.693038370204;2757.696653368128;9527.809443811155;9617.471039092847;9842.753931151707;9915.256355773347;9977.501124943796;1656.2215758593443;1714.3485475519346;1745.3542189390007;1781.536800431884;1870.4108205915093;93065;98117.03765924713;100286;107409.46295268474;116116.99999999916;18003.72994405085;18528.814711852978;18607.44177674672;19223.32718354851;19231.326903558587;28736.137915862557;28738.982406847397;28749;28808.855955720508;28844.567331490045;10615.150787936947;10920.453977301104;10929.453527323762;10947.397893115955;11052.447377631086;9310.301727370474;9341.252699784001;9346.672866449642;9351.15839574428;9393.5303234838;8803.339749518811;8848.026717061119;8946.821063578822;8960.551972401354;8963.372563920593;3472.774269672463;3559.341521818472;3567.4827150063097;3646.580643226063;3650.9817450912574;805.275252272959;812.4028838803474;871.3943809052647;931.5994122527243;1041.3127335958231;19659.213631454582;19798.505037373892;20079.799202008086;20384.388468345973;20403.8979805103;907.3739120007306;926.6988228825659;954.8376775948105;962.2398305338704;1015.3248090020054;10750.193735469715;10901.945490272497;10902.836457453144;10920.18098642605;10932.890671093346;605766;617750;643819;656440;656670;93095.06904931;103813;106091.40862887063;115827.42086289515;117311;1019.8011387779312;1025.2310766924807;1038.6364772329623;1046.5552140340326;1047.0524175621076;17521;17656.117194139984;17914;18247.635047299245;18409.447716568524;48060.519394805604;49490.50509494859;49626;50600;50627.493725062275;70936;72513;73064;73071.63464182644;73450;6796.456283497408;7490.925090749023;7780.805479863048;7805.258500442449;7982.082060562877;10720.659917510311;11098.389588572383;11801.881981180079;12604.243745375306;12733;9213.815723685622;10670.83993740079;10959;10999.065079468335;11156.888431115909;10326.57713464481;10608.946955265174;10613.734656633645;10778.407187604756;10885.782284354427;11041.171912106785;11416.486258118572;11434.142439317251;11440.48517816717;11451.854814518481;7403.407727381689;7647.044119485065;7683.346915512244;7874.54320950626;7908.762737117896;10011.649592264235;10781.245312828027;11098.167637427065;11131.833022504507;11140.442977851237 10:13:56 INFO - PROCESS | 1670 | |3;mootools.html;1461.1087236785552;1616.7736516887635;1634.591352161959;1918.8273055425018;2039.2149022626284;7866;8402.243798058174;8579.485230886152;8601.021764994055;8609.096044915272;8319.792005199874;8550;8568.485890846554;8569.100244474319;8578.914210857889;1868.271374164077;2427.4174198192395;2444.193416172663;2479.404942813721;2491.202815099169;2480.528699547089;2523.079076137215;2523.3439305780444;2525.9621105683336;2526.6715327007464;2364.810815134785;2381.3332266965276;2381.535600557892;2384.260879127476;2414.9758502415016;2177.1835561664375;2424.7211570669424;2475.158446128316;2475.900963961439;2479.417336925821;2439.2682195341326;2445.8410203336725;2491.987540062288;2493.463905260378;2494.5634513959985;8289.668413263462;8379.329653627696;8382.16178382157;8388.119247478988;8389.412741108124;5268.789248430058;5378;5402;5426.891462170774;5434.429384914606;3379.763416560817;3401.2517246205794;3565.554305711786;3602.35157671619;3681.44778283257;948.5162567090833;1046.7801761630067;1050.4170185547018;1053.984190237147;1074.2533938912459;11281.774364512663;11481.598144065001;11497.367644779533;11506.769864602746;11515.963563279345;4831.444383895827;4920.81900343922;4957.925631115536;4984.626153038536;5007.24891266313;10049.045340692623;10062;10078;10083.596656133672;10091.7477063074;5467.261919640877;5508.256385388001;5523.061079616475;5524.900537795612;5530.529904958124;4410.823567057346;4543.045960348364;4783.56947874686;4831.396075490564;4842.007388485352;3875.8643447479767;3957.8021098944937;3975.8012099394914;3997.080671445584;4010.5588385277597;1264.7913094339515;1272.4083301264957;1274.4265080713717;1286.0483242400555;1302.218668798732;1344.8386193656825;1363.6522686715023;1381.3714759784275;1397.9720405592034;1421.1473116130446;8019.198080191934;8103.513789172668;8115.8782618260775;8127.75616731499;8128.837423251502;509.0531611203159;516.1792749528269;516.2205070343808;519.7764961066778;536.6109570561312;6164.8767024659255;6194.752209911643;6228.22147231596;6232.158658581034;6235.158253635792;10066.949665251626;10490.527926243338;10514.158867290598;10523.368597884151;10534;9694.563744631509;10314.968503149776;10376.429296388771;10376.533056012497;10381.636642717469;7786.299233069051;7969.561674107979;7991.760247192594;7994.64024118916;8016.759497215093;7389.778306650809;7798.908152858718;7799.37604991588;7876.763697089096;7899.368050555827;8884.111588841322;9120.270378369582;9223.400478968846;9252.861207082035;9345.0654934506;9270.490123043297;9403.623855045722;9421.057894210799;9522.666706665234;9633.855492167482;7210.242924492853;7424.220456851953;7442.144153422426;7543.094828620381;7654.081510218809;8065.8790118149445;8076.515409075474;8112.351011918914;8127.634256458592;8128.227818357246;6222;7000.859982800417;7064.894026589503;7201.675924583302;7303.014093097364;7007.439404847702;7087.433005359662;7165.820854478679;7181.820454488679;7273.454490913308;7423.740169094056;7638.923610763822;7645.961770191336;7649.694012239448;7665.655045523076;6947.402097517498;6959.095317608679;6993.755218567326;7009.684564194521;7012.2286548478605;6235;6999.755008574675;7036.296370362923;7075.71697132109;7095.503314767917 10:13:56 INFO - PROCESS | 1670 | |4;prototype.html;313.56101457958863;327.5071018117732;330.8908060340088;336.2317105414129;339.13182253431205;6366.663000769844;6499.740010399584;6513.641749703765;6580.407763301302;6582.901256481151;5374.6506477078965;5674.971625141869;6511.2837587865415;6541.7710380136705;6560.244697227164;4065.8983525411804;4750.358701575277;4755.26293424518;4823.011282687041;4884.511548845114;4806.543378379049;4817.494163112858;4832.323474713526;4836.46798852126;4841.661083724141;4810.735409552473;4826.7586620669;4833.830815921444;4842.515748425165;4850.4179498460235;4337.154254920292;4398;4669.159551280768;4807.326974223576;4834.2265237562;4127.545969943304;4136.379543068534;4136.400221967828;4146.440230568895;4169.624733773975;5189.495046436529;6216.3162052174675;6225.19072520574;6284.685765711696;6293.748250069992;5690.2033715279895;5701.486866182022;5707;5707.914381284284;5708.257926469574;6925.549839260432;6933.514653974224;6935.72257109715;6936.09830722008;6953;4319.265724826787;4500.639948804088;4511.390962220124;4514.210013247702;4668.6731928765;7129.358357747776;7153.6065516396575;7245.963770181168;7251.963740181265;7320.560766353982;4576.748278844696;4592.380028696083;4592.931106033412;4599.218132917345;4607.861764147081;4273.978630106892;4375.993521490075;4631.536846315342;4644.651651126179;4678.157931572349;4634.768261586907;5503.944960550423;5513.338399392099;5515.972420137874;5522.972385138049;6639.1037209977;6930.653467326613;6944.548604340803;6980.371766541036;7005.299470053056;1435.978460323096;1539.7536394176877;1603.1503303249297;1613.6691978144452;1617.9887570268581;1033.8294181460126;1038.5118994072925;1047.157038583932;1062.0388548363744;1064.3241541621126;5744.454276843693;6412.326705695835;6469.256035555877;6586.506012049115;6588.96705516479;6064.818055458255;6605.735770569219;7261.5280006799385;7290.890636640454;7296.087989001375;6564.540482166202;6568.310327415648;6574.243961944342;6575.375339342755;6576.473882089517;3789.3558095123894;3834.1948190880225;3837.6354246346555;3841.961580384216;3844.7885366304563;7343.77968660941;7606.201348858401;7610.429217808686;7646;7674.53952762836;7467.813304667427;7489.400847932152;7495.737649182252;7507.211742766931;7509.474336796372;7607.315341619281;7620.504667196615;7637.312641862259;7640.388768898475;7656.042994625672;7037.867648878743;7250.746223882139;7269.127704675473;7274.781756547312;7289.781306560812;7023.157221133497;7125.857482850418;7151;7159.319864612853;7180.210176880434;6580.012998050331;7538.773836784905;7597.696092156252;7609.162992070757;7629.321549259154;4433.357163211252;4614.861554153381;4616.399868017271;4619.630429565694;4640.721556706609;7132.037174981519;7136.750213742494;7144.749933752501;7157.105361829771;7172.533785303938;5823.970880145572;6641.1034510342415;6931.2375638678695;6983.127109111361;6998.475114366341;6919.861602767815;6955.130608673916;6966.756163534252;6972;6981.5461994970165;6803.149606299213;6814.352636499525;6822.727090916506;6826.249112597511;6833.077534532775;6694.464442844658;6925.549839260633;6927.445804335742;6929.549579277331;6940.548864324005;6538.280789113289;6572.868542629025;6753.3246675332075;6824;6865.691043902936 10:13:56 INFO - PROCESS | 1670 | |5;yui.html;562.3083607163192;578.7164289498145;651.2575663743334;680.4998326230223;713.0409599089223;14910.329035193416;15169.544913652608;15170.317335719892;15175.165365904884;15199.848001519968;13264.535741249058;13268.800967985488;13315.733685326311;13351.465941362334;13389.799153012713;740.2486476226634;753.7437271327748;905.9909400906006;925.7593025813303;926;888.1296329596998;933.4492649336889;933.6405483888718;934.7616357828745;936.0499093420184;965.9661911833088;978.227200511595;979.0503211884461;979.1236843025488;979.6179489998906;774.1523032279673;921.230772305126;967.5259123029736;973.5424350555228;974.7563109222694;719.5790462579397;719.9856002879914;720.099875156055;720.4200618502103;720.7801620505744;14858.554243372717;14990.100593964396;14993;15006.324715387835;15008.399664013426;12451.501939922393;12497.875021249762;12498.812517812241;12759.74480510394;12867.09930304879;9903;9976.700698979042;10044.547995340226;10252.179825613934;10936.890631093745;3520.9965159929297;3556.5554305711785;3598.046517672819;3635.600083990759;3661.6887564557046;83540.58229708874;84588;86732;86813.13186868177;86821.56589217077;9446.480443575669;9610.790364324053;9619.134277915022;9656.71029869105;9890.950545247371;20776.96115194234;20948.162073516887;20958.371248862557;20971.056302466426;20993.89503052475;7484.326410622961;7564.735234266775;7602.163761986177;7752.91459195713;7836.373090152774;4177.206330797138;4192.727472714264;4226.260404429274;4229.302165142717;4269.060806622538;3637.5998640149564;3673.1735359544423;3681.9631803682155;3684.2631473705364;3686.594474607791;575.6977586766981;622.4491325177161;633;645.3417514135556;655.5476721062547;506.17493485618206;556.5658786146812;561.7331767410448;562.4768964862635;581.9941800582025;6813.659317034128;7857.528548287121;7871.409644276702;7940.563269020259;8073.798155046054;530.8672831792052;568.4741614007027;568.8265079150899;571.4371344225934;574.5001848391843;3719.702423806089;3725.3108174987715;3753.530808648919;3783.4703141559653;3936.7441116327345;94124.52937735268;95716.52141739246;96663;97505;97593;77200.61399692965;79476.60261698655;79483.60258198672;80729.19270807334;81280.59359703163;68037.65981170062;70100.64949675219;71304.64347678333;72192.55614887777;73829.26170738223;7471.850562988819;7518.28576285252;7674.117476490052;7705.576193309197;7765.572893490912;46399;47580.52419475761;48766.268505971726;50719.98560028853;51336.45990620287;66578.66710666416;70430;72261.6386918062;72382.91425628724;73086.63456682682;10912.836307455553;11027.064711301638;11267.887321127011;11397.829032564685;11625.6512304631;12080.39598020078;12119.394030298627;12183.512659493876;12188.634340969786;12264;11536.307821530734;11736.119791015879;11835;11863;11951;11478.426078695864;11536.942315288705;11552.191346605658;11591.710207244887;11603.129765267808;9581.377210481296;11163.609273675382;11205.327680339205;11262.718432039264;11640.592579259684;9352.906470935204;9429.905700943178;9504.619815207314;9609.855852162083;9996.800063998533;9555.522223888916;9561.569729362334;9655.461096106168;9667.081627245401;9671.9032809671 10:13:56 INFO - PROCESS | 1670 | __end_tp_report 10:13:56 INFO - PROCESS | 1670 | __start_cc_report 10:13:56 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1228 10:13:56 INFO - PROCESS | 1670 | __end_cc_report 10:13:56 INFO - PROCESS | 1670 | __startTimestamp1458580436249__endTimestamp 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | ------- Summary: start ------- 10:13:56 INFO - PROCESS | 1670 | Number of tests: 6 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5639.26 Median:5814.85 stddev:619.43 (10.7%) stddev-sans-first:592.40 10:13:56 INFO - PROCESS | 1670 | Values: 3254.0 3466.0 3501.5 3505.2 3534.1 5290.4 5392.1 5620.6 5628.4 5632.2 5587.0 5605.5 5644.7 5741.6 5751.5 5038.6 5041.1 5064.8 5075.0 5178.6 5215.2 5221.7 5272.6 5276.7 5316.8 5005.6 5023.2 5084.0 5128.9 5204.1 5105.5 5116.6 5118.6 5136.0 5143.0 5025.1 5088.6 5089.2 5090.4 5104.9 5374.3 5478.6 5514.3 5568.0 5580.3 6153.7 6160.1 6175.1 6176.2 6196.8 6151.9 6210.8 6230.8 6238.7 6244.3 5593.3 5622.3 5697.8 5704.3 5710.7 6226.0 6235.5 6237.9 6245.0 6254.3 5955.9 6002.1 6006.9 6007.8 6007.8 6198.8 6224.1 6229.7 6232.5 6239.9 6098.1 6132.5 6138.1 6145.0 6145.9 5971.9 6127.9 6148.1 6169.6 6184.9 4823.3 4867.5 4873.1 4904.5 4925.5 4268.9 4275.9 4328.4 4330.6 4361.8 5516.2 5628.4 5635.3 5642.7 5647.5 5968.4 6078.8 6083.8 6087.7 6129.2 5594.6 5599.2 5604.0 5634.8 5635.2 5179.2 5287.4 5293.9 5302.2 5302.2 6161.2 6218.7 6229.0 6229.9 6241.9 6011.4 6017.7 6021.6 6025.0 6093.4 6127.9 6216.1 6227.1 6229.1 6232.5 6021.6 6042.6 6055.4 6077.3 6125.4 6150.4 6173.1 6177.1 6181.1 6187.5 5866.7 5981.2 5999.3 6016.0 6042.3 5937.6 5989.3 6011.0 6023.3 6064.3 4786.0 5561.2 5566.7 5630.3 5637.1 5688.6 5752.7 5814.9 5831.9 5890.9 5855.2 5884.4 5884.9 5886.6 5924.2 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:55633.13 Median:362064.19 stddev:112528.61 (31.1%) stddev-sans-first:112768.17 10:13:56 INFO - PROCESS | 1670 | Values: 508.3 574.0 579.3 617.3 637.7 29795.0 30140.0 37938.8 38030.0 38108.6 40081.8 40510.8 40525.4 40567.2 40821.0 9362.6 9552.4 9559.6 9588.6 9593.0 9362.4 9528.3 9532.8 9536.9 9547.6 9479.6 9546.9 9661.0 9666.9 9678.4 9568.8 9635.1 9638.6 9653.3 9656.0 9468.2 9609.0 9616.4 9630.0 9631.7 34094.7 35953.8 39076.6 40501.4 40552.8 3239.4 3295.3 3303.4 3693.5 4106.5 28054.4 28347.4 28422.0 28967.3 29119.4 2713.9 2736.6 2790.2 2799.8 2838.8 366057.0 367207.0 368306.2 370135.0 370344.0 45541.0 46161.8 46205.0 46232.8 64720.7 44785.6 44861.1 44892.9 44915.3 44972.0 15491.7 15638.8 15651.5 15654.7 15655.2 12355.9 12472.4 12567.9 12621.3 12720.5 13070.8 14110.9 14681.8 14704.8 14749.2 6259.3 6362.3 6366.6 6410.9 6427.8 925.8 930.3 1019.5 1101.0 1131.9 28237.4 28586.9 28810.1 29031.9 29397.4 1058.7 1067.6 1092.5 1104.5 1126.3 14643.0 14654.5 14662.7 15019.8 15106.9 510806.0 519026.0 522963.0 524750.0 524838.0 57325.7 57928.0 57995.1 58052.0 58073.4 1327.1 1372.2 1464.6 1490.5 1513.7 28124.3 28651.7 28700.7 28849.3 29432.8 45828.5 46519.8 46851.0 46928.3 46954.8 361595.0 362533.4 364121.4 364198.0 365185.2 28104.0 32425.4 32588.5 32851.9 33050.5 40552.8 41294.8 41735.0 41788.4 42333.2 34303.0 34351.3 34524.0 35346.0 35423.3 33841.5 34122.7 34404.5 34707.3 34768.0 29662.2 30698.8 30981.7 35662.6 35822.8 30277.9 31099.4 31115.5 31196.0 31229.8 23475.0 23501.8 23676.8 24109.8 24171.5 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35302.15 Median:28778.93 stddev:104986.58 (364.8%) stddev-sans-first:105248.30 10:13:56 INFO - PROCESS | 1670 | Values: 357.2 358.7 362.4 367.8 372.1 16317.0 19959.8 20303.9 20755.6 20770.9 19956.9 20731.4 21008.3 21241.9 21245.7 5811.4 5979.9 6015.8 6031.8 6034.1 3678.3 4327.6 5188.5 6020.4 6679.8 6579.6 6613.3 6613.6 6630.9 6632.2 5207.7 5653.2 5933.0 5934.5 6595.3 3821.4 5516.7 5656.8 5729.3 5749.6 13272.9 13462.8 13482.5 16140.7 24432.5 1964.9 2235.6 2294.6 2455.7 2757.7 9527.8 9617.5 9842.8 9915.3 9977.5 1656.2 1714.3 1745.4 1781.5 1870.4 93065.0 98117.0 100286.0 107409.5 116117.0 18003.7 18528.8 18607.4 19223.3 19231.3 28736.1 28739.0 28749.0 28808.9 28844.6 10615.2 10920.5 10929.5 10947.4 11052.4 9310.3 9341.3 9346.7 9351.2 9393.5 8803.3 8848.0 8946.8 8960.6 8963.4 3472.8 3559.3 3567.5 3646.6 3651.0 805.3 812.4 871.4 931.6 1041.3 19659.2 19798.5 20079.8 20384.4 20403.9 907.4 926.7 954.8 962.2 1015.3 10750.2 10901.9 10902.8 10920.2 10932.9 605766.0 617750.0 643819.0 656440.0 656670.0 93095.1 103813.0 106091.4 115827.4 117311.0 1019.8 1025.2 1038.6 1046.6 1047.1 17521.0 17656.1 17914.0 18247.6 18409.4 48060.5 49490.5 49626.0 50600.0 50627.5 70936.0 72513.0 73064.0 73071.6 73450.0 6796.5 7490.9 7780.8 7805.3 7982.1 10720.7 11098.4 11801.9 12604.2 12733.0 9213.8 10670.8 10959.0 10999.1 11156.9 10326.6 10608.9 10613.7 10778.4 10885.8 11041.2 11416.5 11434.1 11440.5 11451.9 7403.4 7647.0 7683.3 7874.5 7908.8 10011.6 10781.2 11098.2 11131.8 11140.4 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5925.65 Median:5414.45 stddev:3093.82 (57.1%) stddev-sans-first:3084.30 10:13:56 INFO - PROCESS | 1670 | Values: 1461.1 1616.8 1634.6 1918.8 2039.2 7866.0 8402.2 8579.5 8601.0 8609.1 8319.8 8550.0 8568.5 8569.1 8578.9 1868.3 2427.4 2444.2 2479.4 2491.2 2480.5 2523.1 2523.3 2526.0 2526.7 2364.8 2381.3 2381.5 2384.3 2415.0 2177.2 2424.7 2475.2 2475.9 2479.4 2439.3 2445.8 2492.0 2493.5 2494.6 8289.7 8379.3 8382.2 8388.1 8389.4 5268.8 5378.0 5402.0 5426.9 5434.4 3379.8 3401.3 3565.6 3602.4 3681.4 948.5 1046.8 1050.4 1054.0 1074.3 11281.8 11481.6 11497.4 11506.8 11516.0 4831.4 4920.8 4957.9 4984.6 5007.2 10049.0 10062.0 10078.0 10083.6 10091.7 5467.3 5508.3 5523.1 5524.9 5530.5 4410.8 4543.0 4783.6 4831.4 4842.0 3875.9 3957.8 3975.8 3997.1 4010.6 1264.8 1272.4 1274.4 1286.0 1302.2 1344.8 1363.7 1381.4 1398.0 1421.1 8019.2 8103.5 8115.9 8127.8 8128.8 509.1 516.2 516.2 519.8 536.6 6164.9 6194.8 6228.2 6232.2 6235.2 10066.9 10490.5 10514.2 10523.4 10534.0 9694.6 10315.0 10376.4 10376.5 10381.6 7786.3 7969.6 7991.8 7994.6 8016.8 7389.8 7798.9 7799.4 7876.8 7899.4 8884.1 9120.3 9223.4 9252.9 9345.1 9270.5 9403.6 9421.1 9522.7 9633.9 7210.2 7424.2 7442.1 7543.1 7654.1 8065.9 8076.5 8112.4 8127.6 8128.2 6222.0 7000.9 7064.9 7201.7 7303.0 7007.4 7087.4 7165.8 7181.8 7273.5 7423.7 7638.9 7646.0 7649.7 7665.7 6947.4 6959.1 6993.8 7009.7 7012.2 6235.0 6999.8 7036.3 7075.7 7095.5 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5675.04 Median:6525.96 stddev:1824.23 (28.0%) stddev-sans-first:1784.41 10:13:56 INFO - PROCESS | 1670 | Values: 313.6 327.5 330.9 336.2 339.1 6366.7 6499.7 6513.6 6580.4 6582.9 5374.7 5675.0 6511.3 6541.8 6560.2 4065.9 4750.4 4755.3 4823.0 4884.5 4806.5 4817.5 4832.3 4836.5 4841.7 4810.7 4826.8 4833.8 4842.5 4850.4 4337.2 4398.0 4669.2 4807.3 4834.2 4127.5 4136.4 4136.4 4146.4 4169.6 5189.5 6216.3 6225.2 6284.7 6293.7 5690.2 5701.5 5707.0 5707.9 5708.3 6925.5 6933.5 6935.7 6936.1 6953.0 4319.3 4500.6 4511.4 4514.2 4668.7 7129.4 7153.6 7246.0 7252.0 7320.6 4576.7 4592.4 4592.9 4599.2 4607.9 4274.0 4376.0 4631.5 4644.7 4678.2 4634.8 5503.9 5513.3 5516.0 5523.0 6639.1 6930.7 6944.5 6980.4 7005.3 1436.0 1539.8 1603.2 1613.7 1618.0 1033.8 1038.5 1047.2 1062.0 1064.3 5744.5 6412.3 6469.3 6586.5 6589.0 6064.8 6605.7 7261.5 7290.9 7296.1 6564.5 6568.3 6574.2 6575.4 6576.5 3789.4 3834.2 3837.6 3842.0 3844.8 7343.8 7606.2 7610.4 7646.0 7674.5 7467.8 7489.4 7495.7 7507.2 7509.5 7607.3 7620.5 7637.3 7640.4 7656.0 7037.9 7250.7 7269.1 7274.8 7289.8 7023.2 7125.9 7151.0 7159.3 7180.2 6580.0 7538.8 7597.7 7609.2 7629.3 4433.4 4614.9 4616.4 4619.6 4640.7 7132.0 7136.8 7144.7 7157.1 7172.5 5824.0 6641.1 6931.2 6983.1 6998.5 6919.9 6955.1 6966.8 6972.0 6981.5 6803.1 6814.4 6822.7 6826.2 6833.1 6694.5 6925.5 6927.4 6929.5 6940.5 6538.3 6572.9 6753.3 6824.0 6865.7 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18650.96 Median:627.72 stddev:26668.66 (4248.5%) stddev-sans-first:26708.88 10:13:56 INFO - PROCESS | 1670 | Values: 562.3 578.7 651.3 680.5 713.0 14910.3 15169.5 15170.3 15175.2 15199.8 13264.5 13268.8 13315.7 13351.5 13389.8 740.2 753.7 906.0 925.8 926.0 888.1 933.4 933.6 934.8 936.0 966.0 978.2 979.1 979.1 979.6 774.2 921.2 967.5 973.5 974.8 719.6 720.0 720.1 720.4 720.8 14858.6 14990.1 14993.0 15006.3 15008.4 12451.5 12497.9 12498.8 12759.7 12867.1 9903.0 9976.7 10044.5 10252.2 10936.9 3521.0 3556.6 3598.0 3635.6 3661.7 83540.6 84588.0 86732.0 86813.1 86821.6 9446.5 9610.8 9619.1 9656.7 9891.0 20777.0 20948.2 20958.4 20971.1 20993.9 7484.3 7564.7 7602.2 7752.9 7836.4 4177.2 4192.7 4226.3 4229.3 4269.1 3637.6 3673.2 3682.0 3684.3 3686.6 575.7 622.4 633.0 645.3 655.5 506.2 556.6 561.7 562.5 582.0 6813.7 7857.5 7871.4 7940.6 8073.8 530.9 568.5 568.8 571.4 574.5 3719.7 3725.3 3753.5 3783.5 3936.7 94124.5 95716.5 96663.0 97505.0 97593.0 77200.6 79476.6 79483.6 80729.2 81280.6 68037.7 70100.6 71304.6 72192.6 73829.3 7471.9 7518.3 7674.1 7705.6 7765.6 46399.0 47580.5 48766.3 50720.0 51336.5 66578.7 70430.0 72261.6 72382.9 73086.6 10912.8 11027.1 11267.9 11397.8 11625.7 12080.4 12119.4 12183.5 12188.6 12264.0 11536.3 11736.1 11835.0 11863.0 11951.0 11478.4 11536.9 11552.2 11591.7 11603.1 9581.4 11163.6 11205.3 11262.7 11640.6 9352.9 9429.9 9504.6 9609.9 9996.8 9555.5 9561.6 9655.5 9667.1 9671.9 10:13:56 INFO - PROCESS | 1670 | -------- Summary: end -------- 10:13:56 INFO - PROCESS | 1670 | 10:13:56 INFO - TEST-INFO | 1670: exit 0 10:13:56 INFO - TEST-OK | dromaeo_css | took 1114098ms 10:13:56 INFO - TEST-START | kraken 10:13:56 INFO - operating with platform_type : mac_ 10:13:56 INFO - Initialising browser for kraken test... 10:13:56 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpKcSUK9/profile http://localhost:49270/getInfo.html) 10:13:59 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 10:13:59 INFO - PROCESS | 1675 | colorDepth:24 10:13:59 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 10:13:59 INFO - PROCESS | 1675 | __metrics 10:13:59 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:13:59 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:13:59 INFO - TEST-INFO | 1675: exit 0 10:13:59 INFO - Browser initialized. 10:13:59 INFO - Running cycle 1/1 for kraken test... 10:13:59 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpKcSUK9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:11 INFO - PROCESS | 1677 | RSS: Main: 245547008 10:14:11 INFO - PROCESS | 1677 | 10:14:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 10:14:14 INFO - PROCESS | 1677 | RSS: Main: 292835328 10:14:14 INFO - PROCESS | 1677 | 10:14:17 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 10:14:18 INFO - PROCESS | 1677 | RSS: Main: 301867008 10:14:18 INFO - PROCESS | 1677 | 10:14:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 10:14:21 INFO - PROCESS | 1677 | RSS: Main: 286294016 10:14:21 INFO - PROCESS | 1677 | 10:14:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 10:14:24 INFO - PROCESS | 1677 | RSS: Main: 291033088 10:14:24 INFO - PROCESS | 1677 | 10:14:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:14:27 INFO - PROCESS | 1677 | RSS: Main: 290852864 10:14:27 INFO - PROCESS | 1677 | 10:14:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 10:14:30 INFO - PROCESS | 1677 | RSS: Main: 291459072 10:14:30 INFO - PROCESS | 1677 | 10:14:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 10:14:33 INFO - PROCESS | 1677 | RSS: Main: 291983360 10:14:34 INFO - PROCESS | 1677 | 10:14:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 10:14:37 INFO - PROCESS | 1677 | RSS: Main: 291635200 10:14:37 INFO - PROCESS | 1677 | 10:14:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:39 INFO - PROCESS | 1677 | RSS: Main: 327106560 10:14:39 INFO - PROCESS | 1677 | 10:14:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:41 INFO - PROCESS | 1677 | RSS: Main: 326393856 10:14:41 INFO - PROCESS | 1677 | 10:14:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:44 INFO - PROCESS | 1677 | RSS: Main: 333799424 10:14:44 INFO - PROCESS | 1677 | 10:14:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:47 INFO - PROCESS | 1677 | RSS: Main: 335466496 10:14:47 INFO - PROCESS | 1677 | 10:14:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:50 INFO - PROCESS | 1677 | RSS: Main: 335003648 10:14:50 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 10:14:52 INFO - PROCESS | 1677 | RSS: Main: 394981376 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | __start_tp_report 10:14:52 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 10:14:52 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 10:14:52 INFO - PROCESS | 1677 | |i|pagename|runs| 10:14:52 INFO - PROCESS | 1677 | |0;ai-astar;112;109;111;112;112;113;117;112;113;113 10:14:52 INFO - PROCESS | 1677 | |1;audio-beat-detection;154;119;149;181;143;139;141;115;157;120 10:14:52 INFO - PROCESS | 1677 | |2;audio-dft;188;185;185;185;184;185;186;186;182;183 10:14:52 INFO - PROCESS | 1677 | |3;audio-fft;74;79;87;76;56;56;62;80;77;56 10:14:52 INFO - PROCESS | 1677 | |4;audio-oscillator;93;96;131;80;77;83;112;78;79;118 10:14:52 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;91;88;85;87;85;90;87;93;73 10:14:52 INFO - PROCESS | 1677 | |6;imaging-darkroom;94;94;94;95;94;94;115;131;130;93 10:14:52 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;85;86;85;86;84;84;84;85;88 10:14:52 INFO - PROCESS | 1677 | |8;json-parse-financial;57;54;56;55;54;54;55;66;57;53 10:14:52 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;63;82;75;71;67;67;69;69;67 10:14:52 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;85;82;82;81;83;82;81;83;85;82 10:14:52 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;134;128;117;110;130;125;127;120;121;121 10:14:52 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;142;128;140;139;138;153;157;140;137;132 10:14:52 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;65;67;68;65;67;67;67;70;66;67 10:14:52 INFO - PROCESS | 1677 | __end_tp_report 10:14:52 INFO - PROCESS | 1677 | __start_cc_report 10:14:52 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1227 10:14:52 INFO - PROCESS | 1677 | __end_cc_report 10:14:52 INFO - PROCESS | 1677 | __startTimestamp1458580492753__endTimestamp 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | ------- Summary: start ------- 10:14:52 INFO - PROCESS | 1677 | Number of tests: 14 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:2.01 (1.8%) stddev-sans-first:2.13 10:14:52 INFO - PROCESS | 1677 | Values: 112.0 109.0 111.0 112.0 112.0 113.0 117.0 112.0 113.0 113.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:146.00 stddev:20.25 (13.9%) stddev-sans-first:20.99 10:14:52 INFO - PROCESS | 1677 | Values: 154.0 119.0 149.0 181.0 143.0 139.0 141.0 115.0 157.0 120.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.66 (0.9%) stddev-sans-first:1.33 10:14:52 INFO - PROCESS | 1677 | Values: 188.0 185.0 185.0 185.0 184.0 185.0 186.0 186.0 182.0 183.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:70.30 Median:76.50 stddev:11.65 (15.2%) stddev-sans-first:12.28 10:14:52 INFO - PROCESS | 1677 | Values: 74.0 79.0 87.0 76.0 56.0 56.0 62.0 80.0 77.0 56.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.50 stddev:19.31 (24.3%) stddev-sans-first:20.47 10:14:52 INFO - PROCESS | 1677 | Values: 93.0 96.0 131.0 80.0 77.0 83.0 112.0 78.0 79.0 118.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:5.44 (6.2%) stddev-sans-first:5.75 10:14:52 INFO - PROCESS | 1677 | Values: 88.0 91.0 88.0 85.0 87.0 85.0 90.0 87.0 93.0 73.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:94.00 stddev:15.72 (16.7%) stddev-sans-first:16.30 10:14:52 INFO - PROCESS | 1677 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 115.0 131.0 130.0 93.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.23 (1.4%) stddev-sans-first:1.30 10:14:52 INFO - PROCESS | 1677 | Values: 85.0 85.0 86.0 85.0 86.0 84.0 84.0 84.0 85.0 88.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.50 stddev:3.73 (6.7%) stddev-sans-first:3.94 10:14:52 INFO - PROCESS | 1677 | Values: 57.0 54.0 56.0 55.0 54.0 54.0 55.0 66.0 57.0 53.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:5.48 (7.9%) stddev-sans-first:5.57 10:14:52 INFO - PROCESS | 1677 | Values: 65.0 63.0 82.0 75.0 71.0 67.0 67.0 69.0 69.0 67.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.43 (1.7%) stddev-sans-first:1.22 10:14:52 INFO - PROCESS | 1677 | Values: 85.0 82.0 82.0 81.0 83.0 82.0 81.0 83.0 85.0 82.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:126.00 stddev:6.96 (5.5%) stddev-sans-first:6.21 10:14:52 INFO - PROCESS | 1677 | Values: 134.0 128.0 117.0 110.0 130.0 125.0 127.0 120.0 121.0 121.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.60 Median:140.00 stddev:8.69 (6.2%) stddev-sans-first:9.21 10:14:52 INFO - PROCESS | 1677 | Values: 142.0 128.0 140.0 139.0 138.0 153.0 157.0 140.0 137.0 132.0 10:14:52 INFO - PROCESS | 1677 | 10:14:52 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.36 10:14:52 INFO - PROCESS | 1677 | Values: 65.0 67.0 68.0 65.0 67.0 67.0 67.0 70.0 66.0 67.0 10:14:52 INFO - PROCESS | 1677 | -------- Summary: end -------- 10:14:52 INFO - PROCESS | 1677 | 10:14:53 INFO - TEST-INFO | 1677: exit 0 10:14:53 INFO - TEST-OK | kraken | took 56705ms 10:14:53 INFO - SUITE-END | took 1170s 10:14:53 INFO - Completed test suite (00:19:31) 10:14:53 INFO - javascript benchmark 10:14:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3253.951190732139, 3465.9826700866493, 3501.5447991761075, 3505.1938054247507, 3534.0988048047743, 5290.39160496543, 5392.056390131721, 5620.5784566157545, 5628.409017053206, 5632.239647647566, 5587.0, 5605.467480589347, 5644.74598643062, 5741.598088133832, 5751.482366587006, 5038.571721403685, 5041.067402530525, 5064.79740810369, 5074.959633275188, 5178.637495375326, 5215.191645294985, 5221.660592061504, 5272.630915835893, 5276.709780962045, 5316.76074576645, 5005.6496045276845, 5023.196288593826, 5084.034033533654, 5128.897422051576, 5204.115300398904, 5105.540501354859, 5116.565091967187, 5118.59051275897, 5136.049830781318, 5142.971405718871, 5025.14572522672, 5088.567471764904, 5089.160288552384, 5090.440051594359, 5104.897902041938, 5374.301340825707, 5478.616496845222, 5514.283143191399, 5567.972160139214, 5580.330360356743, 6153.7230824613, 6160.0759886017, 6175.104609831549, 6176.197094377702, 6196.81409557714, 6151.876962460726, 6210.782622608187, 6230.844228894269, 6238.688065596702, 6244.313125556185, 5593.272874526327, 5622.32532096151, 5697.800576979827, 5704.286964129484, 5710.65736055838, 6226.003839385677, 6235.469985051322, 6237.875242495124, 6245.000799871998, 6254.2807577129215, 5955.940440595626, 6002.129691194752, 6006.879862402728, 6007.8197654070445, 6007.849803754853, 6198.845028874314, 6224.06639004153, 6229.719662615194, 6232.501399887998, 6239.875202496016, 6098.14625952367, 6132.478739307209, 6138.1099740537375, 6145.016797312409, 6145.907811382833, 5971.850703732442, 6127.877442451126, 6148.1085242639565, 6169.56813023093, 6184.938150618436, 4823.348847905558, 4867.513248675175, 4873.122837889214, 4904.485029071968, 4925.458199598042, 4268.87193384199, 4275.87172384829, 4328.372386004012, 4330.566943305707, 4361.847335343247, 5516.172574113915, 5628.380878103405, 5635.267415236075, 5642.689652069093, 5647.491725744702, 5968.37332080134, 6078.75684972605, 6083.8174854754425, 6087.665178415141, 6129.233845769279, 5594.580406469531, 5599.160125981135, 5604.047311956977, 5634.830955071355, 5635.154726790932, 5179.171332586843, 5287.365516138088, 5293.920591191135, 5302.1781623848365, 5302.1781623848365, 6161.199044124235, 6218.657973811303, 6229.0, 6229.937700623026, 6241.875162496815, 6011.398860113954, 6017.70619316849, 6021.578489505692, 6025.0, 6093.360197179232, 6127.908081378872, 6216.067589861557, 6227.0970709246, 6229.096780966644, 6232.532560057924, 6021.578489505868, 6042.637441753509, 6055.3944605540855, 6077.270727512727, 6125.387461253839, 6150.354212807591, 6173.074038894202, 6177.135201071764, 6181.134641150333, 6187.474064704551, 5866.735996880236, 5981.222441082631, 5999.340072592098, 6016.007358785751, 6042.335343112342, 5937.614055086406, 5989.251343582052, 6011.008183649649, 6023.3374328824675, 6064.332923378513, 4786.0, 5561.249231353715, 5566.721663916707, 5630.296212973379, 5637.098064309691, 5688.5733569981585, 5752.6836024019085, 5814.854628634149, 5831.912521312099, 5890.9116363253725, 5855.238818953509, 5884.411558844081, 5884.882302353843, 5886.558508111823, 5924.170616113662], "unit": "score", "name": "dojo.html", "value": 5600.61898598608}, {"lowerIsBetter": false, "replicates": [508.2757071173577, 573.9971300143499, 579.32508627449, 617.2685367839113, 637.6684124255387, 29794.95717649883, 30140.0, 37938.8103059485, 38030.0, 38108.61891381085, 40081.799591002, 40510.79744601273, 40525.392119118165, 40567.188656226856, 40820.99999999993, 9362.578683959222, 9552.42685438876, 9559.56981935811, 9588.568514416833, 9593.04069593042, 9362.391444556117, 9528.285378596598, 9532.80934381312, 9536.856947145798, 9547.570359333846, 9479.620815167385, 9546.904530954705, 9661.0, 9666.90333096667, 9678.37090589113, 9568.808623827554, 9635.084666956627, 9638.614455421775, 9653.324267301292, 9656.034396560359, 9468.195203407719, 9608.95195524018, 9616.423014619075, 9630.036996300383, 9631.71104866855, 34094.6590534094, 35953.82023089894, 39076.609233907584, 40501.39247911284, 40552.797236013634, 3239.3683231769814, 3295.2915123248617, 3303.4178927702606, 3693.519842420495, 4106.466159399289, 28054.43891122166, 28347.433051339063, 28422.0, 28967.275818104506, 29119.41761164786, 2713.9321516962036, 2736.6031925370708, 2790.2326860113426, 2799.7760179185616, 2838.7728981681416, 366057.0, 367206.9999999973, 368306.15846920863, 370135.0, 370344.0, 45541.0, 46161.76919115383, 46205.0, 46232.84417889579, 64720.67639661772, 44785.55214447879, 44861.10277794426, 44892.87767805831, 44915.32627010597, 44972.0, 15491.690166196839, 15638.84361156374, 15651.452199172974, 15654.686906261812, 15655.217239138225, 12355.93822030884, 12472.438740256528, 12567.937160314323, 12621.349516601616, 12720.491180352683, 13070.758277963578, 14110.929445352707, 14681.77977330341, 14704.779428308584, 14749.188794616184, 6259.342769009279, 6362.300146983828, 6366.554341196164, 6410.8717825643225, 6427.839304017437, 925.842606756853, 930.3022732950287, 1019.50553981319, 1100.9889901100887, 1131.9264247823864, 28237.43525129527, 28586.85706571454, 28810.12734172272, 29031.85484072566, 29397.412051758845, 1058.6771034834296, 1067.6103222323795, 1092.470151976291, 1104.5471356743697, 1126.2904370246692, 14642.974991750476, 14654.48709295191, 14662.706745865024, 15019.849801501845, 15106.924465377602, 510806.0, 519026.0, 522963.0, 524750.0, 524838.0, 57325.713371432874, 57928.0, 57995.13007304894, 58052.0, 58073.41926580764, 1327.1373607155426, 1372.1561239837429, 1464.5825939607162, 1490.4559835659907, 1513.6594266290217, 28124.296892577848, 28651.710673019348, 28700.712992870638, 28849.278768030967, 29432.822687092277, 45828.541714582425, 46519.767401162775, 46851.0, 46928.29607555958, 46954.76522617365, 361595.0, 362533.37466624996, 364121.35878640873, 364198.0, 365185.1740741279, 28104.0, 32425.351492969538, 32588.51117233196, 32851.85018524436, 33050.504242436866, 40552.797236013634, 41294.76115716533, 41735.0, 41788.3731744018, 42333.153336933705, 34303.0, 34351.31297374088, 34524.0, 35346.0, 35423.291534169686, 33841.49237761386, 34122.658773411946, 34404.48393274153, 34707.305853883285, 34767.9569612912, 29662.154630531673, 30698.846505767327, 30981.690183097882, 35662.64337356593, 35822.8208858954, 30277.94027209125, 31099.378012440076, 31115.53326700056, 31196.0, 31229.843850780602, 23475.0, 23501.764982349956, 23676.763232368146, 24109.75890241075, 24171.51656966886], "unit": "score", "name": "ext.html", "value": 18471.065480179248}, {"lowerIsBetter": false, "replicates": [357.20343633696854, 358.652107455768, 362.37671205526493, 367.83998960452203, 372.0809600287293, 16317.0, 19959.800401995977, 20303.898480507596, 20755.584888302226, 20770.89614551925, 19956.90021549894, 20731.378058658265, 21008.264710735126, 21241.893790531063, 21245.68131478029, 5811.360750317462, 5979.880402391949, 6015.82691375182, 6031.788887388942, 6034.125051867477, 3678.2643471305714, 4327.632151267146, 5188.533032027117, 6020.367861374536, 6679.766208182715, 6579.572327798678, 6613.338666133396, 6613.603183808987, 6630.867382652344, 6632.1709786276715, 5207.713575753313, 5653.180288858113, 5933.0, 5934.5252379809945, 6595.307492713268, 3821.4458903458844, 5516.668999860021, 5656.773729050833, 5729.341125770548, 5749.568782341341, 13272.867271327355, 13462.798058029137, 13482.460701571925, 16140.677186456205, 24432.511349772903, 1964.8526360522876, 2235.58641651295, 2294.6328587426096, 2455.693038370204, 2757.696653368128, 9527.809443811155, 9617.471039092847, 9842.753931151707, 9915.256355773347, 9977.501124943796, 1656.2215758593443, 1714.3485475519346, 1745.3542189390007, 1781.536800431884, 1870.4108205915093, 93065.0, 98117.03765924713, 100286.0, 107409.46295268474, 116116.99999999916, 18003.72994405085, 18528.814711852978, 18607.44177674672, 19223.32718354851, 19231.326903558587, 28736.137915862557, 28738.982406847397, 28749.0, 28808.855955720508, 28844.567331490045, 10615.150787936947, 10920.453977301104, 10929.453527323762, 10947.397893115955, 11052.447377631086, 9310.301727370474, 9341.252699784001, 9346.672866449642, 9351.15839574428, 9393.5303234838, 8803.339749518811, 8848.026717061119, 8946.821063578822, 8960.551972401354, 8963.372563920593, 3472.774269672463, 3559.341521818472, 3567.4827150063097, 3646.580643226063, 3650.9817450912574, 805.275252272959, 812.4028838803474, 871.3943809052647, 931.5994122527243, 1041.3127335958231, 19659.213631454582, 19798.505037373892, 20079.799202008086, 20384.388468345973, 20403.8979805103, 907.3739120007306, 926.6988228825659, 954.8376775948105, 962.2398305338704, 1015.3248090020054, 10750.193735469715, 10901.945490272497, 10902.836457453144, 10920.18098642605, 10932.890671093346, 605766.0, 617750.0, 643819.0, 656440.0, 656670.0, 93095.06904931, 103813.0, 106091.40862887063, 115827.42086289515, 117311.0, 1019.8011387779312, 1025.2310766924807, 1038.6364772329623, 1046.5552140340326, 1047.0524175621076, 17521.0, 17656.117194139984, 17914.0, 18247.635047299245, 18409.447716568524, 48060.519394805604, 49490.50509494859, 49626.0, 50600.0, 50627.493725062275, 70936.0, 72513.0, 73064.0, 73071.63464182644, 73450.0, 6796.456283497408, 7490.925090749023, 7780.805479863048, 7805.258500442449, 7982.082060562877, 10720.659917510311, 11098.389588572383, 11801.881981180079, 12604.243745375306, 12733.0, 9213.815723685622, 10670.83993740079, 10959.0, 10999.065079468335, 11156.888431115909, 10326.57713464481, 10608.946955265174, 10613.734656633645, 10778.407187604756, 10885.782284354427, 11041.171912106785, 11416.486258118572, 11434.142439317251, 11440.48517816717, 11451.854814518481, 7403.407727381689, 7647.044119485065, 7683.346915512244, 7874.54320950626, 7908.762737117896, 10011.649592264235, 10781.245312828027, 11098.167637427065, 11131.833022504507, 11140.442977851237], "unit": "score", "name": "jquery.html", "value": 9970.799412097675}, {"lowerIsBetter": false, "replicates": [1461.1087236785552, 1616.7736516887635, 1634.591352161959, 1918.8273055425018, 2039.2149022626284, 7866.0, 8402.243798058174, 8579.485230886152, 8601.021764994055, 8609.096044915272, 8319.792005199874, 8550.0, 8568.485890846554, 8569.100244474319, 8578.914210857889, 1868.271374164077, 2427.4174198192395, 2444.193416172663, 2479.404942813721, 2491.202815099169, 2480.528699547089, 2523.079076137215, 2523.3439305780444, 2525.9621105683336, 2526.6715327007464, 2364.810815134785, 2381.3332266965276, 2381.535600557892, 2384.260879127476, 2414.9758502415016, 2177.1835561664375, 2424.7211570669424, 2475.158446128316, 2475.900963961439, 2479.417336925821, 2439.2682195341326, 2445.8410203336725, 2491.987540062288, 2493.463905260378, 2494.5634513959985, 8289.668413263462, 8379.329653627696, 8382.16178382157, 8388.119247478988, 8389.412741108124, 5268.789248430058, 5378.0, 5402.0, 5426.891462170774, 5434.429384914606, 3379.763416560817, 3401.2517246205794, 3565.554305711786, 3602.35157671619, 3681.44778283257, 948.5162567090833, 1046.7801761630067, 1050.4170185547018, 1053.984190237147, 1074.2533938912459, 11281.774364512663, 11481.598144065001, 11497.367644779533, 11506.769864602746, 11515.963563279345, 4831.444383895827, 4920.81900343922, 4957.925631115536, 4984.626153038536, 5007.24891266313, 10049.045340692623, 10062.0, 10078.0, 10083.596656133672, 10091.7477063074, 5467.261919640877, 5508.256385388001, 5523.061079616475, 5524.900537795612, 5530.529904958124, 4410.823567057346, 4543.045960348364, 4783.56947874686, 4831.396075490564, 4842.007388485352, 3875.8643447479767, 3957.8021098944937, 3975.8012099394914, 3997.080671445584, 4010.5588385277597, 1264.7913094339515, 1272.4083301264957, 1274.4265080713717, 1286.0483242400555, 1302.218668798732, 1344.8386193656825, 1363.6522686715023, 1381.3714759784275, 1397.9720405592034, 1421.1473116130446, 8019.198080191934, 8103.513789172668, 8115.8782618260775, 8127.75616731499, 8128.837423251502, 509.0531611203159, 516.1792749528269, 516.2205070343808, 519.7764961066778, 536.6109570561312, 6164.8767024659255, 6194.752209911643, 6228.22147231596, 6232.158658581034, 6235.158253635792, 10066.949665251626, 10490.527926243338, 10514.158867290598, 10523.368597884151, 10534.0, 9694.563744631509, 10314.968503149776, 10376.429296388771, 10376.533056012497, 10381.636642717469, 7786.299233069051, 7969.561674107979, 7991.760247192594, 7994.64024118916, 8016.759497215093, 7389.778306650809, 7798.908152858718, 7799.37604991588, 7876.763697089096, 7899.368050555827, 8884.111588841322, 9120.270378369582, 9223.400478968846, 9252.861207082035, 9345.0654934506, 9270.490123043297, 9403.623855045722, 9421.057894210799, 9522.666706665234, 9633.855492167482, 7210.242924492853, 7424.220456851953, 7442.144153422426, 7543.094828620381, 7654.081510218809, 8065.8790118149445, 8076.515409075474, 8112.351011918914, 8127.634256458592, 8128.227818357246, 6222.0, 7000.859982800417, 7064.894026589503, 7201.675924583302, 7303.014093097364, 7007.439404847702, 7087.433005359662, 7165.820854478679, 7181.820454488679, 7273.454490913308, 7423.740169094056, 7638.923610763822, 7645.961770191336, 7649.694012239448, 7665.655045523076, 6947.402097517498, 6959.095317608679, 6993.755218567326, 7009.684564194521, 7012.2286548478605, 6235.0, 6999.755008574675, 7036.296370362923, 7075.71697132109, 7095.503314767917], "unit": "score", "name": "mootools.html", "value": 4780.353127255594}, {"lowerIsBetter": false, "replicates": [313.56101457958863, 327.5071018117732, 330.8908060340088, 336.2317105414129, 339.13182253431205, 6366.663000769844, 6499.740010399584, 6513.641749703765, 6580.407763301302, 6582.901256481151, 5374.6506477078965, 5674.971625141869, 6511.2837587865415, 6541.7710380136705, 6560.244697227164, 4065.8983525411804, 4750.358701575277, 4755.26293424518, 4823.011282687041, 4884.511548845114, 4806.543378379049, 4817.494163112858, 4832.323474713526, 4836.46798852126, 4841.661083724141, 4810.735409552473, 4826.7586620669, 4833.830815921444, 4842.515748425165, 4850.4179498460235, 4337.154254920292, 4398.0, 4669.159551280768, 4807.326974223576, 4834.2265237562, 4127.545969943304, 4136.379543068534, 4136.400221967828, 4146.440230568895, 4169.624733773975, 5189.495046436529, 6216.3162052174675, 6225.19072520574, 6284.685765711696, 6293.748250069992, 5690.2033715279895, 5701.486866182022, 5707.0, 5707.914381284284, 5708.257926469574, 6925.549839260432, 6933.514653974224, 6935.72257109715, 6936.09830722008, 6953.0, 4319.265724826787, 4500.639948804088, 4511.390962220124, 4514.210013247702, 4668.6731928765, 7129.358357747776, 7153.6065516396575, 7245.963770181168, 7251.963740181265, 7320.560766353982, 4576.748278844696, 4592.380028696083, 4592.931106033412, 4599.218132917345, 4607.861764147081, 4273.978630106892, 4375.993521490075, 4631.536846315342, 4644.651651126179, 4678.157931572349, 4634.768261586907, 5503.944960550423, 5513.338399392099, 5515.972420137874, 5522.972385138049, 6639.1037209977, 6930.653467326613, 6944.548604340803, 6980.371766541036, 7005.299470053056, 1435.978460323096, 1539.7536394176877, 1603.1503303249297, 1613.6691978144452, 1617.9887570268581, 1033.8294181460126, 1038.5118994072925, 1047.157038583932, 1062.0388548363744, 1064.3241541621126, 5744.454276843693, 6412.326705695835, 6469.256035555877, 6586.506012049115, 6588.96705516479, 6064.818055458255, 6605.735770569219, 7261.5280006799385, 7290.890636640454, 7296.087989001375, 6564.540482166202, 6568.310327415648, 6574.243961944342, 6575.375339342755, 6576.473882089517, 3789.3558095123894, 3834.1948190880225, 3837.6354246346555, 3841.961580384216, 3844.7885366304563, 7343.77968660941, 7606.201348858401, 7610.429217808686, 7646.0, 7674.53952762836, 7467.813304667427, 7489.400847932152, 7495.737649182252, 7507.211742766931, 7509.474336796372, 7607.315341619281, 7620.504667196615, 7637.312641862259, 7640.388768898475, 7656.042994625672, 7037.867648878743, 7250.746223882139, 7269.127704675473, 7274.781756547312, 7289.781306560812, 7023.157221133497, 7125.857482850418, 7151.0, 7159.319864612853, 7180.210176880434, 6580.012998050331, 7538.773836784905, 7597.696092156252, 7609.162992070757, 7629.321549259154, 4433.357163211252, 4614.861554153381, 4616.399868017271, 4619.630429565694, 4640.721556706609, 7132.037174981519, 7136.750213742494, 7144.749933752501, 7157.105361829771, 7172.533785303938, 5823.970880145572, 6641.1034510342415, 6931.2375638678695, 6983.127109111361, 6998.475114366341, 6919.861602767815, 6955.130608673916, 6966.756163534252, 6972.0, 6981.5461994970165, 6803.149606299213, 6814.352636499525, 6822.727090916506, 6826.249112597511, 6833.077534532775, 6694.464442844658, 6925.549839260633, 6927.445804335742, 6929.549579277331, 6940.548864324005, 6538.280789113289, 6572.868542629025, 6753.3246675332075, 6824.0, 6865.691043902936], "unit": "score", "name": "prototype.html", "value": 5065.84715039037}, {"lowerIsBetter": false, "replicates": [562.3083607163192, 578.7164289498145, 651.2575663743334, 680.4998326230223, 713.0409599089223, 14910.329035193416, 15169.544913652608, 15170.317335719892, 15175.165365904884, 15199.848001519968, 13264.535741249058, 13268.800967985488, 13315.733685326311, 13351.465941362334, 13389.799153012713, 740.2486476226634, 753.7437271327748, 905.9909400906006, 925.7593025813303, 926.0, 888.1296329596998, 933.4492649336889, 933.6405483888718, 934.7616357828745, 936.0499093420184, 965.9661911833088, 978.227200511595, 979.0503211884461, 979.1236843025488, 979.6179489998906, 774.1523032279673, 921.230772305126, 967.5259123029736, 973.5424350555228, 974.7563109222694, 719.5790462579397, 719.9856002879914, 720.099875156055, 720.4200618502103, 720.7801620505744, 14858.554243372717, 14990.100593964396, 14993.0, 15006.324715387835, 15008.399664013426, 12451.501939922393, 12497.875021249762, 12498.812517812241, 12759.74480510394, 12867.09930304879, 9903.0, 9976.700698979042, 10044.547995340226, 10252.179825613934, 10936.890631093745, 3520.9965159929297, 3556.5554305711785, 3598.046517672819, 3635.600083990759, 3661.6887564557046, 83540.58229708874, 84588.0, 86732.0, 86813.13186868177, 86821.56589217077, 9446.480443575669, 9610.790364324053, 9619.134277915022, 9656.71029869105, 9890.950545247371, 20776.96115194234, 20948.162073516887, 20958.371248862557, 20971.056302466426, 20993.89503052475, 7484.326410622961, 7564.735234266775, 7602.163761986177, 7752.91459195713, 7836.373090152774, 4177.206330797138, 4192.727472714264, 4226.260404429274, 4229.302165142717, 4269.060806622538, 3637.5998640149564, 3673.1735359544423, 3681.9631803682155, 3684.2631473705364, 3686.594474607791, 575.6977586766981, 622.4491325177161, 633.0, 645.3417514135556, 655.5476721062547, 506.17493485618206, 556.5658786146812, 561.7331767410448, 562.4768964862635, 581.9941800582025, 6813.659317034128, 7857.528548287121, 7871.409644276702, 7940.563269020259, 8073.798155046054, 530.8672831792052, 568.4741614007027, 568.8265079150899, 571.4371344225934, 574.5001848391843, 3719.702423806089, 3725.3108174987715, 3753.530808648919, 3783.4703141559653, 3936.7441116327345, 94124.52937735268, 95716.52141739246, 96663.0, 97505.0, 97593.0, 77200.61399692965, 79476.60261698655, 79483.60258198672, 80729.19270807334, 81280.59359703163, 68037.65981170062, 70100.64949675219, 71304.64347678333, 72192.55614887777, 73829.26170738223, 7471.850562988819, 7518.28576285252, 7674.117476490052, 7705.576193309197, 7765.572893490912, 46399.0, 47580.52419475761, 48766.268505971726, 50719.98560028853, 51336.45990620287, 66578.66710666416, 70430.0, 72261.6386918062, 72382.91425628724, 73086.63456682682, 10912.836307455553, 11027.064711301638, 11267.887321127011, 11397.829032564685, 11625.6512304631, 12080.39598020078, 12119.394030298627, 12183.512659493876, 12188.634340969786, 12264.0, 11536.307821530734, 11736.119791015879, 11835.0, 11863.0, 11951.0, 11478.426078695864, 11536.942315288705, 11552.191346605658, 11591.710207244887, 11603.129765267808, 9581.377210481296, 11163.609273675382, 11205.327680339205, 11262.718432039264, 11640.592579259684, 9352.906470935204, 9429.905700943178, 9504.619815207314, 9609.855852162083, 9996.800063998533, 9555.522223888916, 9561.569729362334, 9655.461096106168, 9667.081627245401, 9671.9032809671], "unit": "score", "name": "yui.html", "value": 6884.766985488564}], "name": "dromaeo_css", "value": 7457.312634164152}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 111.0, 112.0, 112.0, 113.0, 117.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 149.0, 181.0, 143.0, 139.0, 141.0, 115.0, 157.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [188.0, 185.0, 185.0, 185.0, 184.0, 185.0, 186.0, 186.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [74.0, 79.0, 87.0, 76.0, 56.0, 56.0, 62.0, 80.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 131.0, 80.0, 77.0, 83.0, 112.0, 78.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [88.0, 91.0, 88.0, 85.0, 87.0, 85.0, 90.0, 87.0, 93.0, 73.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 115.0, 131.0, 130.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 85.0, 86.0, 84.0, 84.0, 84.0, 85.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 55.0, 54.0, 54.0, 55.0, 66.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 82.0, 75.0, 71.0, 67.0, 67.0, 69.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 82.0, 81.0, 83.0, 82.0, 81.0, 83.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [134.0, 128.0, 117.0, 110.0, 130.0, 125.0, 127.0, 120.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [142.0, 128.0, 140.0, 139.0, 138.0, 153.0, 157.0, 140.0, 137.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 68.0, 65.0, 67.0, 67.0, 67.0, 70.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1418.4}]} 10:14:53 INFO - Return code: 0 10:14:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:14:54 ERROR - # TBPL SUCCESS # 10:14:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:14:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:14:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:14:54 INFO - 2016-03-21 10:14:54.063 screenresolution[1681:10394] starting screenresolution argv=screenresolution get 10:14:54 INFO - 2016-03-21 10:14:54.066 screenresolution[1681:10394] Display 0: 1600x1200x32@60 10:14:54 INFO - 2016-03-21 10:14:54.072 screenresolution[1682:10397] starting screenresolution argv=screenresolution list 10:14:54 INFO - Available Modes on Display 0 10:14:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:14:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:14:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:14:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:14:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:14:54 INFO - Intel Iris: 10:14:54 INFO - Chipset Model: Intel Iris 10:14:54 INFO - Type: GPU 10:14:54 INFO - Bus: Built-In 10:14:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:14:54 INFO - Vendor: Intel (0x8086) 10:14:54 INFO - Device ID: 0x0a2e 10:14:54 INFO - Revision ID: 0x0009 10:14:54 INFO - Displays: 10:14:54 INFO - Display: 10:14:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:14:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:14:54 INFO - Display Serial Number: 1600x1200 60 10:14:54 INFO - Main Display: Yes 10:14:54 INFO - Mirror: Off 10:14:54 INFO - Online: Yes 10:14:54 INFO - Rotation: Supported 10:14:54 INFO - Return code: 0 10:14:54 INFO - Running post-action listener: _resource_record_post_action 10:14:54 INFO - Running post-run listener: _resource_record_post_run 10:14:55 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34045440; Write bytes: 705827328; Read time: 358; Write time: 1915 10:14:55 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387514880; Write bytes: 381687296; Read time: 29864; Write time: 692 10:14:55 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33107456; Write bytes: 301390848; Read time: 343; Write time: 1173 10:14:55 INFO - Running post-run listener: _upload_blobber_files 10:14:55 INFO - Blob upload gear active. 10:14:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:55 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 10:14:55 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'] 10:14:55 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 10:14:55 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:56 INFO - (blobuploader) - INFO - Done attempting. 10:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:14:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:14:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:57 INFO - (blobuploader) - INFO - Done attempting. 10:14:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:57 INFO - Return code: 0 10:14:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0608801faa8e7474f13fff314e60b6fd96a7257bbd2c95828082e10d2115ff13fe0519ef404af24adb0f3dc38218290ac70e3088da4206ad6eb7bfb72c40c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a656ca049397f86dab4fbe880c1ffbdf1c690117c864db4fb33b3adaf61ba2f60eb9e7ba13af1c6570b98b666404ad810873237feecba068039f39976c1382"} 10:14:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:57 INFO - Contents: 10:14:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0608801faa8e7474f13fff314e60b6fd96a7257bbd2c95828082e10d2115ff13fe0519ef404af24adb0f3dc38218290ac70e3088da4206ad6eb7bfb72c40c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a656ca049397f86dab4fbe880c1ffbdf1c690117c864db4fb33b3adaf61ba2f60eb9e7ba13af1c6570b98b666404ad810873237feecba068039f39976c1382"} 10:14:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:57 INFO - Copying logs to upload dir... 10:14:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.848236 ========= master_lag: 0.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-21 10:14:58.369139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-21 10:14:58.371819) ========= 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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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/4a0608801faa8e7474f13fff314e60b6fd96a7257bbd2c95828082e10d2115ff13fe0519ef404af24adb0f3dc38218290ac70e3088da4206ad6eb7bfb72c40c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a656ca049397f86dab4fbe880c1ffbdf1c690117c864db4fb33b3adaf61ba2f60eb9e7ba13af1c6570b98b666404ad810873237feecba068039f39976c1382"} build_url:https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/HkjXpf9zS-uHsug36h_7bQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a0608801faa8e7474f13fff314e60b6fd96a7257bbd2c95828082e10d2115ff13fe0519ef404af24adb0f3dc38218290ac70e3088da4206ad6eb7bfb72c40c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a656ca049397f86dab4fbe880c1ffbdf1c690117c864db4fb33b3adaf61ba2f60eb9e7ba13af1c6570b98b666404ad810873237feecba068039f39976c1382"}' ========= master_lag: 1.95 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-21 10:15:00.335666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-21 10:15:00.336035) ========= 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.E9GlifiIHH/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.wzzlqFMs5E/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005180 ========= master_lag: 5.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-03-21 10:15:05.518896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 10:15:05.519189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 10:15:06.199514) ========= ========= Total master_lag: 55.67 =========