builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1458591545.22 results: success (0) buildid: 20160321111439 builduid: ca00d744db714252bc5f2e84d95e4ce3 revision: 3dc5292ed66afbca801c33bff49c86154b3b3c24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.216711) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.217164) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.217457) ========= 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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005871 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.274709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.275033) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.366584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.366980) ========= 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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005354 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.452606) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.452990) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.453339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.453621) ========= 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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:19:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.39M=0.001s 2016-03-21 13:19:05 (8.39 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.252859 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.742426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.742750) ========= 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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.019188 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:05.832341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 13:19:05.832776) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3dc5292ed66afbca801c33bff49c86154b3b3c24 --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 3dc5292ed66afbca801c33bff49c86154b3b3c24 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:19:05,901 truncating revision to first 12 chars 2016-03-21 13:19:05,901 Setting DEBUG logging. 2016-03-21 13:19:05,901 attempt 1/10 2016-03-21 13:19:05,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3dc5292ed66a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 13:19:06,520 unpacking tar archive at: fx-team-3dc5292ed66a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963620 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 13:19:06.833412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:06.833754) ========= echo 3dc5292ed66afbca801c33bff49c86154b3b3c24 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3dc5292ed66afbca801c33bff49c86154b3b3c24'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 3dc5292ed66afbca801c33bff49c86154b3b3c24 program finished with exit code 0 elapsedTime=0.004423 script_repo_revision: '3dc5292ed66afbca801c33bff49c86154b3b3c24' ========= master_lag: 0.09 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:06.931339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:06.931750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 13:19:07.023126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-03-21 13:19:07.023507) ========= /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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:19:07 INFO - MultiFileLogger online at 20160321 13:19:07 in /builds/slave/test 13:19:07 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 13:19:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:19:07 INFO - {'append_to_log': False, 13:19:07 INFO - 'base_work_dir': '/builds/slave/test', 13:19:07 INFO - 'blob_upload_branch': 'Fx-Team', 13:19:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:19:07 INFO - 'branch': 'Fx-Team', 13:19:07 INFO - 'buildbot_json_path': 'buildprops.json', 13:19:07 INFO - 'config_files': ('talos/mac_config.py',), 13:19:07 INFO - 'default_actions': ('clobber', 13:19:07 INFO - 'read-buildbot-config', 13:19:07 INFO - 'download-and-extract', 13:19:07 INFO - 'populate-webroot', 13:19:07 INFO - 'create-virtualenv', 13:19:07 INFO - 'install', 13:19:07 INFO - 'run-tests'), 13:19:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:19:07 INFO - 'download_minidump_stackwalk': True, 13:19:07 INFO - 'download_symbols': 'ondemand', 13:19:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:19:07 INFO - 'tooltool.py': '/tools/tooltool.py', 13:19:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:19:07 INFO - '/tools/misc-python/virtualenv.py')}, 13:19:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:19:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:19:07 INFO - 'installer_path': 'installer.exe', 13:19:07 INFO - 'log_level': 'info', 13:19:07 INFO - 'log_name': 'talos', 13:19:07 INFO - 'log_to_console': True, 13:19:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:19:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:19:07 INFO - 'opt_config_files': (), 13:19:07 INFO - 'pip_index': False, 13:19:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:19:07 INFO - 'cmd': ('bash', 13:19:07 INFO - '-c', 13:19:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:19:07 INFO - 'enabled': True, 13:19:07 INFO - 'halt_on_failure': False, 13:19:07 INFO - 'name': 'check_screen_resolution'},), 13:19:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:19:07 INFO - 'cmd': ('bash', 13:19:07 INFO - '-c', 13:19:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:19:07 INFO - 'enabled': True, 13:19:07 INFO - 'halt_on_failure': False, 13:19:07 INFO - 'name': 'check_screen_resolution'},), 13:19:07 INFO - 'run_cmd_checks_enabled': True, 13:19:07 INFO - 'sps_profile': False, 13:19:07 INFO - 'sps_profile_interval': 0, 13:19:07 INFO - 'suite': 'dromaeojs', 13:19:07 INFO - 'system_bits': '32', 13:19:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:19:07 INFO - 'title': 't-yosemite-r7-0037', 13:19:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:19:07 INFO - 'use_talos_json': True, 13:19:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:19:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:19:07 INFO - 'work_dir': 'build'} 13:19:07 INFO - ##### 13:19:07 INFO - ##### Running clobber step. 13:19:07 INFO - ##### 13:19:07 INFO - Running pre-action listener: _resource_record_pre_action 13:19:07 INFO - Running main action method: clobber 13:19:07 INFO - rmtree: /builds/slave/test/build 13:19:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:19:07 INFO - Running post-action listener: _resource_record_post_action 13:19:07 INFO - ##### 13:19:07 INFO - ##### Running read-buildbot-config step. 13:19:07 INFO - ##### 13:19:07 INFO - Running pre-action listener: _resource_record_pre_action 13:19:07 INFO - Running main action method: read_buildbot_config 13:19:07 INFO - Using buildbot properties: 13:19:07 INFO - { 13:19:07 INFO - "project": "", 13:19:07 INFO - "product": "firefox", 13:19:07 INFO - "script_repo_revision": "production", 13:19:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:19:07 INFO - "repository": "", 13:19:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:19:07 INFO - "buildid": "20160321111439", 13:19:07 INFO - "pgo_build": "False", 13:19:07 INFO - "basedir": "/builds/slave/test", 13:19:07 INFO - "buildnumber": 541, 13:19:07 INFO - "slavename": "t-yosemite-r7-0037", 13:19:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:19:07 INFO - "platform": "yosemite_r7", 13:19:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:19:07 INFO - "branch": "fx-team", 13:19:07 INFO - "repo_path": "integration/fx-team", 13:19:07 INFO - "revision": "3dc5292ed66afbca801c33bff49c86154b3b3c24", 13:19:07 INFO - "stage_platform": "macosx64", 13:19:07 INFO - "builduid": "ca00d744db714252bc5f2e84d95e4ce3", 13:19:07 INFO - "slavebuilddir": "test" 13:19:07 INFO - } 13:19:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 13:19:07 INFO - Running post-action listener: _resource_record_post_action 13:19:07 INFO - ##### 13:19:07 INFO - ##### Running download-and-extract step. 13:19:07 INFO - ##### 13:19:07 INFO - Running pre-action listener: _resource_record_pre_action 13:19:07 INFO - Running main action method: download_and_extract 13:19:07 INFO - mkdir: /builds/slave/test/build/tests 13:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:07 INFO - https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:08 INFO - Downloaded 1199 bytes. 13:19:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:19:08 INFO - Using the following test package requirements: 13:19:08 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:19:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 13:19:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 13:19:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'jsshell-mac.zip'], 13:19:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 13:19:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:19:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 13:19:08 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 13:19:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 13:19:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:19:08 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 13:19:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:19:08 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')]} 13:19:08 INFO - https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:19:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:19:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:19:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:12 INFO - Downloaded 17858506 bytes. 13:19:12 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'] 13:19:12 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 13:19:15 INFO - Return code: 0 13:19:15 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 13:19: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')]} 13:19:15 INFO - https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:23 INFO - Downloaded 17858506 bytes. 13:19:23 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'] 13:19:23 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 13:19:27 INFO - Return code: 0 13:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:27 INFO - https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:31 INFO - Downloaded 10847637 bytes. 13:19:31 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'] 13:19:31 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 13:19:32 INFO - Return code: 0 13:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:19:32 INFO - https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:19:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:19:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:19:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 13:19:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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 13:19:54 INFO - Downloaded 111262085 bytes. 13:19:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:19:54 INFO - mkdir: /builds/slave/test/properties 13:19:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:19:54 INFO - Writing to file /builds/slave/test/properties/build_url 13:19:54 INFO - Contents: 13:19:54 INFO - build_url:https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:19:56 INFO - Running post-action listener: _resource_record_post_action 13:19:56 INFO - Running post-action listener: set_extra_try_arguments 13:19:56 INFO - ##### 13:19:56 INFO - ##### Running populate-webroot step. 13:19:56 INFO - ##### 13:19:56 INFO - Running pre-action listener: _resource_record_pre_action 13:19:56 INFO - Running main action method: populate_webroot 13:19:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:19:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:19:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:19:56 INFO - '--tppagecycles', 13:19:56 INFO - '7'], 13:19:56 INFO - 'tests': ['tsvgm']}}, 13:19:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:19:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:19:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:19:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:19:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:19:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'tests': ['damp', 'tps']}, 13:19:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['damp', 'tps']}, 13:19:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:19:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:19:56 INFO - 'other': {'tests': ['a11yr', 13:19:56 INFO - 'ts_paint', 13:19:56 INFO - 'tpaint', 13:19:56 INFO - 'sessionrestore', 13:19:56 INFO - 'sessionrestore_no_auto_restore', 13:19:56 INFO - 'tabpaint']}, 13:19:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['a11yr', 13:19:56 INFO - 'ts_paint', 13:19:56 INFO - 'tpaint', 13:19:56 INFO - 'sessionrestore', 13:19:56 INFO - 'sessionrestore_no_auto_restore', 13:19:56 INFO - 'tabpaint']}, 13:19:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['a11yr', 13:19:56 INFO - 'ts_paint', 13:19:56 INFO - 'tpaint', 13:19:56 INFO - 'sessionrestore', 13:19:56 INFO - 'sessionrestore_no_auto_restore', 13:19:56 INFO - 'tabpaint']}, 13:19:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['a11yr', 13:19:56 INFO - 'ts_paint', 13:19:56 INFO - 'tpaint', 13:19:56 INFO - 'sessionrestore', 13:19:56 INFO - 'sessionrestore_no_auto_restore', 13:19:56 INFO - 'tabpaint']}, 13:19:56 INFO - 'other_l64': {'tests': ['a11yr', 13:19:56 INFO - 'ts_paint', 13:19:56 INFO - 'tpaint', 13:19:56 INFO - 'sessionrestore', 13:19:56 INFO - 'sessionrestore_no_auto_restore', 13:19:56 INFO - 'tabpaint']}, 13:19:56 INFO - 'other_nol64': {'tests': ['a11yr', 13:19:56 INFO - 'ts_paint', 13:19:56 INFO - 'tpaint', 13:19:56 INFO - 'sessionrestore', 13:19:56 INFO - 'sessionrestore_no_auto_restore', 13:19:56 INFO - 'tabpaint']}, 13:19:56 INFO - 'svgr': {'tests': ['tsvgx', 13:19:56 INFO - 'tsvgr_opacity', 13:19:56 INFO - 'tart', 13:19:56 INFO - 'tscrollx', 13:19:56 INFO - 'cart']}, 13:19:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['tsvgx', 13:19:56 INFO - 'tsvgr_opacity', 13:19:56 INFO - 'tart', 13:19:56 INFO - 'tscrollx', 13:19:56 INFO - 'cart']}, 13:19:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'tests': ['tp5o']}, 13:19:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'talos_options': ['--e10s'], 13:19:56 INFO - 'tests': ['tp5o']}, 13:19:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'talos_options': ['--xperf_path', 13:19:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:56 INFO - 'tests': ['tp5n']}, 13:19:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:19:56 INFO - 'talos_options': ['--e10s', 13:19:56 INFO - '--xperf_path', 13:19:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:19:56 INFO - 'tests': ['tp5n']}}, 13:19:56 INFO - 'talos.zip': {'path': '', 13:19:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:19:56 INFO - Running post-action listener: _resource_record_post_action 13:19:56 INFO - ##### 13:19:56 INFO - ##### Running create-virtualenv step. 13:19:56 INFO - ##### 13:19:56 INFO - Running pre-action listener: _resource_record_pre_action 13:19:56 INFO - Running main action method: create_virtualenv 13:19:56 INFO - Creating virtualenv /builds/slave/test/build/venv 13:19:56 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 13:19:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:19:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:19:56 INFO - Using real prefix '/tools/python27' 13:19:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:19:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:19:59 INFO - Installing pip.................done. 13:19:59 INFO - Return code: 0 13:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:19:59 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')]} 13:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:59 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')]} 13:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:19:59 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:19:59 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 13:19:59 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 13:19:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:19:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:19:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:19:59 INFO - 'HOME': '/Users/cltbld', 13:19:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:19:59 INFO - 'LOGNAME': 'cltbld', 13:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:19:59 INFO - 'MOZ_NO_REMOTE': '1', 13:19:59 INFO - 'NO_EM_RESTART': '1', 13:19:59 INFO - 'PAGER': '/bin/cat', 13:19:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:19:59 INFO - 'PWD': '/builds/slave/test', 13:19:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:19:59 INFO - 'SHELL': '/bin/bash', 13:19:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:19:59 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:19:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:19:59 INFO - 'USER': 'cltbld', 13:19:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:19:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:19:59 INFO - 'XPC_FLAGS': '0x0', 13:19:59 INFO - 'XPC_SERVICE_NAME': '0', 13:19:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:00 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 13:20:00 INFO - Cleaning up... 13:20:00 INFO - Return code: 0 13:20:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:20:00 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')]} 13:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:00 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')]} 13:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:00 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:00 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 13:20:00 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 13:20:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:00 INFO - 'HOME': '/Users/cltbld', 13:20:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:00 INFO - 'LOGNAME': 'cltbld', 13:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:00 INFO - 'MOZ_NO_REMOTE': '1', 13:20:00 INFO - 'NO_EM_RESTART': '1', 13:20:00 INFO - 'PAGER': '/bin/cat', 13:20:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:00 INFO - 'PWD': '/builds/slave/test', 13:20:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:00 INFO - 'SHELL': '/bin/bash', 13:20:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:00 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:00 INFO - 'USER': 'cltbld', 13:20:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:00 INFO - 'XPC_FLAGS': '0x0', 13:20:00 INFO - 'XPC_SERVICE_NAME': '0', 13:20:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:00 INFO - Downloading/unpacking psutil>=0.7.1 13:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:20:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:07 INFO - Installing collected packages: psutil 13:20:07 INFO - Running setup.py install for psutil 13:20:07 INFO - building 'psutil._psutil_osx' extension 13:20:07 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 13:20:07 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 13:20:07 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 13:20:07 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 13:20:07 INFO - building 'psutil._psutil_posix' extension 13:20:07 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 13:20:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:20:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:20:07 INFO - ^ 13:20:07 INFO - 1 warning generated. 13:20:07 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 13:20:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:20:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:20:07 INFO - Successfully installed psutil 13:20:07 INFO - Cleaning up... 13:20:07 INFO - Return code: 0 13:20:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:20:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:07 INFO - 'HOME': '/Users/cltbld', 13:20:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:07 INFO - 'LOGNAME': 'cltbld', 13:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:07 INFO - 'MOZ_NO_REMOTE': '1', 13:20:07 INFO - 'NO_EM_RESTART': '1', 13:20:07 INFO - 'PAGER': '/bin/cat', 13:20:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:07 INFO - 'PWD': '/builds/slave/test', 13:20:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:07 INFO - 'SHELL': '/bin/bash', 13:20:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:07 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:07 INFO - 'USER': 'cltbld', 13:20:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:07 INFO - 'XPC_FLAGS': '0x0', 13:20:07 INFO - 'XPC_SERVICE_NAME': '0', 13:20:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:20:08 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 13:20:08 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 13:20:08 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 13:20:08 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 13:20:08 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 13:20:08 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 13:20:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:20:12 INFO - Installing collected packages: mozsystemmonitor 13:20:12 INFO - Running setup.py install for mozsystemmonitor 13:20:12 INFO - Successfully installed mozsystemmonitor 13:20:12 INFO - Cleaning up... 13:20:12 INFO - Return code: 0 13:20:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:12 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:12 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 13:20:12 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 13:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:12 INFO - 'HOME': '/Users/cltbld', 13:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:12 INFO - 'LOGNAME': 'cltbld', 13:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:12 INFO - 'MOZ_NO_REMOTE': '1', 13:20:12 INFO - 'NO_EM_RESTART': '1', 13:20:12 INFO - 'PAGER': '/bin/cat', 13:20:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:12 INFO - 'PWD': '/builds/slave/test', 13:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:12 INFO - 'SHELL': '/bin/bash', 13:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:12 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:12 INFO - 'USER': 'cltbld', 13:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:12 INFO - 'XPC_FLAGS': '0x0', 13:20:12 INFO - 'XPC_SERVICE_NAME': '0', 13:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:12 INFO - Downloading/unpacking blobuploader==1.2.4 13:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:16 INFO - Downloading blobuploader-1.2.4.tar.gz 13:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:20:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:20:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20: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 13:20:17 INFO - Downloading docopt-0.6.1.tar.gz 13:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:20:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:20:17 INFO - Running setup.py install for blobuploader 13:20:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:20:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:20:17 INFO - Running setup.py install for requests 13:20:18 INFO - Running setup.py install for docopt 13:20:18 INFO - Successfully installed blobuploader requests docopt 13:20:18 INFO - Cleaning up... 13:20:18 INFO - Return code: 0 13:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:18 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:18 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 13:20:18 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 13:20:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:18 INFO - 'HOME': '/Users/cltbld', 13:20:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:18 INFO - 'LOGNAME': 'cltbld', 13:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:18 INFO - 'MOZ_NO_REMOTE': '1', 13:20:18 INFO - 'NO_EM_RESTART': '1', 13:20:18 INFO - 'PAGER': '/bin/cat', 13:20:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:18 INFO - 'PWD': '/builds/slave/test', 13:20:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:18 INFO - 'SHELL': '/bin/bash', 13:20:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:18 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:18 INFO - 'USER': 'cltbld', 13:20:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:18 INFO - 'XPC_FLAGS': '0x0', 13:20:18 INFO - 'XPC_SERVICE_NAME': '0', 13:20:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-bTl_7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Fs_f1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-FAd9QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-R7RndU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-hi_dpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qqQRQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7_1fk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fRsm7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9iYLoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pRKw8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-crc18J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CQ3GKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7eJwkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:19 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-I9GyMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:20 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-sCuOZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:20 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-O4CANg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:20 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-O3W3io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:20:20 INFO - Running setup.py install for manifestparser 13:20:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:20:20 INFO - Running setup.py install for mozcrash 13:20:20 INFO - Running setup.py install for mozdebug 13:20:20 INFO - Running setup.py install for mozdevice 13:20:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:20:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:20:20 INFO - Running setup.py install for mozfile 13:20:21 INFO - Running setup.py install for mozhttpd 13:20:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Running setup.py install for mozinfo 13:20:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Running setup.py install for mozInstall 13:20:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Running setup.py install for mozleak 13:20:21 INFO - Running setup.py install for mozlog 13:20:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Running setup.py install for moznetwork 13:20:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:20:21 INFO - Running setup.py install for mozprocess 13:20:22 INFO - Running setup.py install for mozprofile 13:20:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:20:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:20:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:20:22 INFO - Running setup.py install for mozrunner 13:20:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:20:22 INFO - Running setup.py install for mozscreenshot 13:20:22 INFO - Running setup.py install for moztest 13:20:22 INFO - Running setup.py install for mozversion 13:20:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:20:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:20:22 INFO - Cleaning up... 13:20:22 INFO - Return code: 0 13:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:22 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:22 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 13:20:22 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 13:20:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:22 INFO - 'HOME': '/Users/cltbld', 13:20:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:22 INFO - 'LOGNAME': 'cltbld', 13:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:22 INFO - 'MOZ_NO_REMOTE': '1', 13:20:22 INFO - 'NO_EM_RESTART': '1', 13:20:22 INFO - 'PAGER': '/bin/cat', 13:20:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:22 INFO - 'PWD': '/builds/slave/test', 13:20:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:22 INFO - 'SHELL': '/bin/bash', 13:20:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:22 INFO - 'USER': 'cltbld', 13:20:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:22 INFO - 'XPC_FLAGS': '0x0', 13:20:22 INFO - 'XPC_SERVICE_NAME': '0', 13:20:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-WO4nv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-TJqFmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-AniMw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-t_jGSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-4Q1mEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-wWYoci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-vkBBbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:20:23 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)) 13:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:20:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jkwDXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7lrqxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-GfDig9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ynjgmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UZGWAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-k8BrbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-JmIkHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-N8melR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XiGFCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:20:24 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)) 13:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:20:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZI4SQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:20:24 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)) 13:20:24 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)) 13:20:24 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)) 13:20:24 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)) 13:20:24 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)) 13:20:24 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)) 13:20:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:28 INFO - Downloading blessings-1.6.tar.gz 13:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:20:28 INFO - Installing collected packages: blessings 13:20:28 INFO - Running setup.py install for blessings 13:20:28 INFO - Successfully installed blessings 13:20:28 INFO - Cleaning up... 13:20:28 INFO - Return code: 0 13:20:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:28 INFO - Reading from file tmpfile_stdout 13:20:28 INFO - Current package versions: 13:20:28 INFO - blessings == 1.6 13:20:28 INFO - blobuploader == 1.2.4 13:20:28 INFO - docopt == 0.6.1 13:20:28 INFO - manifestparser == 1.1 13:20:28 INFO - mozInstall == 1.12 13:20:28 INFO - mozcrash == 0.17 13:20:28 INFO - mozdebug == 0.1 13:20:28 INFO - mozdevice == 0.48 13:20:28 INFO - mozfile == 1.2 13:20:28 INFO - mozhttpd == 0.7 13:20:28 INFO - mozinfo == 0.9 13:20:28 INFO - mozleak == 0.1 13:20:28 INFO - mozlog == 3.1 13:20:28 INFO - moznetwork == 0.27 13:20:28 INFO - mozprocess == 0.22 13:20:28 INFO - mozprofile == 0.28 13:20:28 INFO - mozrunner == 6.11 13:20:28 INFO - mozscreenshot == 0.1 13:20:28 INFO - mozsystemmonitor == 0.0 13:20:28 INFO - moztest == 0.7 13:20:28 INFO - mozversion == 1.4 13:20:28 INFO - psutil == 3.1.1 13:20:28 INFO - requests == 1.2.3 13:20:28 INFO - wsgiref == 0.1.2 13:20:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:28 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:28 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 13:20:28 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 13:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:28 INFO - 'HOME': '/Users/cltbld', 13:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:28 INFO - 'LOGNAME': 'cltbld', 13:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:28 INFO - 'MOZ_NO_REMOTE': '1', 13:20:28 INFO - 'NO_EM_RESTART': '1', 13:20:28 INFO - 'PAGER': '/bin/cat', 13:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:28 INFO - 'PWD': '/builds/slave/test', 13:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:28 INFO - 'SHELL': '/bin/bash', 13:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:28 INFO - 'USER': 'cltbld', 13:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:28 INFO - 'XPC_FLAGS': '0x0', 13:20:28 INFO - 'XPC_SERVICE_NAME': '0', 13:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 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)) 13:20:29 INFO - Cleaning up... 13:20:29 INFO - Return code: 0 13:20:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:20:29 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')]} 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:29 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')]} 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:29 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:29 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 13:20:29 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 13:20:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:29 INFO - 'HOME': '/Users/cltbld', 13:20:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:29 INFO - 'LOGNAME': 'cltbld', 13:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:29 INFO - 'MOZ_NO_REMOTE': '1', 13:20:29 INFO - 'NO_EM_RESTART': '1', 13:20:29 INFO - 'PAGER': '/bin/cat', 13:20:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:29 INFO - 'PWD': '/builds/slave/test', 13:20:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:29 INFO - 'SHELL': '/bin/bash', 13:20:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:29 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:29 INFO - 'USER': 'cltbld', 13:20:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:29 INFO - 'XPC_FLAGS': '0x0', 13:20:29 INFO - 'XPC_SERVICE_NAME': '0', 13:20:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:29 INFO - Downloading/unpacking jsonschema 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:20:32 INFO - Downloading/unpacking functools32 (from jsonschema) 13:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:20:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:20:33 INFO - warning: no files found matching '*.txt' 13:20:33 INFO - no previously-included directories found matching 'build' 13:20:33 INFO - no previously-included directories found matching 'dist' 13:20:33 INFO - no previously-included directories found matching '.git*' 13:20:33 INFO - Installing collected packages: jsonschema, functools32 13:20:33 INFO - Running setup.py install for functools32 13:20:33 INFO - warning: no files found matching '*.txt' 13:20:33 INFO - no previously-included directories found matching 'build' 13:20:33 INFO - no previously-included directories found matching 'dist' 13:20:33 INFO - no previously-included directories found matching '.git*' 13:20:33 INFO - Successfully installed jsonschema functools32 13:20:33 INFO - Cleaning up... 13:20:33 INFO - Return code: 0 13:20:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:20: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')]} 13:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20: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')]} 13:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:20:33 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 0x10c676a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c686420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ba582a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, '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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 13:20:33 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 13:20:33 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 13:20:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:20:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:20:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:20:33 INFO - 'HOME': '/Users/cltbld', 13:20:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:20:33 INFO - 'LOGNAME': 'cltbld', 13:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:20:33 INFO - 'MOZ_NO_REMOTE': '1', 13:20:33 INFO - 'NO_EM_RESTART': '1', 13:20:33 INFO - 'PAGER': '/bin/cat', 13:20:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:20:33 INFO - 'PWD': '/builds/slave/test', 13:20:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:20:33 INFO - 'SHELL': '/bin/bash', 13:20:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:20:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:20:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:20:33 INFO - 'USER': 'cltbld', 13:20:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:20:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:20:33 INFO - 'XPC_FLAGS': '0x0', 13:20:33 INFO - 'XPC_SERVICE_NAME': '0', 13:20:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:20:33 INFO - Downloading/unpacking flake8 13:20:33 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 13:20:33 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 13:20:33 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 13:20:33 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 13:20:33 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 13:20:33 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 13:20:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:20:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:20:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:37 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 13:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:20:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:20:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:20:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:20:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:20:38 INFO - no previously-included directories found matching 'docs/_build' 13:20:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:20:38 INFO - Running setup.py install for pep8 13:20:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:20:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:20:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:20:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:20:38 INFO - no previously-included directories found matching 'docs/_build' 13:20:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:20:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:20:38 INFO - Cleaning up... 13:20:38 INFO - Return code: 0 13:20:38 INFO - Running post-action listener: _resource_record_post_action 13:20:38 INFO - Running post-action listener: _start_resource_monitoring 13:20:38 INFO - Starting resource monitoring. 13:20:38 INFO - ##### 13:20:38 INFO - ##### Running install step. 13:20:38 INFO - ##### 13:20:38 INFO - Running pre-action listener: _resource_record_pre_action 13:20:38 INFO - Running main action method: install 13:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:20:39 INFO - Reading from file tmpfile_stdout 13:20:39 INFO - Detecting whether we're running mozinstall >=1.0... 13:20:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:20:39 INFO - Reading from file tmpfile_stdout 13:20:39 INFO - Output received: 13:20:39 INFO - Usage: mozinstall [options] installer 13:20:39 INFO - Options: 13:20:39 INFO - -h, --help show this help message and exit 13:20:39 INFO - -d DEST, --destination=DEST 13:20:39 INFO - Directory to install application into. [default: 13:20:39 INFO - "/builds/slave/test"] 13:20:39 INFO - --app=APP Application being installed. [default: firefox] 13:20:39 INFO - mkdir: /builds/slave/test/build/application 13:20:39 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'] 13:20:39 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 13:21:13 INFO - Reading from file tmpfile_stdout 13:21:13 INFO - Output received: 13:21:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:21:13 INFO - Running post-action listener: _resource_record_post_action 13:21:13 INFO - ##### 13:21:13 INFO - ##### Running run-tests step. 13:21:13 INFO - ##### 13:21:13 INFO - Running pre-action listener: _resource_record_pre_action 13:21:13 INFO - Running main action method: run_tests 13:21:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:21:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:21:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:21:13 INFO - 2016-03-21 13:21:13.077 screenresolution[1914:9239] starting screenresolution argv=screenresolution get 13:21:13 INFO - 2016-03-21 13:21:13.080 screenresolution[1914:9239] Display 0: 1600x1200x32@60 13:21:13 INFO - 2016-03-21 13:21:13.086 screenresolution[1915:9241] starting screenresolution argv=screenresolution list 13:21:13 INFO - Available Modes on Display 0 13:21:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:21:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:21:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:21:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:21:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:21:13 INFO - Intel Iris: 13:21:13 INFO - Chipset Model: Intel Iris 13:21:13 INFO - Type: GPU 13:21:13 INFO - Bus: Built-In 13:21:13 INFO - VRAM (Dynamic, Max): 1536 MB 13:21:13 INFO - Vendor: Intel (0x8086) 13:21:13 INFO - Device ID: 0x0a2e 13:21:13 INFO - Revision ID: 0x0009 13:21:13 INFO - Displays: 13:21:13 INFO - Display: 13:21:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:21:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:21:13 INFO - Display Serial Number: 1600x1200 60 13:21:13 INFO - Main Display: Yes 13:21:13 INFO - Mirror: Off 13:21:13 INFO - Online: Yes 13:21:13 INFO - Rotation: Supported 13:21:13 INFO - Return code: 0 13:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:21:13 INFO - Python 2.7.3 13:21:13 INFO - Return code: 0 13:21:13 INFO - grabbing minidump binary from tooltool 13:21:13 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')]} 13:21:13 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 0x10c515e00>, '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 0x10c33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c510b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:21:13 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 13:21:13 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 13:21:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:21:13 INFO - Return code: 0 13:21:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:21:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:21:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:21:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:21:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:21:14 INFO - Return code: 0 13:21:14 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/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 13:21:14 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/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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 13:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oxEJ5B4T7t/Render', 13:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:21:14 INFO - 'HOME': '/Users/cltbld', 13:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:21:14 INFO - 'LOGNAME': 'cltbld', 13:21:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:21:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:14 INFO - 'MOZ_NO_REMOTE': '1', 13:21:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:21:14 INFO - 'NO_EM_RESTART': '1', 13:21:14 INFO - 'PAGER': '/bin/cat', 13:21:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:14 INFO - 'PWD': '/builds/slave/test', 13:21:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:21:14 INFO - 'SHELL': '/bin/bash', 13:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aPkrGuMAdn/Listeners', 13:21:14 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 13:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:21:14 INFO - 'USER': 'cltbld', 13:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:14 INFO - 'XPC_FLAGS': '0x0', 13:21:14 INFO - 'XPC_SERVICE_NAME': '0', 13:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:21:14 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/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 13:21:14 INFO - mozversion application_buildid: 20160321111439 13:21:14 INFO - mozversion application_changeset: 3dc5292ed66afbca801c33bff49c86154b3b3c24 13:21:14 INFO - mozversion application_display_name: Nightly 13:21:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:21:14 INFO - mozversion application_name: Firefox 13:21:14 INFO - mozversion application_remotingname: firefox 13:21:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:21:14 INFO - mozversion application_vendor: Mozilla 13:21:14 INFO - mozversion application_version: 48.0a1 13:21:14 INFO - mozversion platform_buildid: 20160321111439 13:21:14 INFO - mozversion platform_changeset: 3dc5292ed66afbca801c33bff49c86154b3b3c24 13:21:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:21:14 INFO - mozversion platform_version: 48.0a1 13:21:14 INFO - using testdate: 1458591674 13:21:14 INFO - actual date: 1458591674 13:21:14 INFO - starting webserver on 'localhost:49459' 13:21:14 INFO - SUITE-START | Running 2 tests 13:21:14 INFO - TEST-START | dromaeo_css 13:21:14 INFO - operating with platform_type : mac_ 13:21:14 INFO - Initialising browser for dromaeo_css test... 13:21:14 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpzLxvNG/profile http://localhost:49459/getInfo.html) 13:21:17 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 13:21:17 INFO - PROCESS | 1933 | colorDepth:24 13:21:17 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 13:21:17 INFO - PROCESS | 1933 | __metrics 13:21:17 INFO - PROCESS | 1933 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:21:17 ERROR - PROCESS | 1933 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:21:17 INFO - TEST-INFO | 1933: exit 0 13:21:17 INFO - Browser initialized. 13:21:17 INFO - Running cycle 1/1 for dromaeo_css test... 13:21:17 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpzLxvNG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:29 INFO - PROCESS | 1935 | RSS: Main: 245182464 13:21:29 INFO - PROCESS | 1935 | 13:22:20 INFO - PROCESS | 1935 | 1458591740813 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] 13:24:30 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49459/tests/dromaeo/cssquery-ext.html) 13:24:32 INFO - PROCESS | 1935 | RSS: Main: 388116480 13:24:32 INFO - PROCESS | 1935 | 13:27:35 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-ext.html (next: http://localhost:49459/tests/dromaeo/cssquery-jquery.html) 13:27:35 INFO - PROCESS | 1935 | RSS: Main: 377384960 13:27:35 INFO - PROCESS | 1935 | 13:30:37 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49459/tests/dromaeo/cssquery-mootools.html) 13:30:38 INFO - PROCESS | 1935 | RSS: Main: 377688064 13:30:38 INFO - PROCESS | 1935 | 13:33:40 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49459/tests/dromaeo/cssquery-prototype.html) 13:33:41 INFO - PROCESS | 1935 | RSS: Main: 334376960 13:33:41 INFO - PROCESS | 1935 | 13:36:44 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49459/tests/dromaeo/cssquery-yui.html) 13:36:44 INFO - PROCESS | 1935 | RSS: Main: 338440192 13:36:44 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-yui.html (next: http://localhost:49459/tests/dromaeo/cssquery-dojo.html) 13:39:47 INFO - PROCESS | 1935 | RSS: Main: 406638592 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | __start_tp_report 13:39:47 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 13:39:47 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 13:39:47 INFO - PROCESS | 1935 | |i|pagename|runs| 13:39:47 INFO - PROCESS | 1935 | |0;dojo.html;2908.7527560157387;3192.345569158322;3468.3583537045665;3479.234568394955;3531.5585551806025;5567.749451274693;5672.120821272699;5714.857128571783;5714.942850571493;5746.942530574693;5021.59827213823;5390.598444404453;5592.468715472024;5648.887022259552;5662.745176467059;5109.080365534202;5134.897302053957;5184.351956005499;5201.9479805201845;5240.973795131019;5188.7146206958605;5204.245384419257;5210.869728256805;5216.00895829793;5232.3459567554055;5133.794648214067;5157.406898206698;5159.871003224931;5179.637425380225;5206.219067139921;5201.713905735183;5237.057329680656;5254.7635356409055;5257.737113144328;5315.6013299002725;5023.4474207837475;5073.847784566469;5095.414027386861;5144.485551444863;5157.71632560209;5551.861203469905;5559.916601250984;5561.694106824123;5561.860953476155;5649.576281778842;6216.968915155395;6252.562320637558;6257.937420625781;6277.246730392382;6286.717097730613;6110.96944515279;6111.87776244477;6264.812055638293;6332.810015699536;6346.714397852108;5752.223449834219;5761.510271626875;5765.56758243125;5774.364819869811;5782.161586569966;6301.369863013753;6318.842028949313;6329.620222786648;6331.2085989251345;6338.936610633927;5961.314448838352;6009.678620176201;6101.55020674385;6123.908141377883;6155.815325540241;5723.255976723;6225.315215326311;6229.813105606839;6246.718897649616;6253.90556652584;6161.6332712255125;6164.660943648053;6219.533534984895;6220.720067596969;6224.906626400608;6060.393960603992;6109.283207920342;6120.0205129226715;6122.969385153046;6157.507399408037;4235.618794308465;4894.241392584155;4908.558229759339;4919.385076865392;4953.405591329064;4413.668974826836;4416.470023597189;4416.757078360721;4417.602415782595;4470.083632855322;5610.663360198401;5675.517581005661;5702.230198923092;5710.828675139753;5723.914141287884;6283.560150789401;6330.905036424458;6334.778282760173;6335.334789847092;6350.206224221973;5684.63049901755;5732.627379220337;5733.827985160452;5741.25363702716;5773.509251713567;4954.826581069645;5303.151495760737;5348.5186333230195;5361.758720857492;5362.356517217959;6288.591241569284;6323.30443651198;6325.905111423424;6333.240011198685;6341.8731625368155;6274;6290.49676025926;6304.05439184126;6309.526785491014;6319.083732858618;6239.875202496016;6255.437010669061;6267.2479302484;6305.5901366411035;6336.936630633634;6138.232720909887;6169.2288463942;6181.3200547938795;6184.907226391518;6189.133521307111;6083.66539840313;6252.656103914328;6254.749810007549;6261.499080073492;6273.37266273369;5932.614380065282;6062.757489700362;6107.037103281039;6129.358790882775;6140.534923917628;6075.817725468243;6083.330833608388;6093.086037094471;6110;6131.785387511416;4911.263310503453;5811.94188058114;5956.166136740773;5982.192404025401;5983.880322393615;5828.912566311424;5994.910076348945;6002.129691194665;6030.216071910623;6085.056816193497;5871;5910.70446477683;5914.526837853047;5944.64332140073;5976.910346344721 13:39:47 INFO - PROCESS | 1935 | |1;ext.html;492.1043700465155;570.1988705868257;577.8324285957073;626.555145846449;636.9012803015532;30992;31358.372832543337;31384.372312553765;31436;31544.68455315446;32160;32553;41447;41815.37276940848;41874.7906260469;9496.382735122212;9677.75805604862;9686.612535498607;9690.982446843085;9708.466034368106;9481.81036379272;9621;9634.759131021745;9645.614175432975;9671.661491847786;9564.665236716717;9662.033796620317;9662.661806836726;9667.274954378414;9676.854847177297;9588.280878934072;9691.999999999965;9793;9793.167580755644;9793.461359625218;9507.286953478517;9657.372270802376;9663;9664.226861851035;9676.419414835062;41736.58263417388;42216.78891605522;42252.36621450681;42253.15493690109;42292.78853605743;2995.5506673998857;3781.357169281229;3829.195868867513;3993.28120938231;4123.60825721556;28753.71246287531;29625.703742962727;29942.55086173709;29963;30726.539101913266;2684.3973741099985;2785.8189217700783;2819.9143329818166;2849.15949794811;2877.510823160068;482182;483926.32147357205;484136;484347;484359.99999999645;58517.70741146267;67712.98430523546;67736.6613166931;67744.66127669429;67762;69295;70490.64754676296;70672.64663676752;70699;70725.64637176781;17366.47900562985;17589.648207036043;17591.38430154964;17611.207495662726;17649.294028238728;13268.27024513661;13343.332833358294;13345.93327033378;13349.265790381622;13356.398962046731;20920.686189707165;21588.244411445525;21635.56728865414;21638.567228655655;21649.242276520246;7114.857702845914;8247.95876020628;8474.66101355939;8549.230569248797;8565.743027709179;901.7851359901929;904.3217586809892;1055;1089.1395797320029;1122.3266040375709;24001.27996160118;24582.139625113035;29398;29876.954306599164;29948.700512995027;914.277720600718;953.4088864903804;1061;1161.4831400026908;1177.7526719389025;14187;14408.351624176938;14446.566603001927;14603.853961460249;14630.195339256443;525158.1226281609;528596;528770;530394;532166;59837.401625983184;60441;61546.69226653838;61550;61601;1363.7136201397618;1368.3705495471995;1467.1123969998212;1476.8153980752406;1496.4911929943653;25729.099481518057;29659.40681186321;29687;30625.846870766396;31103.533446998765;55272.17091743708;55691;56267.87464250774;56324.43675563192;56453.43546564482;422694;426121;426722;427306;428024.8598757111;28619.713802861705;32266.193345166557;32598.51102233421;33022;33554.49668255027;42993.78503107464;43586;44136;44252;44498.01264187419;35714.821425893744;36065.45901811423;36070.8196459016;37096.25807483781;37294.81352593219;36014.639853601126;36940.44589331109;37121.628783711814;39279;40165.79917100513;35705;36087.819560902026;36221.63778362182;36364.63635363719;37060.44409333916;30710.543156546977;31267.84366078155;31822;31902.52146217762;32152.839235804608;23867.403314917265;24020.63969040501;24052.27843164708;24587;24633 13:39:47 INFO - PROCESS | 1935 | |2;jquery.html;363.6399964035605;365.4372266709268;369.796611863475;369.9500567423397;376.0636016319362;19298;20001.899990500046;20819.791802081974;21037.579248415022;21271.574568508622;20122;20176.69734953977;20836.062377193026;20850.687239691415;21100.472488187803;5169.302144210521;5669.319681638199;5909.911351329733;5959.910601340984;5961.850953726148;4097.897552561195;4261.978690106545;5813.633796057923;6435.388638079375;6439.388258115471;6332.968335158341;6380.744770209186;6389.520785941049;6390.329015453381;6391.584547004453;6066.6663333516635;6311.936880631204;6323.9565471697115;6325.1777268954975;6337.302896681407;5402.370803151817;5457.426970168115;5457.699826509541;5466.070767969455;5469;11225.550977960871;12932.54736084242;25020.874895625406;25704;25839.870800646066;2028.2191356327774;2047.7747447780732;2073.8340932725346;2234.6146779423625;2564.1666458401096;9830;9930.304878658497;10113.393196408239;10200.13298869597;10356.741081472948;1676.48029110976;1736.9826301736948;1773.4147731248656;1906.1231833356535;1972.7632684078003;95444.52277738567;99463.50268248685;103191.48404258005;103369.96630033679;106422.40366394511;11301.49143288554;11544.826827597593;11548.884511154782;11560.30638161713;11684.298942063504;13900.93049534766;13908.235047072509;13912.30438478072;13919.373628186755;13933.094348867291;8536.317094632415;8601.31189504838;8605.784855378666;8612.827743445096;8711.259542938795;8654.350923680624;8696.91303086961;8706.085860984633;8767.736967890973;8808.383413161017;4534.79593418297;4548.135854187693;4550.385697930803;4581.129585378834;4674.976625116853;1771.9468415947542;1808.9236904042075;1834.954126146857;1860.3302810988034;1865.159145649638;912.8174365126869;936.3258453913172;958.4824194934657;999.3304485994402;1045.8704599033026;19557.804421955883;20219.898900505697;20252.088656010514;20312.390628281177;20318.695219571717;930.2790337488501;952.2905435450496;966.2994329111337;1004.382304882492;1052.894710528941;10519.105876000625;10652.414117223627;10740.516676749565;10780.892191077988;10785.245032847626;508505;621957;627295;643523.7823810851;645452.5454745393;72182;107796;110623;113542.86457135323;117440;1010.9949450252849;1021.341234903483;1026.5483187397522;1034.2088302448633;1038.4911393417171;14201.721845033997;17244.74132888033;17634.470965871045;17863.374781882572;17988.55028624295;49051.09925123432;49542.50457495379;49567.05195376578;50163.24755128749;50445;68628;69338.65330673516;70190;70203.59592808217;71903.64048179725;8009.159038300894;10887.346759194474;11115.8154802523;11347.89344794829;11405.315681059163;12160.209586376857;12744.42650080767;12847.421866015864;13086.541971030969;13092.738145237232;10925.617603383844;11147;11247.831282530933;11280.49237784318;11343.262687925258;11241.88758112441;11264;11311;11458.94270528642;11511.654650360502;11055.170862185529;11594.88405115938;11615.128865334964;11820.881791181979;11852.525898963944;9488.620455181715;11454.94272528632;11464.885351146715;11671.533138674358;11743.17797754149;11411.486483108114;11427.428628568705;11652.475638596114;11657.358845263592;11803.645890623295 13:39:47 INFO - PROCESS | 1935 | |3;mootools.html;1446.7106578684266;1581.4543982326095;1614.830442803506;1907.7043058325955;2033.7661168965574;8003.679852805888;8628.266597339225;8746.300295976322;8782.38523303369;8787.165219304155;8509.872351914726;8732.8690069649;8736.563171841399;8754.474731516113;8756.474611523314;2192.068370942351;2456.299954512964;2490.887910044052;2514.8742562871876;2518.4333524956924;2503.6244563315468;2516.8615726135054;2518.659980902582;2519.407939134311;2524.798016158712;2446.412860913377;2497.7502249775057;2516.471540976388;2527.3428908483743;2528.279440359498;2280.551849575515;2307.653851922208;2313.595120853861;2321.117975169425;2321.872297023663;2493.7132229793624;2497.675302210719;2506.3483494291618;2524.7475252474787;2530.962035569468;7790.766277011642;8884.689035883714;8962.551872406353;8966.641334346617;8978.057303983052;5448.727563621803;5577.721113944286;5623.0721930881355;5625.774969001235;5627.774889004435;3579.3199292134673;3603.8198090095652;3688.981555092234;3774.565924918642;3774.6036666149935;1040.5889673578895;1051.8211903976267;1056.287006270764;1066.7439814444556;1069.1607088435542;12118.81821772674;12162.5134994601;12164.51341946321;12174.81737773934;12183.086268529807;4943.629227807929;4966.304717339575;5042.067217564762;5044.8234311798915;5066.265391518283;10275.332103413255;10282.331648442976;10282.794344113076;10290.742731431774;10293.330933489298;5637.943620563824;5639.689817060019;5664.68844213564;5671.432856714378;5671.631343962629;4217.746935183899;4522.547745225517;4693.272542755878;5016.874578135503;5040.395152581714;3944.822482988215;4025.496812898388;4033.9394909076386;4058.492688413948;4108.404281379183;1343.8051482534977;1348.0226835544152;1351.6350585341902;1357.2331632627534;1358.483776165051;1367.6170672211797;1375.312343828086;1387.8126452928725;1409.8308203015704;1411.8870490360746;8212.219839115274;8236.011678598607;8279.917200828035;8289.253967142986;8313.251807337369;526.3184176491453;532.4063669009105;533.863864714503;537.5618870620432;542.568657916957;6213.347598502182;6229.53278504114;6260.186175797117;6286.18279623646;6288.5598008138995;10548.156147508182;10735.731606709895;10735.78528429427;10742.194335424874;10759.193060520336;10428.895711042944;10549.630762923261;10627;10682.51928663212;10693.518791654395;8261.504309741435;8351.66593336272;8379.62291696875;8420.957895210484;8427.241548260687;7838.412119090977;7899.802504937193;7911.1693272207895;7915;8032.236937490929;9244.445333280024;9594.376365536218;9651.806963860823;9690.75773105678;9723;9725.221982241263;9953.701388958343;10004.449755263238;10116.747081322732;10131.240156988402;6822.590644561342;7308.817279568053;7469.701211951461;7535.208803075599;7612.391008719178;8318.70884519039;8336.708215212439;8368.623411946355;8371.706990255556;8391.874121888055;7287.599182045038;7305.817354566178;7364.66858991336;7502.137254215617;7553.433492487976;7215.60314182725;7266.527675701062;7306.232845551353;7387.519811212254;7419.29516695913;7686.000819893378;7726.381889448943;7742.6128693566225;7746.109197442366;7748.92251077482;6972;7008.859822803413;7052.717891284291;7056.823579410556;7078.823029424306;7117.67970441321;7190.928090719235;7195.02867112933;7235.602041887747;7253.057102576631 13:39:47 INFO - PROCESS | 1935 | |4;prototype.html;271.72827172827175;329.0720169123072;332.6922596598147;336.6532471554298;337.77875491553044;5224.817131400397;6492.545521813469;6560.934390656092;6602.10871532343;6634.170728658918;6466.773662921799;6500.122483464731;6503.967480162604;6504.38208370204;6544.541882068257;4605.838795642153;4673.485916549177;4716.198246298138;4758.857234282977;4855.732934688591;4762.476127625959;4813.542713442235;4818.3495228144275;4828.299896515004;4859.878503037417;4761.761911904408;4800.855974320759;4804.759762011903;4819.7108173509705;4821.614270858323;4548.7043342182815;4612.446506419217;4786.688865223749;4796.712197268158;4817.56641902227;4098.774567398792;4120.608542188487;4124.1133156371525;4125.793710314472;4129.401236820644;6221.502279817649;6225.28409232935;6243.313235544087;6247.187865577446;6282.371762823681;5707.0038229929205;5708.71456427177;5721.399253078408;5733.569982251348;5736.909987102479;5839.240898683186;6785.91425371943;6898.275681053467;6902.965485172592;6923.684499944994;4328.848490302856;4490.146872094291;4515.548445155491;4542.477615074243;4628.791704373311;6008.939910600881;6669.499362643415;7227.494075414723;7253.165885923134;7340.339369456775;4593.2191527439745;4601;4602.976985115053;4612.446506419251;4612.962083531245;3849.846006159722;4668.929966050512;4678.578927896506;4683.297505374221;4686.226772582554;5543.889122217533;5558.305211848519;5560.499555040065;5561.304836895388;5565.721713914288;6761.68147211289;6967.512274140863;6993.440524758007;7031;7052;1602.5833283346415;1612.6049117966174;1624.2934323569284;1624.6344572471335;1625.268629116902;988.7182153086336;1037.2635428845454;1043.1654676258963;1059.364381371171;1063.7181146996052;6294.8111556653375;6496.805095847132;6609;6614.8346291343105;6636;7294.234105418961;7296.963515182496;7312.378447831994;7314.487985841047;7320.04839370889;6601.471882249409;6602.900956485657;6605.471562275006;6610.900836487456;6618.602883826986;3116.937661246762;3850.9422358664083;3854.5374555053013;3857.7685338879755;3868.2263547290654;7320.707171713072;7642.04474440695;7651.1583725790115;7666.8849967250535;7679.846403072019;7496.475246732676;7526.887096693445;7535.698572057166;7545.320921117126;7571.962140189374;7666.9616651916385;7670.27132422419;7673.884891726629;7678.078630564368;7679.654415551202;5246.108161612611;6683.498737594603;6968.407685346802;7299.5255308404785;7301;7139.571625702267;7189.209186989322;7197.172325182671;7218.458615603746;7219.9278007221355;6568.14614100183;7267.927320726936;7303.685336639456;7655.88516172269;7683.9231607683205;4043.5552089270745;4607.470140933701;4618.2610782276015;4622.375979242759;4624.213883639856;6214.937850621436;6947.270536593584;7225.169105552718;7231.63841807897;7239.529430586995;6653.500987425866;7005.789826305219;7023.438124949889;7055.611941343275;7070.222275549789;6935.375816176568;6944.479164062816;7034.050403195503;7042.542234754725;7050.189228238818;6880.759173429106;6883.449324054164;6891.483138764713;6898.793036208922;6917.273686263071;6774.204529428589;6892.035115083792;6995.79012629622;7018.824529386806;7021.68402421882;6655.667216639245;6669.166354205724;6812.21659509143;6855.245922948372;6877.105976223059 13:39:47 INFO - PROCESS | 1935 | |5;yui.html;692.6329045605829;755.6523998960478;756.1153450462958;770.9922900770994;773.6325245508384;15295.69408611827;15518.922405387957;15540.145292008934;15544.145072021049;15545;13889.583312500616;14265.215413152273;14359.78460323096;14364.066335688172;14391.568252952402;763.5342441110918;921.3504479342065;936.4287784451479;950.4487397309543;952.642758965388;763.0500027465813;931.1107891963159;951.1962391778935;951.3768481644533;954.6944977607169;978.0317485689187;978.2760757039811;979.2215188924822;981.043482604462;987.8024395120968;803.9477433966773;979.6228452045942;988.5106872098321;995.4972738766949;995.8406654935212;736.6537727268176;737.3216640690524;738.1511262048633;739.8964145019702;739.9408047356198;15598.220088995506;15645.687086258326;15652.843471565253;15654.9217253913;15690.529284121381;12625.116241863074;12789.872101279054;12895.355232238444;13020.283884386356;13045.34773261333;9936.105750482491;10085.243606729451;10296.845547316796;10362.63730769427;11012.614558490495;3645.6172101929446;3716.8513259469587;3729.6829769469355;3821.6560509554274;3841.8079096045085;83551.582242089;83734;84069;84345;84754;9550.426974381558;9631.614735410505;9707.174890134418;9721.854172187423;10098.495075246208;22676.319710408716;22723.545529089326;22725.659115113285;22737.31788046361;22808.20171293997;7612.467127301035;7622.738372876981;7661.540307581563;7724.92275077242;7732.961335193288;4077.2660921033907;4111;4116.5421046321235;4141.730787498803;4226.492820861455;3373.375925453799;3694.261147770457;3704.6480584344445;3707.351213537674;3711.6659500645073;657.3459407889085;662.9005649152666;665;680.2924958043678;681.0669382945298;511.2790964739699;535.5742184962963;588.9957622254046;597.8923793717086;604.8850718363585;8019.879701804478;8031.598420078973;8131.4714543555665;8334.16658334174;8370.581470926429;533.3016127913098;587.9441453061952;601.762303889961;612.8467883029243;613.1324176290499;3107.6270847497995;3888.6889048876023;3935.409688546684;3982.880513584597;4032.4757781488806;72194.9170762439;92445;92811;93097;93163;72993.6350318245;74487.62756186293;74964.62517687486;75023;78318;65660.6716966412;66101.00848487277;68184.31815681879;69470;72475.27524724686;8356.623951922056;8457.450265732708;8530.10433904431;8577.785555360917;8592.871106933526;41937.37093943532;48072;49079.52761417163;50431.49568504268;51904;69186;69712.30287697261;70600.58798823893;73092.26907730855;73469.6326518364;11037.227394082658;11077.16921230927;11432.714182145513;11450.94274528622;11692.649220523397;11935.582254621393;12022.819657704966;12073;12100.576479823163;13131.671708207372;11054.778904422028;11305.71735706581;11369.374684392107;11783.410829458664;12426.937865310616;11330.799235790242;11352.886471135183;11384.943075284571;11484.610562139853;11668.533258669897;9384.202342800938;11123.332600044023;11145.331280123219;11246.606368777053;11268.436578171222;9301.302402319718;9351.298652600946;9612.471314077793;9642.807143857224;9884.703458896245;9334.71995840126;9458.43249405038;9493.430394176372;9557.952210238904;9789.559469824018 13:39:47 INFO - PROCESS | 1935 | __end_tp_report 13:39:47 INFO - PROCESS | 1935 | __start_cc_report 13:39:47 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,1455 13:39:47 INFO - PROCESS | 1935 | __end_cc_report 13:39:47 INFO - PROCESS | 1935 | __startTimestamp1458592787939__endTimestamp 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | ------- Summary: start ------- 13:39:47 INFO - PROCESS | 1935 | Number of tests: 6 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | [#0] dojo.html Cycles:165 Average:5708.50 Median:5932.61 stddev:662.49 (11.2%) stddev-sans-first:627.06 13:39:47 INFO - PROCESS | 1935 | Values: 2908.8 3192.3 3468.4 3479.2 3531.6 5567.7 5672.1 5714.9 5714.9 5746.9 5021.6 5390.6 5592.5 5648.9 5662.7 5109.1 5134.9 5184.4 5201.9 5241.0 5188.7 5204.2 5210.9 5216.0 5232.3 5133.8 5157.4 5159.9 5179.6 5206.2 5201.7 5237.1 5254.8 5257.7 5315.6 5023.4 5073.8 5095.4 5144.5 5157.7 5551.9 5559.9 5561.7 5561.9 5649.6 6217.0 6252.6 6257.9 6277.2 6286.7 6111.0 6111.9 6264.8 6332.8 6346.7 5752.2 5761.5 5765.6 5774.4 5782.2 6301.4 6318.8 6329.6 6331.2 6338.9 5961.3 6009.7 6101.6 6123.9 6155.8 5723.3 6225.3 6229.8 6246.7 6253.9 6161.6 6164.7 6219.5 6220.7 6224.9 6060.4 6109.3 6120.0 6123.0 6157.5 4235.6 4894.2 4908.6 4919.4 4953.4 4413.7 4416.5 4416.8 4417.6 4470.1 5610.7 5675.5 5702.2 5710.8 5723.9 6283.6 6330.9 6334.8 6335.3 6350.2 5684.6 5732.6 5733.8 5741.3 5773.5 4954.8 5303.2 5348.5 5361.8 5362.4 6288.6 6323.3 6325.9 6333.2 6341.9 6274.0 6290.5 6304.1 6309.5 6319.1 6239.9 6255.4 6267.2 6305.6 6336.9 6138.2 6169.2 6181.3 6184.9 6189.1 6083.7 6252.7 6254.7 6261.5 6273.4 5932.6 6062.8 6107.0 6129.4 6140.5 6075.8 6083.3 6093.1 6110.0 6131.8 4911.3 5811.9 5956.2 5982.2 5983.9 5828.9 5994.9 6002.1 6030.2 6085.1 5871.0 5910.7 5914.5 5944.6 5976.9 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | [#1] ext.html Cycles:180 Average:62964.43 Median:22079.54 stddev:127948.23 (579.5%) stddev-sans-first:128221.18 13:39:47 INFO - PROCESS | 1935 | Values: 492.1 570.2 577.8 626.6 636.9 30992.0 31358.4 31384.4 31436.0 31544.7 32160.0 32553.0 41447.0 41815.4 41874.8 9496.4 9677.8 9686.6 9691.0 9708.5 9481.8 9621.0 9634.8 9645.6 9671.7 9564.7 9662.0 9662.7 9667.3 9676.9 9588.3 9692.0 9793.0 9793.2 9793.5 9507.3 9657.4 9663.0 9664.2 9676.4 41736.6 42216.8 42252.4 42253.2 42292.8 2995.6 3781.4 3829.2 3993.3 4123.6 28753.7 29625.7 29942.6 29963.0 30726.5 2684.4 2785.8 2819.9 2849.2 2877.5 482182.0 483926.3 484136.0 484347.0 484360.0 58517.7 67713.0 67736.7 67744.7 67762.0 69295.0 70490.6 70672.6 70699.0 70725.6 17366.5 17589.6 17591.4 17611.2 17649.3 13268.3 13343.3 13345.9 13349.3 13356.4 20920.7 21588.2 21635.6 21638.6 21649.2 7114.9 8248.0 8474.7 8549.2 8565.7 901.8 904.3 1055.0 1089.1 1122.3 24001.3 24582.1 29398.0 29877.0 29948.7 914.3 953.4 1061.0 1161.5 1177.8 14187.0 14408.4 14446.6 14603.9 14630.2 525158.1 528596.0 528770.0 530394.0 532166.0 59837.4 60441.0 61546.7 61550.0 61601.0 1363.7 1368.4 1467.1 1476.8 1496.5 25729.1 29659.4 29687.0 30625.8 31103.5 55272.2 55691.0 56267.9 56324.4 56453.4 422694.0 426121.0 426722.0 427306.0 428024.9 28619.7 32266.2 32598.5 33022.0 33554.5 42993.8 43586.0 44136.0 44252.0 44498.0 35714.8 36065.5 36070.8 37096.3 37294.8 36014.6 36940.4 37121.6 39279.0 40165.8 35705.0 36087.8 36221.6 36364.6 37060.4 30710.5 31267.8 31822.0 31902.5 32152.8 23867.4 24020.6 24052.3 24587.0 24633.0 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | [#2] jquery.html Cycles:180 Average:33894.67 Median:11170.30 stddev:101008.01 (904.3%) stddev-sans-first:101259.98 13:39:47 INFO - PROCESS | 1935 | Values: 363.6 365.4 369.8 370.0 376.1 19298.0 20001.9 20819.8 21037.6 21271.6 20122.0 20176.7 20836.1 20850.7 21100.5 5169.3 5669.3 5909.9 5959.9 5961.9 4097.9 4262.0 5813.6 6435.4 6439.4 6333.0 6380.7 6389.5 6390.3 6391.6 6066.7 6311.9 6324.0 6325.2 6337.3 5402.4 5457.4 5457.7 5466.1 5469.0 11225.6 12932.5 25020.9 25704.0 25839.9 2028.2 2047.8 2073.8 2234.6 2564.2 9830.0 9930.3 10113.4 10200.1 10356.7 1676.5 1737.0 1773.4 1906.1 1972.8 95444.5 99463.5 103191.5 103370.0 106422.4 11301.5 11544.8 11548.9 11560.3 11684.3 13900.9 13908.2 13912.3 13919.4 13933.1 8536.3 8601.3 8605.8 8612.8 8711.3 8654.4 8696.9 8706.1 8767.7 8808.4 4534.8 4548.1 4550.4 4581.1 4675.0 1771.9 1808.9 1835.0 1860.3 1865.2 912.8 936.3 958.5 999.3 1045.9 19557.8 20219.9 20252.1 20312.4 20318.7 930.3 952.3 966.3 1004.4 1052.9 10519.1 10652.4 10740.5 10780.9 10785.2 508505.0 621957.0 627295.0 643523.8 645452.5 72182.0 107796.0 110623.0 113542.9 117440.0 1011.0 1021.3 1026.5 1034.2 1038.5 14201.7 17244.7 17634.5 17863.4 17988.6 49051.1 49542.5 49567.1 50163.2 50445.0 68628.0 69338.7 70190.0 70203.6 71903.6 8009.2 10887.3 11115.8 11347.9 11405.3 12160.2 12744.4 12847.4 13086.5 13092.7 10925.6 11147.0 11247.8 11280.5 11343.3 11241.9 11264.0 11311.0 11458.9 11511.7 11055.2 11594.9 11615.1 11820.9 11852.5 9488.6 11454.9 11464.9 11671.5 11743.2 11411.5 11427.4 11652.5 11657.4 11803.6 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | [#3] mootools.html Cycles:180 Average:6097.49 Median:535.71 stddev:3221.87 (601.4%) stddev-sans-first:3211.95 13:39:47 INFO - PROCESS | 1935 | Values: 1446.7 1581.5 1614.8 1907.7 2033.8 8003.7 8628.3 8746.3 8782.4 8787.2 8509.9 8732.9 8736.6 8754.5 8756.5 2192.1 2456.3 2490.9 2514.9 2518.4 2503.6 2516.9 2518.7 2519.4 2524.8 2446.4 2497.8 2516.5 2527.3 2528.3 2280.6 2307.7 2313.6 2321.1 2321.9 2493.7 2497.7 2506.3 2524.7 2531.0 7790.8 8884.7 8962.6 8966.6 8978.1 5448.7 5577.7 5623.1 5625.8 5627.8 3579.3 3603.8 3689.0 3774.6 3774.6 1040.6 1051.8 1056.3 1066.7 1069.2 12118.8 12162.5 12164.5 12174.8 12183.1 4943.6 4966.3 5042.1 5044.8 5066.3 10275.3 10282.3 10282.8 10290.7 10293.3 5637.9 5639.7 5664.7 5671.4 5671.6 4217.7 4522.5 4693.3 5016.9 5040.4 3944.8 4025.5 4033.9 4058.5 4108.4 1343.8 1348.0 1351.6 1357.2 1358.5 1367.6 1375.3 1387.8 1409.8 1411.9 8212.2 8236.0 8279.9 8289.3 8313.3 526.3 532.4 533.9 537.6 542.6 6213.3 6229.5 6260.2 6286.2 6288.6 10548.2 10735.7 10735.8 10742.2 10759.2 10428.9 10549.6 10627.0 10682.5 10693.5 8261.5 8351.7 8379.6 8421.0 8427.2 7838.4 7899.8 7911.2 7915.0 8032.2 9244.4 9594.4 9651.8 9690.8 9723.0 9725.2 9953.7 10004.4 10116.7 10131.2 6822.6 7308.8 7469.7 7535.2 7612.4 8318.7 8336.7 8368.6 8371.7 8391.9 7287.6 7305.8 7364.7 7502.1 7553.4 7215.6 7266.5 7306.2 7387.5 7419.3 7686.0 7726.4 7742.6 7746.1 7748.9 6972.0 7008.9 7052.7 7056.8 7078.8 7117.7 7190.9 7195.0 7235.6 7253.1 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | [#4] prototype.html Cycles:180 Average:5689.51 Median:6524.46 stddev:1829.35 (28.0%) stddev-sans-first:1788.72 13:39:47 INFO - PROCESS | 1935 | Values: 271.7 329.1 332.7 336.7 337.8 5224.8 6492.5 6560.9 6602.1 6634.2 6466.8 6500.1 6504.0 6504.4 6544.5 4605.8 4673.5 4716.2 4758.9 4855.7 4762.5 4813.5 4818.3 4828.3 4859.9 4761.8 4800.9 4804.8 4819.7 4821.6 4548.7 4612.4 4786.7 4796.7 4817.6 4098.8 4120.6 4124.1 4125.8 4129.4 6221.5 6225.3 6243.3 6247.2 6282.4 5707.0 5708.7 5721.4 5733.6 5736.9 5839.2 6785.9 6898.3 6903.0 6923.7 4328.8 4490.1 4515.5 4542.5 4628.8 6008.9 6669.5 7227.5 7253.2 7340.3 4593.2 4601.0 4603.0 4612.4 4613.0 3849.8 4668.9 4678.6 4683.3 4686.2 5543.9 5558.3 5560.5 5561.3 5565.7 6761.7 6967.5 6993.4 7031.0 7052.0 1602.6 1612.6 1624.3 1624.6 1625.3 988.7 1037.3 1043.2 1059.4 1063.7 6294.8 6496.8 6609.0 6614.8 6636.0 7294.2 7297.0 7312.4 7314.5 7320.0 6601.5 6602.9 6605.5 6610.9 6618.6 3116.9 3850.9 3854.5 3857.8 3868.2 7320.7 7642.0 7651.2 7666.9 7679.8 7496.5 7526.9 7535.7 7545.3 7572.0 7667.0 7670.3 7673.9 7678.1 7679.7 5246.1 6683.5 6968.4 7299.5 7301.0 7139.6 7189.2 7197.2 7218.5 7219.9 6568.1 7267.9 7303.7 7655.9 7683.9 4043.6 4607.5 4618.3 4622.4 4624.2 6214.9 6947.3 7225.2 7231.6 7239.5 6653.5 7005.8 7023.4 7055.6 7070.2 6935.4 6944.5 7034.1 7042.5 7050.2 6880.8 6883.4 6891.5 6898.8 6917.3 6774.2 6892.0 6995.8 7018.8 7021.7 6655.7 6669.2 6812.2 6855.2 6877.1 13:39:47 INFO - PROCESS | 1935 | 13:39:47 INFO - PROCESS | 1935 | [#5] yui.html Cycles:180 Average:18339.38 Median:33379.18 stddev:25532.20 (76.5%) stddev-sans-first:25569.44 13:39:47 INFO - PROCESS | 1935 | Values: 692.6 755.7 756.1 771.0 773.6 15295.7 15518.9 15540.1 15544.1 15545.0 13889.6 14265.2 14359.8 14364.1 14391.6 763.5 921.4 936.4 950.4 952.6 763.1 931.1 951.2 951.4 954.7 978.0 978.3 979.2 981.0 987.8 803.9 979.6 988.5 995.5 995.8 736.7 737.3 738.2 739.9 739.9 15598.2 15645.7 15652.8 15654.9 15690.5 12625.1 12789.9 12895.4 13020.3 13045.3 9936.1 10085.2 10296.8 10362.6 11012.6 3645.6 3716.9 3729.7 3821.7 3841.8 83551.6 83734.0 84069.0 84345.0 84754.0 9550.4 9631.6 9707.2 9721.9 10098.5 22676.3 22723.5 22725.7 22737.3 22808.2 7612.5 7622.7 7661.5 7724.9 7733.0 4077.3 4111.0 4116.5 4141.7 4226.5 3373.4 3694.3 3704.6 3707.4 3711.7 657.3 662.9 665.0 680.3 681.1 511.3 535.6 589.0 597.9 604.9 8019.9 8031.6 8131.5 8334.2 8370.6 533.3 587.9 601.8 612.8 613.1 3107.6 3888.7 3935.4 3982.9 4032.5 72194.9 92445.0 92811.0 93097.0 93163.0 72993.6 74487.6 74964.6 75023.0 78318.0 65660.7 66101.0 68184.3 69470.0 72475.3 8356.6 8457.5 8530.1 8577.8 8592.9 41937.4 48072.0 49079.5 50431.5 51904.0 69186.0 69712.3 70600.6 73092.3 73469.6 11037.2 11077.2 11432.7 11450.9 11692.6 11935.6 12022.8 12073.0 12100.6 13131.7 11054.8 11305.7 11369.4 11783.4 12426.9 11330.8 11352.9 11384.9 11484.6 11668.5 9384.2 11123.3 11145.3 11246.6 11268.4 9301.3 9351.3 9612.5 9642.8 9884.7 9334.7 9458.4 9493.4 9558.0 9789.6 13:39:47 INFO - PROCESS | 1935 | -------- Summary: end -------- 13:39:47 INFO - PROCESS | 1935 | 13:39:48 INFO - TEST-INFO | 1935: exit 0 13:39:48 INFO - TEST-OK | dromaeo_css | took 1113730ms 13:39:48 INFO - TEST-START | kraken 13:39:48 INFO - operating with platform_type : mac_ 13:39:48 INFO - Initialising browser for kraken test... 13:39:48 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpP_AbWP/profile http://localhost:49459/getInfo.html) 13:39:50 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 13:39:50 INFO - PROCESS | 1939 | colorDepth:24 13:39:50 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 13:39:50 INFO - PROCESS | 1939 | __metrics 13:39:51 INFO - PROCESS | 1939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:39:51 ERROR - PROCESS | 1939 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:39:51 INFO - TEST-INFO | 1939: exit 0 13:39:51 INFO - Browser initialized. 13:39:51 INFO - Running cycle 1/1 for kraken test... 13:39:51 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpP_AbWP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:03 INFO - PROCESS | 1941 | RSS: Main: 245374976 13:40:03 INFO - PROCESS | 1941 | 13:40:06 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-beat-detection) 13:40:06 INFO - PROCESS | 1941 | RSS: Main: 291979264 13:40:06 INFO - PROCESS | 1941 | 13:40:09 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-dft) 13:40:09 INFO - PROCESS | 1941 | RSS: Main: 302305280 13:40:09 INFO - PROCESS | 1941 | 13:40:13 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-fft) 13:40:13 INFO - PROCESS | 1941 | RSS: Main: 287956992 13:40:13 INFO - PROCESS | 1941 | 13:40:15 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-oscillator) 13:40:16 INFO - PROCESS | 1941 | RSS: Main: 291295232 13:40:16 INFO - PROCESS | 1941 | 13:40:18 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:40:18 INFO - PROCESS | 1941 | RSS: Main: 290152448 13:40:18 INFO - PROCESS | 1941 | 13:40:21 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49459/tests/kraken/driver.html?testName=imaging-darkroom) 13:40:22 INFO - PROCESS | 1941 | RSS: Main: 290947072 13:40:22 INFO - PROCESS | 1941 | 13:40:25 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49459/tests/kraken/driver.html?testName=imaging-desaturate) 13:40:25 INFO - PROCESS | 1941 | RSS: Main: 291115008 13:40:25 INFO - PROCESS | 1941 | 13:40:28 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49459/tests/kraken/driver.html?testName=json-parse-financial) 13:40:29 INFO - PROCESS | 1941 | RSS: Main: 291577856 13:40:29 INFO - PROCESS | 1941 | 13:40:30 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:40:31 INFO - PROCESS | 1941 | RSS: Main: 326291456 13:40:31 INFO - PROCESS | 1941 | 13:40:33 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:40:33 INFO - PROCESS | 1941 | RSS: Main: 325791744 13:40:33 INFO - PROCESS | 1941 | 13:40:35 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:40:36 INFO - PROCESS | 1941 | RSS: Main: 331300864 13:40:36 INFO - PROCESS | 1941 | 13:40:39 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:40:39 INFO - PROCESS | 1941 | RSS: Main: 333111296 13:40:39 INFO - PROCESS | 1941 | 13:40:42 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:40:42 INFO - PROCESS | 1941 | RSS: Main: 334348288 13:40:42 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49459/tests/kraken/driver.html?testName=ai-astar) 13:40:44 INFO - PROCESS | 1941 | RSS: Main: 394129408 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | __start_tp_report 13:40:44 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 13:40:44 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 13:40:44 INFO - PROCESS | 1941 | |i|pagename|runs| 13:40:44 INFO - PROCESS | 1941 | |0;ai-astar;110;110;110;109;112;110;115;109;109;110 13:40:44 INFO - PROCESS | 1941 | |1;audio-beat-detection;156;121;144;147;129;171;164;119;163;118 13:40:44 INFO - PROCESS | 1941 | |2;audio-dft;185;186;187;185;185;188;187;186;181;183 13:40:44 INFO - PROCESS | 1941 | |3;audio-fft;81;73;88;77;56;56;60;76;76;56 13:40:44 INFO - PROCESS | 1941 | |4;audio-oscillator;92;94;126;84;77;88;112;79;78;115 13:40:44 INFO - PROCESS | 1941 | |5;imaging-gaussian-blur;90;128;121;87;97;129;89;85;89;85 13:40:44 INFO - PROCESS | 1941 | |6;imaging-darkroom;93;94;94;94;94;93;94;95;94;93 13:40:44 INFO - PROCESS | 1941 | |7;imaging-desaturate;85;85;88;87;86;86;83;87;85;87 13:40:44 INFO - PROCESS | 1941 | |8;json-parse-financial;57;55;55;55;55;56;57;68;57;56 13:40:44 INFO - PROCESS | 1941 | |9;json-stringify-tinderbox;64;62;73;74;70;67;68;68;68;75 13:40:44 INFO - PROCESS | 1941 | |10;stanford-crypto-aes;97;107;81;82;82;83;82;81;85;82 13:40:44 INFO - PROCESS | 1941 | |11;stanford-crypto-ccm;129;131;118;121;128;125;121;131;129;146 13:40:44 INFO - PROCESS | 1941 | |12;stanford-crypto-pbkdf2;137;126;134;137;140;124;136;158;116;157 13:40:44 INFO - PROCESS | 1941 | |13;stanford-crypto-sha256-iterative;68;67;68;65;67;68;65;68;66;66 13:40:44 INFO - PROCESS | 1941 | __end_tp_report 13:40:44 INFO - PROCESS | 1941 | __start_cc_report 13:40:44 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,1306 13:40:44 INFO - PROCESS | 1941 | __end_cc_report 13:40:44 INFO - PROCESS | 1941 | __startTimestamp1458592844807__endTimestamp 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | ------- Summary: start ------- 13:40:44 INFO - PROCESS | 1941 | Number of tests: 14 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 13:40:44 INFO - PROCESS | 1941 | Values: 110.0 110.0 110.0 109.0 112.0 110.0 115.0 109.0 109.0 110.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:151.50 stddev:20.25 (13.4%) stddev-sans-first:20.95 13:40:44 INFO - PROCESS | 1941 | Values: 156.0 121.0 144.0 147.0 129.0 171.0 164.0 119.0 163.0 118.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#2] audio-dft Cycles:10 Average:185.30 Median:186.00 stddev:2.06 (1.1%) stddev-sans-first:2.18 13:40:44 INFO - PROCESS | 1941 | Values: 185.0 186.0 187.0 185.0 185.0 188.0 187.0 186.0 181.0 183.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#3] audio-fft Cycles:10 Average:69.90 Median:76.00 stddev:11.85 (15.6%) stddev-sans-first:11.86 13:40:44 INFO - PROCESS | 1941 | Values: 81.0 73.0 88.0 77.0 56.0 56.0 60.0 76.0 76.0 56.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:81.50 stddev:17.31 (21.2%) stddev-sans-first:18.34 13:40:44 INFO - PROCESS | 1941 | Values: 92.0 94.0 126.0 84.0 77.0 88.0 112.0 79.0 78.0 115.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:88.00 stddev:18.37 (20.9%) stddev-sans-first:19.12 13:40:44 INFO - PROCESS | 1941 | Values: 90.0 128.0 121.0 87.0 97.0 129.0 89.0 85.0 89.0 85.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 13:40:44 INFO - PROCESS | 1941 | Values: 93.0 94.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 93.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.50 stddev:1.45 (1.7%) stddev-sans-first:1.50 13:40:44 INFO - PROCESS | 1941 | Values: 85.0 85.0 88.0 87.0 86.0 86.0 83.0 87.0 85.0 87.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.93 (7.0%) stddev-sans-first:4.17 13:40:44 INFO - PROCESS | 1941 | Values: 57.0 55.0 55.0 55.0 55.0 56.0 57.0 68.0 57.0 56.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:4.20 (6.1%) stddev-sans-first:4.07 13:40:44 INFO - PROCESS | 1941 | Values: 64.0 62.0 73.0 74.0 70.0 67.0 68.0 68.0 68.0 75.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:82.00 stddev:8.73 (10.6%) stddev-sans-first:8.34 13:40:44 INFO - PROCESS | 1941 | Values: 97.0 107.0 81.0 82.0 82.0 83.0 82.0 81.0 85.0 82.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.00 stddev:7.82 (6.1%) stddev-sans-first:8.29 13:40:44 INFO - PROCESS | 1941 | Values: 129.0 131.0 118.0 121.0 128.0 125.0 121.0 131.0 129.0 146.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:137.00 stddev:13.29 (9.7%) stddev-sans-first:14.09 13:40:44 INFO - PROCESS | 1941 | Values: 137.0 126.0 134.0 137.0 140.0 124.0 136.0 158.0 116.0 157.0 13:40:44 INFO - PROCESS | 1941 | 13:40:44 INFO - PROCESS | 1941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.22 13:40:44 INFO - PROCESS | 1941 | Values: 68.0 67.0 68.0 65.0 67.0 68.0 65.0 68.0 66.0 66.0 13:40:44 INFO - PROCESS | 1941 | -------- Summary: end -------- 13:40:44 INFO - PROCESS | 1941 | 13:40:45 INFO - TEST-INFO | 1941: exit 0 13:40:45 INFO - TEST-OK | kraken | took 56988ms 13:40:45 INFO - SUITE-END | took 1170s 13:40:45 INFO - Completed test suite (00:19:31) 13:40:45 INFO - javascript benchmark 13:40:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2908.7527560157387, 3192.345569158322, 3468.3583537045665, 3479.234568394955, 3531.5585551806025, 5567.749451274693, 5672.120821272699, 5714.857128571783, 5714.942850571493, 5746.942530574693, 5021.59827213823, 5390.598444404453, 5592.468715472024, 5648.887022259552, 5662.745176467059, 5109.080365534202, 5134.897302053957, 5184.351956005499, 5201.9479805201845, 5240.973795131019, 5188.7146206958605, 5204.245384419257, 5210.869728256805, 5216.00895829793, 5232.3459567554055, 5133.794648214067, 5157.406898206698, 5159.871003224931, 5179.637425380225, 5206.219067139921, 5201.713905735183, 5237.057329680656, 5254.7635356409055, 5257.737113144328, 5315.6013299002725, 5023.4474207837475, 5073.847784566469, 5095.414027386861, 5144.485551444863, 5157.71632560209, 5551.861203469905, 5559.916601250984, 5561.694106824123, 5561.860953476155, 5649.576281778842, 6216.968915155395, 6252.562320637558, 6257.937420625781, 6277.246730392382, 6286.717097730613, 6110.96944515279, 6111.87776244477, 6264.812055638293, 6332.810015699536, 6346.714397852108, 5752.223449834219, 5761.510271626875, 5765.56758243125, 5774.364819869811, 5782.161586569966, 6301.369863013753, 6318.842028949313, 6329.620222786648, 6331.2085989251345, 6338.936610633927, 5961.314448838352, 6009.678620176201, 6101.55020674385, 6123.908141377883, 6155.815325540241, 5723.255976723, 6225.315215326311, 6229.813105606839, 6246.718897649616, 6253.90556652584, 6161.6332712255125, 6164.660943648053, 6219.533534984895, 6220.720067596969, 6224.906626400608, 6060.393960603992, 6109.283207920342, 6120.0205129226715, 6122.969385153046, 6157.507399408037, 4235.618794308465, 4894.241392584155, 4908.558229759339, 4919.385076865392, 4953.405591329064, 4413.668974826836, 4416.470023597189, 4416.757078360721, 4417.602415782595, 4470.083632855322, 5610.663360198401, 5675.517581005661, 5702.230198923092, 5710.828675139753, 5723.914141287884, 6283.560150789401, 6330.905036424458, 6334.778282760173, 6335.334789847092, 6350.206224221973, 5684.63049901755, 5732.627379220337, 5733.827985160452, 5741.25363702716, 5773.509251713567, 4954.826581069645, 5303.151495760737, 5348.5186333230195, 5361.758720857492, 5362.356517217959, 6288.591241569284, 6323.30443651198, 6325.905111423424, 6333.240011198685, 6341.8731625368155, 6274.0, 6290.49676025926, 6304.05439184126, 6309.526785491014, 6319.083732858618, 6239.875202496016, 6255.437010669061, 6267.2479302484, 6305.5901366411035, 6336.936630633634, 6138.232720909887, 6169.2288463942, 6181.3200547938795, 6184.907226391518, 6189.133521307111, 6083.66539840313, 6252.656103914328, 6254.749810007549, 6261.499080073492, 6273.37266273369, 5932.614380065282, 6062.757489700362, 6107.037103281039, 6129.358790882775, 6140.534923917628, 6075.817725468243, 6083.330833608388, 6093.086037094471, 6110.0, 6131.785387511416, 4911.263310503453, 5811.94188058114, 5956.166136740773, 5982.192404025401, 5983.880322393615, 5828.912566311424, 5994.910076348945, 6002.129691194665, 6030.216071910623, 6085.056816193497, 5871.0, 5910.70446477683, 5914.526837853047, 5944.64332140073, 5976.910346344721], "unit": "score", "name": "dojo.html", "value": 5664.733036127686}, {"lowerIsBetter": false, "replicates": [492.1043700465155, 570.1988705868257, 577.8324285957073, 626.555145846449, 636.9012803015532, 30992.0, 31358.372832543337, 31384.372312553765, 31436.0, 31544.68455315446, 32160.0, 32553.0, 41447.0, 41815.37276940848, 41874.7906260469, 9496.382735122212, 9677.75805604862, 9686.612535498607, 9690.982446843085, 9708.466034368106, 9481.81036379272, 9621.0, 9634.759131021745, 9645.614175432975, 9671.661491847786, 9564.665236716717, 9662.033796620317, 9662.661806836726, 9667.274954378414, 9676.854847177297, 9588.280878934072, 9691.999999999965, 9793.0, 9793.167580755644, 9793.461359625218, 9507.286953478517, 9657.372270802376, 9663.0, 9664.226861851035, 9676.419414835062, 41736.58263417388, 42216.78891605522, 42252.36621450681, 42253.15493690109, 42292.78853605743, 2995.5506673998857, 3781.357169281229, 3829.195868867513, 3993.28120938231, 4123.60825721556, 28753.71246287531, 29625.703742962727, 29942.55086173709, 29963.0, 30726.539101913266, 2684.3973741099985, 2785.8189217700783, 2819.9143329818166, 2849.15949794811, 2877.510823160068, 482182.0, 483926.32147357205, 484136.0, 484347.0, 484359.99999999645, 58517.70741146267, 67712.98430523546, 67736.6613166931, 67744.66127669429, 67762.0, 69295.0, 70490.64754676296, 70672.64663676752, 70699.0, 70725.64637176781, 17366.47900562985, 17589.648207036043, 17591.38430154964, 17611.207495662726, 17649.294028238728, 13268.27024513661, 13343.332833358294, 13345.93327033378, 13349.265790381622, 13356.398962046731, 20920.686189707165, 21588.244411445525, 21635.56728865414, 21638.567228655655, 21649.242276520246, 7114.857702845914, 8247.95876020628, 8474.66101355939, 8549.230569248797, 8565.743027709179, 901.7851359901929, 904.3217586809892, 1055.0, 1089.1395797320029, 1122.3266040375709, 24001.27996160118, 24582.139625113035, 29398.0, 29876.954306599164, 29948.700512995027, 914.277720600718, 953.4088864903804, 1061.0, 1161.4831400026908, 1177.7526719389025, 14187.0, 14408.351624176938, 14446.566603001927, 14603.853961460249, 14630.195339256443, 525158.1226281609, 528596.0, 528770.0, 530394.0, 532166.0, 59837.401625983184, 60441.0, 61546.69226653838, 61550.0, 61601.0, 1363.7136201397618, 1368.3705495471995, 1467.1123969998212, 1476.8153980752406, 1496.4911929943653, 25729.099481518057, 29659.40681186321, 29687.0, 30625.846870766396, 31103.533446998765, 55272.17091743708, 55691.0, 56267.87464250774, 56324.43675563192, 56453.43546564482, 422694.0, 426121.0, 426722.0, 427306.0, 428024.8598757111, 28619.713802861705, 32266.193345166557, 32598.51102233421, 33022.0, 33554.49668255027, 42993.78503107464, 43586.0, 44136.0, 44252.0, 44498.01264187419, 35714.821425893744, 36065.45901811423, 36070.8196459016, 37096.25807483781, 37294.81352593219, 36014.639853601126, 36940.44589331109, 37121.628783711814, 39279.0, 40165.79917100513, 35705.0, 36087.819560902026, 36221.63778362182, 36364.63635363719, 37060.44409333916, 30710.543156546977, 31267.84366078155, 31822.0, 31902.52146217762, 32152.839235804608, 23867.403314917265, 24020.63969040501, 24052.27843164708, 24587.0, 24633.0], "unit": "score", "name": "ext.html", "value": 19854.716766169586}, {"lowerIsBetter": false, "replicates": [363.6399964035605, 365.4372266709268, 369.796611863475, 369.9500567423397, 376.0636016319362, 19298.0, 20001.899990500046, 20819.791802081974, 21037.579248415022, 21271.574568508622, 20122.0, 20176.69734953977, 20836.062377193026, 20850.687239691415, 21100.472488187803, 5169.302144210521, 5669.319681638199, 5909.911351329733, 5959.910601340984, 5961.850953726148, 4097.897552561195, 4261.978690106545, 5813.633796057923, 6435.388638079375, 6439.388258115471, 6332.968335158341, 6380.744770209186, 6389.520785941049, 6390.329015453381, 6391.584547004453, 6066.6663333516635, 6311.936880631204, 6323.9565471697115, 6325.1777268954975, 6337.302896681407, 5402.370803151817, 5457.426970168115, 5457.699826509541, 5466.070767969455, 5469.0, 11225.550977960871, 12932.54736084242, 25020.874895625406, 25704.0, 25839.870800646066, 2028.2191356327774, 2047.7747447780732, 2073.8340932725346, 2234.6146779423625, 2564.1666458401096, 9830.0, 9930.304878658497, 10113.393196408239, 10200.13298869597, 10356.741081472948, 1676.48029110976, 1736.9826301736948, 1773.4147731248656, 1906.1231833356535, 1972.7632684078003, 95444.52277738567, 99463.50268248685, 103191.48404258005, 103369.96630033679, 106422.40366394511, 11301.49143288554, 11544.826827597593, 11548.884511154782, 11560.30638161713, 11684.298942063504, 13900.93049534766, 13908.235047072509, 13912.30438478072, 13919.373628186755, 13933.094348867291, 8536.317094632415, 8601.31189504838, 8605.784855378666, 8612.827743445096, 8711.259542938795, 8654.350923680624, 8696.91303086961, 8706.085860984633, 8767.736967890973, 8808.383413161017, 4534.79593418297, 4548.135854187693, 4550.385697930803, 4581.129585378834, 4674.976625116853, 1771.9468415947542, 1808.9236904042075, 1834.954126146857, 1860.3302810988034, 1865.159145649638, 912.8174365126869, 936.3258453913172, 958.4824194934657, 999.3304485994402, 1045.8704599033026, 19557.804421955883, 20219.898900505697, 20252.088656010514, 20312.390628281177, 20318.695219571717, 930.2790337488501, 952.2905435450496, 966.2994329111337, 1004.382304882492, 1052.894710528941, 10519.105876000625, 10652.414117223627, 10740.516676749565, 10780.892191077988, 10785.245032847626, 508505.0, 621957.0, 627295.0, 643523.7823810851, 645452.5454745393, 72182.0, 107796.0, 110623.0, 113542.86457135323, 117440.0, 1010.9949450252849, 1021.341234903483, 1026.5483187397522, 1034.2088302448633, 1038.4911393417171, 14201.721845033997, 17244.74132888033, 17634.470965871045, 17863.374781882572, 17988.55028624295, 49051.09925123432, 49542.50457495379, 49567.05195376578, 50163.24755128749, 50445.0, 68628.0, 69338.65330673516, 70190.0, 70203.59592808217, 71903.64048179725, 8009.159038300894, 10887.346759194474, 11115.8154802523, 11347.89344794829, 11405.315681059163, 12160.209586376857, 12744.42650080767, 12847.421866015864, 13086.541971030969, 13092.738145237232, 10925.617603383844, 11147.0, 11247.831282530933, 11280.49237784318, 11343.262687925258, 11241.88758112441, 11264.0, 11311.0, 11458.94270528642, 11511.654650360502, 11055.170862185529, 11594.88405115938, 11615.128865334964, 11820.881791181979, 11852.525898963944, 9488.620455181715, 11454.94272528632, 11464.885351146715, 11671.533138674358, 11743.17797754149, 11411.486483108114, 11427.428628568705, 11652.475638596114, 11657.358845263592, 11803.645890623295], "unit": "score", "name": "jquery.html", "value": 9532.742948895926}, {"lowerIsBetter": false, "replicates": [1446.7106578684266, 1581.4543982326095, 1614.830442803506, 1907.7043058325955, 2033.7661168965574, 8003.679852805888, 8628.266597339225, 8746.300295976322, 8782.38523303369, 8787.165219304155, 8509.872351914726, 8732.8690069649, 8736.563171841399, 8754.474731516113, 8756.474611523314, 2192.068370942351, 2456.299954512964, 2490.887910044052, 2514.8742562871876, 2518.4333524956924, 2503.6244563315468, 2516.8615726135054, 2518.659980902582, 2519.407939134311, 2524.798016158712, 2446.412860913377, 2497.7502249775057, 2516.471540976388, 2527.3428908483743, 2528.279440359498, 2280.551849575515, 2307.653851922208, 2313.595120853861, 2321.117975169425, 2321.872297023663, 2493.7132229793624, 2497.675302210719, 2506.3483494291618, 2524.7475252474787, 2530.962035569468, 7790.766277011642, 8884.689035883714, 8962.551872406353, 8966.641334346617, 8978.057303983052, 5448.727563621803, 5577.721113944286, 5623.0721930881355, 5625.774969001235, 5627.774889004435, 3579.3199292134673, 3603.8198090095652, 3688.981555092234, 3774.565924918642, 3774.6036666149935, 1040.5889673578895, 1051.8211903976267, 1056.287006270764, 1066.7439814444556, 1069.1607088435542, 12118.81821772674, 12162.5134994601, 12164.51341946321, 12174.81737773934, 12183.086268529807, 4943.629227807929, 4966.304717339575, 5042.067217564762, 5044.8234311798915, 5066.265391518283, 10275.332103413255, 10282.331648442976, 10282.794344113076, 10290.742731431774, 10293.330933489298, 5637.943620563824, 5639.689817060019, 5664.68844213564, 5671.432856714378, 5671.631343962629, 4217.746935183899, 4522.547745225517, 4693.272542755878, 5016.874578135503, 5040.395152581714, 3944.822482988215, 4025.496812898388, 4033.9394909076386, 4058.492688413948, 4108.404281379183, 1343.8051482534977, 1348.0226835544152, 1351.6350585341902, 1357.2331632627534, 1358.483776165051, 1367.6170672211797, 1375.312343828086, 1387.8126452928725, 1409.8308203015704, 1411.8870490360746, 8212.219839115274, 8236.011678598607, 8279.917200828035, 8289.253967142986, 8313.251807337369, 526.3184176491453, 532.4063669009105, 533.863864714503, 537.5618870620432, 542.568657916957, 6213.347598502182, 6229.53278504114, 6260.186175797117, 6286.18279623646, 6288.5598008138995, 10548.156147508182, 10735.731606709895, 10735.78528429427, 10742.194335424874, 10759.193060520336, 10428.895711042944, 10549.630762923261, 10627.0, 10682.51928663212, 10693.518791654395, 8261.504309741435, 8351.66593336272, 8379.62291696875, 8420.957895210484, 8427.241548260687, 7838.412119090977, 7899.802504937193, 7911.1693272207895, 7915.0, 8032.236937490929, 9244.445333280024, 9594.376365536218, 9651.806963860823, 9690.75773105678, 9723.0, 9725.221982241263, 9953.701388958343, 10004.449755263238, 10116.747081322732, 10131.240156988402, 6822.590644561342, 7308.817279568053, 7469.701211951461, 7535.208803075599, 7612.391008719178, 8318.70884519039, 8336.708215212439, 8368.623411946355, 8371.706990255556, 8391.874121888055, 7287.599182045038, 7305.817354566178, 7364.66858991336, 7502.137254215617, 7553.433492487976, 7215.60314182725, 7266.527675701062, 7306.232845551353, 7387.519811212254, 7419.29516695913, 7686.000819893378, 7726.381889448943, 7742.6128693566225, 7746.109197442366, 7748.92251077482, 6972.0, 7008.859822803413, 7052.717891284291, 7056.823579410556, 7078.823029424306, 7117.67970441321, 7190.928090719235, 7195.02867112933, 7235.602041887747, 7253.057102576631], "unit": "score", "name": "mootools.html", "value": 4901.141791366625}, {"lowerIsBetter": false, "replicates": [271.72827172827175, 329.0720169123072, 332.6922596598147, 336.6532471554298, 337.77875491553044, 5224.817131400397, 6492.545521813469, 6560.934390656092, 6602.10871532343, 6634.170728658918, 6466.773662921799, 6500.122483464731, 6503.967480162604, 6504.38208370204, 6544.541882068257, 4605.838795642153, 4673.485916549177, 4716.198246298138, 4758.857234282977, 4855.732934688591, 4762.476127625959, 4813.542713442235, 4818.3495228144275, 4828.299896515004, 4859.878503037417, 4761.761911904408, 4800.855974320759, 4804.759762011903, 4819.7108173509705, 4821.614270858323, 4548.7043342182815, 4612.446506419217, 4786.688865223749, 4796.712197268158, 4817.56641902227, 4098.774567398792, 4120.608542188487, 4124.1133156371525, 4125.793710314472, 4129.401236820644, 6221.502279817649, 6225.28409232935, 6243.313235544087, 6247.187865577446, 6282.371762823681, 5707.0038229929205, 5708.71456427177, 5721.399253078408, 5733.569982251348, 5736.909987102479, 5839.240898683186, 6785.91425371943, 6898.275681053467, 6902.965485172592, 6923.684499944994, 4328.848490302856, 4490.146872094291, 4515.548445155491, 4542.477615074243, 4628.791704373311, 6008.939910600881, 6669.499362643415, 7227.494075414723, 7253.165885923134, 7340.339369456775, 4593.2191527439745, 4601.0, 4602.976985115053, 4612.446506419251, 4612.962083531245, 3849.846006159722, 4668.929966050512, 4678.578927896506, 4683.297505374221, 4686.226772582554, 5543.889122217533, 5558.305211848519, 5560.499555040065, 5561.304836895388, 5565.721713914288, 6761.68147211289, 6967.512274140863, 6993.440524758007, 7031.0, 7052.0, 1602.5833283346415, 1612.6049117966174, 1624.2934323569284, 1624.6344572471335, 1625.268629116902, 988.7182153086336, 1037.2635428845454, 1043.1654676258963, 1059.364381371171, 1063.7181146996052, 6294.8111556653375, 6496.805095847132, 6609.0, 6614.8346291343105, 6636.0, 7294.234105418961, 7296.963515182496, 7312.378447831994, 7314.487985841047, 7320.04839370889, 6601.471882249409, 6602.900956485657, 6605.471562275006, 6610.900836487456, 6618.602883826986, 3116.937661246762, 3850.9422358664083, 3854.5374555053013, 3857.7685338879755, 3868.2263547290654, 7320.707171713072, 7642.04474440695, 7651.1583725790115, 7666.8849967250535, 7679.846403072019, 7496.475246732676, 7526.887096693445, 7535.698572057166, 7545.320921117126, 7571.962140189374, 7666.9616651916385, 7670.27132422419, 7673.884891726629, 7678.078630564368, 7679.654415551202, 5246.108161612611, 6683.498737594603, 6968.407685346802, 7299.5255308404785, 7301.0, 7139.571625702267, 7189.209186989322, 7197.172325182671, 7218.458615603746, 7219.9278007221355, 6568.14614100183, 7267.927320726936, 7303.685336639456, 7655.88516172269, 7683.9231607683205, 4043.5552089270745, 4607.470140933701, 4618.2610782276015, 4622.375979242759, 4624.213883639856, 6214.937850621436, 6947.270536593584, 7225.169105552718, 7231.63841807897, 7239.529430586995, 6653.500987425866, 7005.789826305219, 7023.438124949889, 7055.611941343275, 7070.222275549789, 6935.375816176568, 6944.479164062816, 7034.050403195503, 7042.542234754725, 7050.189228238818, 6880.759173429106, 6883.449324054164, 6891.483138764713, 6898.793036208922, 6917.273686263071, 6774.204529428589, 6892.035115083792, 6995.79012629622, 7018.824529386806, 7021.68402421882, 6655.667216639245, 6669.166354205724, 6812.21659509143, 6855.245922948372, 6877.105976223059], "unit": "score", "name": "prototype.html", "value": 5076.316200458617}, {"lowerIsBetter": false, "replicates": [692.6329045605829, 755.6523998960478, 756.1153450462958, 770.9922900770994, 773.6325245508384, 15295.69408611827, 15518.922405387957, 15540.145292008934, 15544.145072021049, 15545.0, 13889.583312500616, 14265.215413152273, 14359.78460323096, 14364.066335688172, 14391.568252952402, 763.5342441110918, 921.3504479342065, 936.4287784451479, 950.4487397309543, 952.642758965388, 763.0500027465813, 931.1107891963159, 951.1962391778935, 951.3768481644533, 954.6944977607169, 978.0317485689187, 978.2760757039811, 979.2215188924822, 981.043482604462, 987.8024395120968, 803.9477433966773, 979.6228452045942, 988.5106872098321, 995.4972738766949, 995.8406654935212, 736.6537727268176, 737.3216640690524, 738.1511262048633, 739.8964145019702, 739.9408047356198, 15598.220088995506, 15645.687086258326, 15652.843471565253, 15654.9217253913, 15690.529284121381, 12625.116241863074, 12789.872101279054, 12895.355232238444, 13020.283884386356, 13045.34773261333, 9936.105750482491, 10085.243606729451, 10296.845547316796, 10362.63730769427, 11012.614558490495, 3645.6172101929446, 3716.8513259469587, 3729.6829769469355, 3821.6560509554274, 3841.8079096045085, 83551.582242089, 83734.0, 84069.0, 84345.0, 84754.0, 9550.426974381558, 9631.614735410505, 9707.174890134418, 9721.854172187423, 10098.495075246208, 22676.319710408716, 22723.545529089326, 22725.659115113285, 22737.31788046361, 22808.20171293997, 7612.467127301035, 7622.738372876981, 7661.540307581563, 7724.92275077242, 7732.961335193288, 4077.2660921033907, 4111.0, 4116.5421046321235, 4141.730787498803, 4226.492820861455, 3373.375925453799, 3694.261147770457, 3704.6480584344445, 3707.351213537674, 3711.6659500645073, 657.3459407889085, 662.9005649152666, 665.0, 680.2924958043678, 681.0669382945298, 511.2790964739699, 535.5742184962963, 588.9957622254046, 597.8923793717086, 604.8850718363585, 8019.879701804478, 8031.598420078973, 8131.4714543555665, 8334.16658334174, 8370.581470926429, 533.3016127913098, 587.9441453061952, 601.762303889961, 612.8467883029243, 613.1324176290499, 3107.6270847497995, 3888.6889048876023, 3935.409688546684, 3982.880513584597, 4032.4757781488806, 72194.9170762439, 92445.0, 92811.0, 93097.0, 93163.0, 72993.6350318245, 74487.62756186293, 74964.62517687486, 75023.0, 78318.0, 65660.6716966412, 66101.00848487277, 68184.31815681879, 69470.0, 72475.27524724686, 8356.623951922056, 8457.450265732708, 8530.10433904431, 8577.785555360917, 8592.871106933526, 41937.37093943532, 48072.0, 49079.52761417163, 50431.49568504268, 51904.0, 69186.0, 69712.30287697261, 70600.58798823893, 73092.26907730855, 73469.6326518364, 11037.227394082658, 11077.16921230927, 11432.714182145513, 11450.94274528622, 11692.649220523397, 11935.582254621393, 12022.819657704966, 12073.0, 12100.576479823163, 13131.671708207372, 11054.778904422028, 11305.71735706581, 11369.374684392107, 11783.410829458664, 12426.937865310616, 11330.799235790242, 11352.886471135183, 11384.943075284571, 11484.610562139853, 11668.533258669897, 9384.202342800938, 11123.332600044023, 11145.331280123219, 11246.606368777053, 11268.436578171222, 9301.302402319718, 9351.298652600946, 9612.471314077793, 9642.807143857224, 9884.703458896245, 9334.71995840126, 9458.43249405038, 9493.430394176372, 9557.952210238904, 9789.559469824018], "unit": "score", "name": "yui.html", "value": 7002.3740608212875}], "name": "dromaeo_css", "value": 7560.746016900371}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 112.0, 110.0, 115.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 144.0, 147.0, 129.0, 171.0, 164.0, 119.0, 163.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 187.0, 185.0, 185.0, 188.0, 187.0, 186.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.3}, {"lowerIsBetter": true, "replicates": [81.0, 73.0, 88.0, 77.0, 56.0, 56.0, 60.0, 76.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 126.0, 84.0, 77.0, 88.0, 112.0, 79.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [90.0, 128.0, 121.0, 87.0, 97.0, 129.0, 89.0, 85.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 88.0, 87.0, 86.0, 86.0, 83.0, 87.0, 85.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 56.0, 57.0, 68.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 73.0, 74.0, 70.0, 67.0, 68.0, 68.0, 68.0, 75.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [97.0, 107.0, 81.0, 82.0, 82.0, 83.0, 82.0, 81.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [129.0, 131.0, 118.0, 121.0, 128.0, 125.0, 121.0, 131.0, 129.0, 146.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 134.0, 137.0, 140.0, 124.0, 136.0, 158.0, 116.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 65.0, 67.0, 68.0, 65.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1426.3999999999999}]} 13:40:46 INFO - Return code: 0 13:40:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:40:46 ERROR - # TBPL SUCCESS # 13:40:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:40:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:40:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:40:46 INFO - 2016-03-21 13:40:46.130 screenresolution[1946:11113] starting screenresolution argv=screenresolution get 13:40:46 INFO - 2016-03-21 13:40:46.133 screenresolution[1946:11113] Display 0: 1600x1200x32@60 13:40:46 INFO - 2016-03-21 13:40:46.139 screenresolution[1947:11116] starting screenresolution argv=screenresolution list 13:40:46 INFO - Available Modes on Display 0 13:40:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:40:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:40:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:40:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:40:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:40:46 INFO - Intel Iris: 13:40:46 INFO - Chipset Model: Intel Iris 13:40:46 INFO - Type: GPU 13:40:46 INFO - Bus: Built-In 13:40:46 INFO - VRAM (Dynamic, Max): 1536 MB 13:40:46 INFO - Vendor: Intel (0x8086) 13:40:46 INFO - Device ID: 0x0a2e 13:40:46 INFO - Revision ID: 0x0009 13:40:46 INFO - Displays: 13:40:46 INFO - Display: 13:40:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:40:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:40:46 INFO - Display Serial Number: 1600x1200 60 13:40:46 INFO - Main Display: Yes 13:40:46 INFO - Mirror: Off 13:40:46 INFO - Online: Yes 13:40:46 INFO - Rotation: Supported 13:40:46 INFO - Return code: 0 13:40:46 INFO - Running post-action listener: _resource_record_post_action 13:40:46 INFO - Running post-run listener: _resource_record_post_run 13:40:47 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 1544192; Write bytes: 703396864; Read time: 18; Write time: 2069 13:40:47 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399856128; Write bytes: 395179008; Read time: 30062; Write time: 732 13:40:47 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 684032; Write bytes: 297216000; Read time: 13; Write time: 1306 13:40:47 INFO - Running post-run listener: _upload_blobber_files 13:40:47 INFO - Blob upload gear active. 13:40:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:40:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:40:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:50 INFO - (blobuploader) - INFO - Done attempting. 13:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:40:53 INFO - (blobuploader) - INFO - Done attempting. 13:40:53 INFO - (blobuploader) - INFO - Iteration through files over. 13:40:53 INFO - Return code: 0 13:40:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:40:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:40:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b8afeb734b8b2f6fbefcba47ed4d2101f2a1e966f2f323c685fd43d8a74686752c7a3d2eac3193330fdec83066a55e38cecc49e839a7f68ee7f441cb967f5ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0de6e0e2db6581b2d636f4b0c3f962c8064af32f1dab47efb86285dbc05e8408a3ba68cfc463335afb85d1a7aa0a4ce7d2f679ebf8c15d96ca637f92305ece04"} 13:40:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:40:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:40:53 INFO - Contents: 13:40:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1b8afeb734b8b2f6fbefcba47ed4d2101f2a1e966f2f323c685fd43d8a74686752c7a3d2eac3193330fdec83066a55e38cecc49e839a7f68ee7f441cb967f5ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0de6e0e2db6581b2d636f4b0c3f962c8064af32f1dab47efb86285dbc05e8408a3ba68cfc463335afb85d1a7aa0a4ce7d2f679ebf8c15d96ca637f92305ece04"} 13:40:53 INFO - Running post-run listener: copy_logs_to_upload_dir 13:40:53 INFO - Copying logs to upload dir... 13:40:53 INFO - mkdir: /builds/slave/test/build/upload/logs 13:40:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.150985 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-03-21 13:40:53.291043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 13:40:53.294377) ========= 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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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/1b8afeb734b8b2f6fbefcba47ed4d2101f2a1e966f2f323c685fd43d8a74686752c7a3d2eac3193330fdec83066a55e38cecc49e839a7f68ee7f441cb967f5ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0de6e0e2db6581b2d636f4b0c3f962c8064af32f1dab47efb86285dbc05e8408a3ba68cfc463335afb85d1a7aa0a4ce7d2f679ebf8c15d96ca637f92305ece04"} build_url:https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/QNvuoiG-T-ylYKOn7E0Rsw/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/1b8afeb734b8b2f6fbefcba47ed4d2101f2a1e966f2f323c685fd43d8a74686752c7a3d2eac3193330fdec83066a55e38cecc49e839a7f68ee7f441cb967f5ea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0de6e0e2db6581b2d636f4b0c3f962c8064af32f1dab47efb86285dbc05e8408a3ba68cfc463335afb85d1a7aa0a4ce7d2f679ebf8c15d96ca637f92305ece04"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 13:40:53.468896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:40:53.469394) ========= 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.oxEJ5B4T7t/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.aPkrGuMAdn/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005220 ========= master_lag: 0.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 13:40:53.929219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 13:40:53.929524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 13:40:53.929873) ========= ========= Total master_lag: 1.10 =========