builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0130 starttime: 1456114594.12 results: success (0) buildid: 20160221184057 builduid: a8e96d4edd9b4f6c9b88e7f053804c22 revision: da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.117327) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.117960) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.118373) ========= 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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005639 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.152244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.152664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.187176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.187520) ========= 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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.261928) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.262231) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.262834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.263111) ========= 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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-21 20:16:34-- 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.10M=0.001s 2016-02-21 20:16:34 (8.10 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.670971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.949087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.949360) ========= 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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.019040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:34.998443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-21 20:16:34.998753) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 --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 da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-21 20:16:35,078 truncating revision to first 12 chars 2016-02-21 20:16:35,078 Setting DEBUG logging. 2016-02-21 20:16:35,078 attempt 1/10 2016-02-21 20:16:35,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/da87b650c2f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-21 20:16:37,155 unpacking tar archive at: fx-team-da87b650c2f6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.317955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-21 20:16:37.333597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:37.333947) ========= echo da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'da87b650c2f6b9ddaea8fdef2936dbb6425f0a74'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 program finished with exit code 0 elapsedTime=0.005043 script_repo_revision: 'da87b650c2f6b9ddaea8fdef2936dbb6425f0a74' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:37.383208) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:37.383517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-21 20:16:37.396434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-21 20:16:37.396731) ========= /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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:16:37 INFO - MultiFileLogger online at 20160221 20:16:37 in /builds/slave/test 20:16:37 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 20:16:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:37 INFO - {'append_to_log': False, 20:16:37 INFO - 'base_work_dir': '/builds/slave/test', 20:16:37 INFO - 'blob_upload_branch': 'Fx-Team', 20:16:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:37 INFO - 'branch': 'Fx-Team', 20:16:37 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:37 INFO - 'config_files': ('talos/mac_config.py',), 20:16:37 INFO - 'default_actions': ('clobber', 20:16:37 INFO - 'read-buildbot-config', 20:16:37 INFO - 'download-and-extract', 20:16:37 INFO - 'populate-webroot', 20:16:37 INFO - 'create-virtualenv', 20:16:37 INFO - 'install', 20:16:37 INFO - 'run-tests'), 20:16:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:37 INFO - 'download_minidump_stackwalk': True, 20:16:37 INFO - 'download_symbols': 'ondemand', 20:16:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:37 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:37 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:37 INFO - 'installer_path': 'installer.exe', 20:16:37 INFO - 'log_level': 'info', 20:16:37 INFO - 'log_name': 'talos', 20:16:37 INFO - 'log_to_console': True, 20:16:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:16:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:16:37 INFO - 'opt_config_files': (), 20:16:37 INFO - 'pip_index': False, 20:16:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:16:37 INFO - 'cmd': ('bash', 20:16:37 INFO - '-c', 20:16:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:16:37 INFO - 'enabled': True, 20:16:37 INFO - 'halt_on_failure': False, 20:16:37 INFO - 'name': 'check_screen_resolution'},), 20:16:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:16:37 INFO - 'cmd': ('bash', 20:16:37 INFO - '-c', 20:16:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:16:37 INFO - 'enabled': True, 20:16:37 INFO - 'halt_on_failure': False, 20:16:37 INFO - 'name': 'check_screen_resolution'},), 20:16:37 INFO - 'run_cmd_checks_enabled': True, 20:16:37 INFO - 'sps_profile': False, 20:16:37 INFO - 'sps_profile_interval': 0, 20:16:37 INFO - 'suite': 'dromaeojs', 20:16:37 INFO - 'system_bits': '32', 20:16:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:37 INFO - 'title': 't-yosemite-r7-0130', 20:16:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:37 INFO - 'use_talos_json': True, 20:16:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:37 INFO - 'work_dir': 'build'} 20:16:37 INFO - ##### 20:16:37 INFO - ##### Running clobber step. 20:16:37 INFO - ##### 20:16:37 INFO - Running pre-action listener: _resource_record_pre_action 20:16:37 INFO - Running main action method: clobber 20:16:37 INFO - rmtree: /builds/slave/test/build 20:16:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:39 INFO - Running post-action listener: _resource_record_post_action 20:16:39 INFO - ##### 20:16:39 INFO - ##### Running read-buildbot-config step. 20:16:39 INFO - ##### 20:16:39 INFO - Running pre-action listener: _resource_record_pre_action 20:16:39 INFO - Running main action method: read_buildbot_config 20:16:39 INFO - Using buildbot properties: 20:16:39 INFO - { 20:16:39 INFO - "project": "", 20:16:39 INFO - "product": "firefox", 20:16:39 INFO - "script_repo_revision": "production", 20:16:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 20:16:39 INFO - "repository": "", 20:16:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 20:16:39 INFO - "buildid": "20160221184057", 20:16:39 INFO - "pgo_build": "False", 20:16:39 INFO - "basedir": "/builds/slave/test", 20:16:39 INFO - "buildnumber": 473, 20:16:39 INFO - "slavename": "t-yosemite-r7-0130", 20:16:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:16:39 INFO - "platform": "yosemite_r7", 20:16:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 20:16:39 INFO - "branch": "fx-team", 20:16:39 INFO - "repo_path": "integration/fx-team", 20:16:39 INFO - "revision": "da87b650c2f6b9ddaea8fdef2936dbb6425f0a74", 20:16:39 INFO - "stage_platform": "macosx64", 20:16:39 INFO - "builduid": "a8e96d4edd9b4f6c9b88e7f053804c22", 20:16:39 INFO - "slavebuilddir": "test" 20:16:39 INFO - } 20:16:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 20:16:39 INFO - Running post-action listener: _resource_record_post_action 20:16:39 INFO - ##### 20:16:39 INFO - ##### Running download-and-extract step. 20:16:39 INFO - ##### 20:16:39 INFO - Running pre-action listener: _resource_record_pre_action 20:16:39 INFO - Running main action method: download_and_extract 20:16:39 INFO - mkdir: /builds/slave/test/build/tests 20:16:39 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')]} 20:16:39 INFO - https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/test_packages.json 20:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/test_packages.json 20:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:16:49 INFO - Downloaded 1277 bytes. 20:16:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:16:49 INFO - Using the following test package requirements: 20:16:49 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:16:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 20:16:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 20:16:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'jsshell-mac.zip'], 20:16:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 20:16:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:16:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 20:16:49 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 20:16:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 20:16:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:16:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:16:49 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 20:16:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:49 INFO - https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:16:52 INFO - Downloaded 17825204 bytes. 20:16:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:16:55 INFO - Return code: 0 20:16:55 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:16:55 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')]} 20:16:55 INFO - https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:17:00 INFO - Downloaded 17825204 bytes. 20:17:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:17:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:17:04 INFO - Return code: 0 20:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:04 INFO - https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:17:05 INFO - Downloaded 10707015 bytes. 20:17:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:17:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:17:05 INFO - Return code: 0 20:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:05 INFO - https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 20:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 20:17:08 INFO - Downloaded 111278810 bytes. 20:17:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:17:08 INFO - mkdir: /builds/slave/test/properties 20:17:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:17:08 INFO - Writing to file /builds/slave/test/properties/build_url 20:17:08 INFO - Contents: 20:17:08 INFO - build_url:https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:17:09 INFO - Running post-action listener: _resource_record_post_action 20:17:09 INFO - Running post-action listener: set_extra_try_arguments 20:17:09 INFO - ##### 20:17:09 INFO - ##### Running populate-webroot step. 20:17:09 INFO - ##### 20:17:09 INFO - Running pre-action listener: _resource_record_pre_action 20:17:09 INFO - Running main action method: populate_webroot 20:17:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:17:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:17:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:17:09 INFO - '--tppagecycles', 20:17:09 INFO - '7'], 20:17:09 INFO - 'tests': ['tsvgm']}}, 20:17:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:17:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:17:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:17:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:17:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:17:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:17:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'tests': ['damp', 'tps']}, 20:17:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['damp', 'tps']}, 20:17:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:17:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:17:09 INFO - 'other': {'tests': ['a11yr', 20:17:09 INFO - 'ts_paint', 20:17:09 INFO - 'tpaint', 20:17:09 INFO - 'sessionrestore', 20:17:09 INFO - 'sessionrestore_no_auto_restore']}, 20:17:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['a11yr', 20:17:09 INFO - 'ts_paint', 20:17:09 INFO - 'tpaint', 20:17:09 INFO - 'sessionrestore', 20:17:09 INFO - 'sessionrestore_no_auto_restore']}, 20:17:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['a11yr', 20:17:09 INFO - 'ts_paint', 20:17:09 INFO - 'tpaint', 20:17:09 INFO - 'sessionrestore', 20:17:09 INFO - 'sessionrestore_no_auto_restore']}, 20:17:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['a11yr', 20:17:09 INFO - 'ts_paint', 20:17:09 INFO - 'tpaint', 20:17:09 INFO - 'sessionrestore', 20:17:09 INFO - 'sessionrestore_no_auto_restore']}, 20:17:09 INFO - 'other_l64': {'tests': ['a11yr', 20:17:09 INFO - 'ts_paint', 20:17:09 INFO - 'tpaint', 20:17:09 INFO - 'sessionrestore', 20:17:09 INFO - 'sessionrestore_no_auto_restore']}, 20:17:09 INFO - 'other_nol64': {'tests': ['a11yr', 20:17:09 INFO - 'ts_paint', 20:17:09 INFO - 'tpaint', 20:17:09 INFO - 'sessionrestore', 20:17:09 INFO - 'sessionrestore_no_auto_restore']}, 20:17:09 INFO - 'svgr': {'tests': ['tsvgx', 20:17:09 INFO - 'tsvgr_opacity', 20:17:09 INFO - 'tart', 20:17:09 INFO - 'tscrollx', 20:17:09 INFO - 'cart']}, 20:17:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['tsvgx', 20:17:09 INFO - 'tsvgr_opacity', 20:17:09 INFO - 'tart', 20:17:09 INFO - 'tscrollx', 20:17:09 INFO - 'cart']}, 20:17:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'tests': ['tp5o']}, 20:17:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'talos_options': ['--e10s'], 20:17:09 INFO - 'tests': ['tp5o']}, 20:17:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'talos_options': ['--xperf_path', 20:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:17:09 INFO - 'tests': ['tp5n']}, 20:17:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:17:09 INFO - 'talos_options': ['--e10s', 20:17:09 INFO - '--xperf_path', 20:17:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:17:09 INFO - 'tests': ['tp5n']}}, 20:17:09 INFO - 'talos.zip': {'path': '', 20:17:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:17:09 INFO - Running post-action listener: _resource_record_post_action 20:17:09 INFO - ##### 20:17:09 INFO - ##### Running create-virtualenv step. 20:17:09 INFO - ##### 20:17:09 INFO - Running pre-action listener: _resource_record_pre_action 20:17:09 INFO - Running main action method: create_virtualenv 20:17:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:17:09 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 20:17:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:17:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:17:09 INFO - Using real prefix '/tools/python27' 20:17:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:17:09 INFO - Installing distribute.............................................................................................................................................................................................done. 20:17:12 INFO - Installing pip.................done. 20:17:12 INFO - Return code: 0 20:17:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17: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', 'pip>=1.5'] in /builds/slave/test/build 20:17: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 pip>=1.5 20:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:12 INFO - 'HOME': '/Users/cltbld', 20:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:12 INFO - 'LOGNAME': 'cltbld', 20:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:12 INFO - 'MOZ_NO_REMOTE': '1', 20:17:12 INFO - 'NO_EM_RESTART': '1', 20:17:12 INFO - 'PAGER': '/bin/cat', 20:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:12 INFO - 'PWD': '/builds/slave/test', 20:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:12 INFO - 'SHELL': '/bin/bash', 20:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:12 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:12 INFO - 'USER': 'cltbld', 20:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:12 INFO - 'XPC_FLAGS': '0x0', 20:17:12 INFO - 'XPC_SERVICE_NAME': '0', 20:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:13 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 20:17:13 INFO - Cleaning up... 20:17:13 INFO - Return code: 0 20:17:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:13 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 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:13 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 20:17:13 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 20:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:13 INFO - 'HOME': '/Users/cltbld', 20:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:13 INFO - 'LOGNAME': 'cltbld', 20:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:13 INFO - 'MOZ_NO_REMOTE': '1', 20:17:13 INFO - 'NO_EM_RESTART': '1', 20:17:13 INFO - 'PAGER': '/bin/cat', 20:17:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:13 INFO - 'PWD': '/builds/slave/test', 20:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:13 INFO - 'SHELL': '/bin/bash', 20:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:13 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:13 INFO - 'USER': 'cltbld', 20:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:13 INFO - 'XPC_FLAGS': '0x0', 20:17:13 INFO - 'XPC_SERVICE_NAME': '0', 20:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:13 INFO - Downloading/unpacking psutil>=0.7.1 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:13 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 20:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:17:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:17:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:17:16 INFO - Installing collected packages: psutil 20:17:16 INFO - Running setup.py install for psutil 20:17:16 INFO - building 'psutil._psutil_osx' extension 20:17:16 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 INFO - building 'psutil._psutil_posix' extension 20:17:17 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 20:17:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:17:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:17:17 INFO - ^ 20:17:17 INFO - 1 warning generated. 20:17:17 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 20:17:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:17:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:17:17 INFO - Successfully installed psutil 20:17:17 INFO - Cleaning up... 20:17:17 INFO - Return code: 0 20:17:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:17 INFO - 'HOME': '/Users/cltbld', 20:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:17 INFO - 'LOGNAME': 'cltbld', 20:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:17 INFO - 'MOZ_NO_REMOTE': '1', 20:17:17 INFO - 'NO_EM_RESTART': '1', 20:17:17 INFO - 'PAGER': '/bin/cat', 20:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:17 INFO - 'PWD': '/builds/slave/test', 20:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:17 INFO - 'SHELL': '/bin/bash', 20:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:17 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:17 INFO - 'USER': 'cltbld', 20:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:17 INFO - 'XPC_FLAGS': '0x0', 20:17:17 INFO - 'XPC_SERVICE_NAME': '0', 20:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:17:20 INFO - Installing collected packages: mozsystemmonitor 20:17:20 INFO - Running setup.py install for mozsystemmonitor 20:17:20 INFO - Successfully installed mozsystemmonitor 20:17:20 INFO - Cleaning up... 20:17:20 INFO - Return code: 0 20:17:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:20 INFO - 'HOME': '/Users/cltbld', 20:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:20 INFO - 'LOGNAME': 'cltbld', 20:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:20 INFO - 'MOZ_NO_REMOTE': '1', 20:17:20 INFO - 'NO_EM_RESTART': '1', 20:17:20 INFO - 'PAGER': '/bin/cat', 20:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:20 INFO - 'PWD': '/builds/slave/test', 20:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:20 INFO - 'SHELL': '/bin/bash', 20:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:20 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:20 INFO - 'USER': 'cltbld', 20:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:20 INFO - 'XPC_FLAGS': '0x0', 20:17:20 INFO - 'XPC_SERVICE_NAME': '0', 20:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:20 INFO - Downloading/unpacking blobuploader==1.2.4 20:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:23 INFO - Downloading blobuploader-1.2.4.tar.gz 20:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:17:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:17:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:24 INFO - Downloading docopt-0.6.1.tar.gz 20:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:17:24 INFO - Installing collected packages: blobuploader, requests, docopt 20:17:24 INFO - Running setup.py install for blobuploader 20:17:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:17:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:17:24 INFO - Running setup.py install for requests 20:17:25 INFO - Running setup.py install for docopt 20:17:25 INFO - Successfully installed blobuploader requests docopt 20:17:25 INFO - Cleaning up... 20:17:25 INFO - Return code: 0 20:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:25 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')]} 20:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:25 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')]} 20:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:25 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 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:25 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 20:17:25 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 20:17:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:25 INFO - 'HOME': '/Users/cltbld', 20:17:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:25 INFO - 'LOGNAME': 'cltbld', 20:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:25 INFO - 'MOZ_NO_REMOTE': '1', 20:17:25 INFO - 'NO_EM_RESTART': '1', 20:17:25 INFO - 'PAGER': '/bin/cat', 20:17:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:25 INFO - 'PWD': '/builds/slave/test', 20:17:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:25 INFO - 'SHELL': '/bin/bash', 20:17:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:25 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:25 INFO - 'USER': 'cltbld', 20:17:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:25 INFO - 'XPC_FLAGS': '0x0', 20:17:25 INFO - 'XPC_SERVICE_NAME': '0', 20:17:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:25 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5XCMpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:25 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-OuYQXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:25 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-eNCTQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:25 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EXswak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:25 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-M3_xEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-HXntNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-x13p_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Jyd1Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-qyxptB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-qoAGJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-cVaRDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-nO9Jpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-QVakEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:26 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-roo3Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:27 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-QgOyer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:27 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-CiPBvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:27 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-xqESoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:17:27 INFO - Running setup.py install for manifestparser 20:17:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:17:27 INFO - Running setup.py install for mozcrash 20:17:27 INFO - Running setup.py install for mozdebug 20:17:27 INFO - Running setup.py install for mozdevice 20:17:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:17:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:17:27 INFO - Running setup.py install for mozfile 20:17:28 INFO - Running setup.py install for mozhttpd 20:17:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Running setup.py install for mozinfo 20:17:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Running setup.py install for mozInstall 20:17:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Running setup.py install for mozleak 20:17:28 INFO - Running setup.py install for mozlog 20:17:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Running setup.py install for moznetwork 20:17:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:17:28 INFO - Running setup.py install for mozprocess 20:17:29 INFO - Running setup.py install for mozprofile 20:17:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:17:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:17:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:17:29 INFO - Running setup.py install for mozrunner 20:17:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:17:29 INFO - Running setup.py install for mozscreenshot 20:17:29 INFO - Running setup.py install for moztest 20:17:29 INFO - Running setup.py install for mozversion 20:17:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:17:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:17:29 INFO - Cleaning up... 20:17:29 INFO - Return code: 0 20:17:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:29 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 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:29 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 20:17:29 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 20:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:29 INFO - 'HOME': '/Users/cltbld', 20:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:29 INFO - 'LOGNAME': 'cltbld', 20:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:29 INFO - 'MOZ_NO_REMOTE': '1', 20:17:29 INFO - 'NO_EM_RESTART': '1', 20:17:29 INFO - 'PAGER': '/bin/cat', 20:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:29 INFO - 'PWD': '/builds/slave/test', 20:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:29 INFO - 'SHELL': '/bin/bash', 20:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:29 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:29 INFO - 'USER': 'cltbld', 20:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:29 INFO - 'XPC_FLAGS': '0x0', 20:17:29 INFO - 'XPC_SERVICE_NAME': '0', 20:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-KcGyiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-DiKsk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EbIWvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-TPAhBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5xtY1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-cAGj7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-tl__lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Iep74E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:30 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)) 20:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:30 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-kwr8Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-8jRtgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-ub11Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-bddDdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Pc2h2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-CDQB3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-yhReP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-40tuyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:31 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)) 20:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:31 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-W8U18N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:31 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)) 20:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:17:31 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)) 20:17:31 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)) 20:17:31 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)) 20:17:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:34 INFO - Downloading blessings-1.6.tar.gz 20:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:17:34 INFO - Installing collected packages: blessings 20:17:34 INFO - Running setup.py install for blessings 20:17:34 INFO - Successfully installed blessings 20:17:34 INFO - Cleaning up... 20:17:34 INFO - Return code: 0 20:17:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:34 INFO - Reading from file tmpfile_stdout 20:17:34 INFO - Current package versions: 20:17:34 INFO - blessings == 1.6 20:17:34 INFO - blobuploader == 1.2.4 20:17:34 INFO - docopt == 0.6.1 20:17:34 INFO - manifestparser == 1.1 20:17:34 INFO - mozInstall == 1.12 20:17:34 INFO - mozcrash == 0.16 20:17:34 INFO - mozdebug == 0.1 20:17:34 INFO - mozdevice == 0.48 20:17:34 INFO - mozfile == 1.2 20:17:34 INFO - mozhttpd == 0.7 20:17:34 INFO - mozinfo == 0.9 20:17:34 INFO - mozleak == 0.1 20:17:34 INFO - mozlog == 3.1 20:17:34 INFO - moznetwork == 0.27 20:17:34 INFO - mozprocess == 0.22 20:17:34 INFO - mozprofile == 0.28 20:17:34 INFO - mozrunner == 6.11 20:17:34 INFO - mozscreenshot == 0.1 20:17:34 INFO - mozsystemmonitor == 0.0 20:17:34 INFO - moztest == 0.7 20:17:34 INFO - mozversion == 1.4 20:17:34 INFO - psutil == 3.1.1 20:17:34 INFO - requests == 1.2.3 20:17:34 INFO - wsgiref == 0.1.2 20:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:34 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')]} 20:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:34 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')]} 20:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:34 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 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:34 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 20:17:34 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 20:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:34 INFO - 'HOME': '/Users/cltbld', 20:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:34 INFO - 'LOGNAME': 'cltbld', 20:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:34 INFO - 'MOZ_NO_REMOTE': '1', 20:17:34 INFO - 'NO_EM_RESTART': '1', 20:17:34 INFO - 'PAGER': '/bin/cat', 20:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:34 INFO - 'PWD': '/builds/slave/test', 20:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:34 INFO - 'SHELL': '/bin/bash', 20:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:34 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:34 INFO - 'USER': 'cltbld', 20:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:34 INFO - 'XPC_FLAGS': '0x0', 20:17:34 INFO - 'XPC_SERVICE_NAME': '0', 20:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 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)) 20:17:35 INFO - Cleaning up... 20:17:35 INFO - Return code: 0 20:17:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:17:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:35 INFO - 'HOME': '/Users/cltbld', 20:17:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:35 INFO - 'LOGNAME': 'cltbld', 20:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:35 INFO - 'MOZ_NO_REMOTE': '1', 20:17:35 INFO - 'NO_EM_RESTART': '1', 20:17:35 INFO - 'PAGER': '/bin/cat', 20:17:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:35 INFO - 'PWD': '/builds/slave/test', 20:17:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:35 INFO - 'SHELL': '/bin/bash', 20:17:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:35 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:35 INFO - 'USER': 'cltbld', 20:17:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:35 INFO - 'XPC_FLAGS': '0x0', 20:17:35 INFO - 'XPC_SERVICE_NAME': '0', 20:17:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:35 INFO - Downloading/unpacking jsonschema 20:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:17:37 INFO - Downloading/unpacking functools32 (from jsonschema) 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17:38 INFO - Downloading functools32-3.2.3-2.tar.gz 20:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:17:38 INFO - warning: no files found matching '*.txt' 20:17:38 INFO - no previously-included directories found matching 'build' 20:17:38 INFO - no previously-included directories found matching 'dist' 20:17:38 INFO - no previously-included directories found matching '.git*' 20:17:38 INFO - Installing collected packages: jsonschema, functools32 20:17:38 INFO - Running setup.py install for functools32 20:17:38 INFO - warning: no files found matching '*.txt' 20:17:38 INFO - no previously-included directories found matching 'build' 20:17:38 INFO - no previously-included directories found matching 'dist' 20:17:38 INFO - no previously-included directories found matching '.git*' 20:17:38 INFO - Successfully installed jsonschema functools32 20:17:38 INFO - Cleaning up... 20:17:38 INFO - Return code: 0 20:17:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d6c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f952ad6dfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, '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.3mreFqzjrm/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.1VModsug1m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 20:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:17:38 INFO - 'HOME': '/Users/cltbld', 20:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:17:38 INFO - 'LOGNAME': 'cltbld', 20:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:38 INFO - 'MOZ_NO_REMOTE': '1', 20:17:38 INFO - 'NO_EM_RESTART': '1', 20:17:38 INFO - 'PAGER': '/bin/cat', 20:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:38 INFO - 'PWD': '/builds/slave/test', 20:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:17:38 INFO - 'SHELL': '/bin/bash', 20:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:17:38 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:17:38 INFO - 'USER': 'cltbld', 20:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:38 INFO - 'XPC_FLAGS': '0x0', 20:17:38 INFO - 'XPC_SERVICE_NAME': '0', 20:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:38 INFO - Downloading/unpacking flake8 20:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:17:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:17:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:17:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:17:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:17:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:17:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:17:42 INFO - no previously-included directories found matching 'docs/_build' 20:17:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:17:42 INFO - Running setup.py install for pep8 20:17:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:17:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:17:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:17:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:17:42 INFO - no previously-included directories found matching 'docs/_build' 20:17:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:17:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:17:42 INFO - Cleaning up... 20:17:42 INFO - Return code: 0 20:17:42 INFO - Running post-action listener: _resource_record_post_action 20:17:42 INFO - Running post-action listener: _start_resource_monitoring 20:17:42 INFO - Starting resource monitoring. 20:17:42 INFO - ##### 20:17:42 INFO - ##### Running install step. 20:17:42 INFO - ##### 20:17:42 INFO - Running pre-action listener: _resource_record_pre_action 20:17:42 INFO - Running main action method: install 20:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:43 INFO - Reading from file tmpfile_stdout 20:17:43 INFO - Detecting whether we're running mozinstall >=1.0... 20:17:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:17:43 INFO - Reading from file tmpfile_stdout 20:17:43 INFO - Output received: 20:17:43 INFO - Usage: mozinstall [options] installer 20:17:43 INFO - Options: 20:17:43 INFO - -h, --help show this help message and exit 20:17:43 INFO - -d DEST, --destination=DEST 20:17:43 INFO - Directory to install application into. [default: 20:17:43 INFO - "/builds/slave/test"] 20:17:43 INFO - --app=APP Application being installed. [default: firefox] 20:17:43 INFO - mkdir: /builds/slave/test/build/application 20:17:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:18:16 INFO - Reading from file tmpfile_stdout 20:18:16 INFO - Output received: 20:18:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:18:16 INFO - Running post-action listener: _resource_record_post_action 20:18:16 INFO - ##### 20:18:16 INFO - ##### Running run-tests step. 20:18:16 INFO - ##### 20:18:16 INFO - Running pre-action listener: _resource_record_pre_action 20:18:16 INFO - Running main action method: run_tests 20:18:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:18:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:18:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:18:16 INFO - 2016-02-21 20:18:16.676 screenresolution[1957:16837] starting screenresolution argv=screenresolution get 20:18:16 INFO - 2016-02-21 20:18:16.679 screenresolution[1957:16837] Display 0: 1600x1200x32@60 20:18:16 INFO - 2016-02-21 20:18:16.684 screenresolution[1958:16840] starting screenresolution argv=screenresolution list 20:18:16 INFO - Available Modes on Display 0 20:18:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:18:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:18:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:18:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:18:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:18:16 INFO - Intel Iris: 20:18:16 INFO - Chipset Model: Intel Iris 20:18:16 INFO - Type: GPU 20:18:16 INFO - Bus: Built-In 20:18:16 INFO - VRAM (Dynamic, Max): 1536 MB 20:18:16 INFO - Vendor: Intel (0x8086) 20:18:16 INFO - Device ID: 0x0a2e 20:18:16 INFO - Revision ID: 0x0009 20:18:16 INFO - Displays: 20:18:16 INFO - Display: 20:18:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:18:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:18:16 INFO - Display Serial Number: 1600x1200 60 20:18:16 INFO - Main Display: Yes 20:18:16 INFO - Mirror: Off 20:18:16 INFO - Online: Yes 20:18:16 INFO - Rotation: Supported 20:18:16 INFO - Return code: 0 20:18:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:18:16 INFO - Python 2.7.3 20:18:16 INFO - Return code: 0 20:18:16 INFO - grabbing minidump binary from tooltool 20:18:16 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')]} 20:18:16 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 0x104c08d30>, '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 0x104a2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:18:16 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 20:18:16 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 20:18:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:18:17 INFO - Return code: 0 20:18:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:18:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:18:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:18:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:18:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:18:18 INFO - Return code: 0 20:18:18 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/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 20:18:18 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/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --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 20:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mreFqzjrm/Render', 20:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:18:18 INFO - 'HOME': '/Users/cltbld', 20:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:18:18 INFO - 'LOGNAME': 'cltbld', 20:18:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:18:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:18 INFO - 'MOZ_NO_REMOTE': '1', 20:18:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:18:18 INFO - 'NO_EM_RESTART': '1', 20:18:18 INFO - 'PAGER': '/bin/cat', 20:18:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:18 INFO - 'PWD': '/builds/slave/test', 20:18:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:18:18 INFO - 'SHELL': '/bin/bash', 20:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1VModsug1m/Listeners', 20:18:18 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 20:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:18:18 INFO - 'USER': 'cltbld', 20:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:18 INFO - 'XPC_FLAGS': '0x0', 20:18:18 INFO - 'XPC_SERVICE_NAME': '0', 20:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:18:18 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/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 20:18:18 INFO - mozversion application_buildid: 20160221184057 20:18:18 INFO - mozversion application_changeset: da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 20:18:18 INFO - mozversion application_display_name: Nightly 20:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:18:18 INFO - mozversion application_name: Firefox 20:18:18 INFO - mozversion application_remotingname: firefox 20:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:18:18 INFO - mozversion application_vendor: Mozilla 20:18:18 INFO - mozversion application_version: 47.0a1 20:18:18 INFO - mozversion platform_buildid: 20160221184057 20:18:18 INFO - mozversion platform_changeset: da87b650c2f6b9ddaea8fdef2936dbb6425f0a74 20:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:18:18 INFO - mozversion platform_version: 47.0a1 20:18:18 INFO - using testdate: 1456114698 20:18:18 INFO - actual date: 1456114698 20:18:18 INFO - starting webserver on 'localhost:49610' 20:18:18 INFO - SUITE-START | Running 2 tests 20:18:18 INFO - TEST-START | dromaeo_css 20:18:18 INFO - operating with platform_type : mac_ 20:18:19 INFO - Initialising browser for dromaeo_css test... 20:18:19 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpsQRgUN/profile http://localhost:49610/getInfo.html) 20:18:21 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 20:18:21 INFO - PROCESS | 1976 | colorDepth:24 20:18:21 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 20:18:21 INFO - PROCESS | 1976 | __metrics 20:18:21 INFO - PROCESS | 1976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:18:21 INFO - PROCESS | 1976 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:22 INFO - TEST-INFO | 1976: exit 0 20:18:22 INFO - Browser initialized. 20:18:22 INFO - Running cycle 1/1 for dromaeo_css test... 20:18:22 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpsQRgUN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:34 INFO - PROCESS | 1979 | RSS: Main: 242507776 20:18:34 INFO - PROCESS | 1979 | 20:19:25 INFO - PROCESS | 1979 | 1456114765521 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] 20:21:36 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49610/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49610/tests/dromaeo/cssquery-ext.html) 20:21:37 INFO - PROCESS | 1979 | RSS: Main: 331001856 20:21:37 INFO - PROCESS | 1979 | 20:24:39 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49610/tests/dromaeo/cssquery-ext.html (next: http://localhost:49610/tests/dromaeo/cssquery-jquery.html) 20:24:40 INFO - PROCESS | 1979 | RSS: Main: 375287808 20:24:40 INFO - PROCESS | 1979 | 20:27:42 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49610/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49610/tests/dromaeo/cssquery-mootools.html) 20:27:43 INFO - PROCESS | 1979 | RSS: Main: 374730752 20:27:43 INFO - PROCESS | 1979 | 20:30:45 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49610/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49610/tests/dromaeo/cssquery-prototype.html) 20:30:45 INFO - PROCESS | 1979 | RSS: Main: 336982016 20:30:45 INFO - PROCESS | 1979 | 20:33:48 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49610/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49610/tests/dromaeo/cssquery-yui.html) 20:33:49 INFO - PROCESS | 1979 | RSS: Main: 336769024 20:33:49 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49610/tests/dromaeo/cssquery-yui.html (next: http://localhost:49610/tests/dromaeo/cssquery-dojo.html) 20:36:52 INFO - PROCESS | 1979 | RSS: Main: 382980096 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | __start_tp_report 20:36:52 INFO - PROCESS | 1979 | _x_x_mozilla_page_load 20:36:52 INFO - PROCESS | 1979 | _x_x_mozilla_page_load_details 20:36:52 INFO - PROCESS | 1979 | |i|pagename|runs| 20:36:52 INFO - PROCESS | 1979 | |0;dojo.html;3389.932201355973;3426.503157042229;3454.7236221102316;3478.06092355064;3486.651334866512;5571.609987300891;5616.3260408751;5632;5639.520640745536;5658.6038977271555;5640.351359593648;5707.857303567413;5709.0580054290995;5713.285839270091;5714.028615135427;5125.743712814363;5144.305518754976;5191.377034755835;5193.662411943231;5243.6853788772605;5235.55497782689;5235.895282094356;5244.606654500909;5249.42256351801;5250.501202385767;5109.514596113363;5114.028334616411;5117.5650069744115;5160.716160611165;5242.737863106849;5143.562797162245;5199.090159222121;5200.817971371002;5206.713630750307;5259.342582177228;4972.801087956477;5039.546440820343;5094.566961808251;5126.2054381570915;5175.508326708957;5481.671099733989;5509.47659972306;5533.806316778933;5590.86022849432;5612.410696876851;6136.509079273647;6137.447629713302;6142;6158.815235542941;6171.197744293258;6123.8162855114415;6154.78458253959;6213.782517611862;6224.9688751556405;6227.564070515065;5011.972545628138;5298.125809241432;5301.761420735999;5706.087026075849;5753.424657534297;6186.752529898844;6199.845003874939;6229.813105606749;6230.563860529719;6240.4071613196675;5920.348761636216;6038.275406951194;6095.359987201368;6109.541784366191;6130.754769809247;6131.816045518642;6144.692765361714;6168.414000669929;6170.969145154246;6184.5052395808225;6059.21230240066;6106.847328816815;6123.540734444934;6143.56995010354;6147.96926015376;5148.2020286855595;6044.516438684895;6117.188044311343;6141.109539116803;6205.751769929243;4876.390451193601;4882.414110306786;4882.5605695487575;4915.4347250065985;4931.038447502774;4319.265724826787;4396.802143903532;4400.22995975703;4407.977960110179;4424.867253982386;5629.296337957755;5695.231143795618;5748.597598168171;5765.740541675551;5830.76676932918;6165.075238714139;6167.629942203482;6187.195664563578;6195.535334849904;6199.504039676815;5543.944560554342;5735.7418916148035;5742.7415766290615;5757.798477053283;5771.769129234867;5335.386430560535;5381;5385.3268341457315;5388.865278368072;5437.8368648940595;6311.842203944938;6358.1416508771645;6362.204724409449;6367.968160159169;6378.011408231731;6114.144019837137;6138.664296166039;6226.25284965807;6235.812925612239;6247.656378899204;6265.216847894013;6289.685515724287;6338.746450141943;6348.143000694847;6353.237611486651;6119.694015299307;6139.662318572521;6151.323354431099;6153.6923153841235;6158.3841615838055;6116.457510225511;6139.754409823557;6215.65813880241;6224.190855188796;6229.781957631461;6019.18740969981;6046.5767396281835;6055.576109672281;6057.697115144313;6100.633961962297;4538.72767633943;5901.203337549376;6002.489788368038;6029.246344206974;6030.577859549965;5676.68778217202;5715.542756579547;5845.298564172326;5855.677937713466;5875.294964604275;5877.089051197071;5940.910886336622;5964.612300200473;6055.273367195965;6130.969345153246;5755.53955683536;5843.7954671587995;5865.237519122486;5890.3226128994;5894.469497745224 20:36:52 INFO - PROCESS | 1979 | |1;ext.html;457.26608792887413;459.35001972209324;520.3703518742323;524.4440892653787;570.8629928817085;28821.847126114957;36750.26499470009;37235.99999999996;37370;37374.878753637364;32317.51523727146;33152.502712459274;39926;40069.797906062864;40102.59897401025;9161.129692679186;9527.952360238189;9528.761780955463;9534.284928630346;9549.856752148724;9330.160285574297;9478.28912831537;9481.099295566944;9483;9625.759356016086;9465.526723663823;9530.38052526587;9538.284628652878;9547.379420337656;9570.712878613618;9544.284178686592;9631.470269135194;9632.422054676706;9639.951800241024;9643.324967252294;9501.857472137923;9619.56711947964;9626.711198664052;9634.855477167848;9637.036296370377;38795.22409551821;39158;39220.80389598062;39241.82274531769;39267.80366098151;3103.7516998640053;3158.98420507896;3207.631122420905;3379.222778760874;3418.9658103418897;27540.586891196646;28536.14391568256;29234.415311693647;29272;29310.413791724048;2739.561670132789;2821.4780265650716;2844.8293102413922;2849.244950088228;2878.352370716572;489363.5531822354;493307;497865;498772;499963;43167.13665726668;43810;43836;44071.33892991608;63390.68304658539;43002.35496467556;43088;43242.351364729555;43252.13495730068;43345.34981975273;12993.870061299265;15184.088954662755;15463.072215667096;15463.072215667096;15539.922300388653;12358.75282494345;12415.379231038412;12422;12432.937835310766;12616.747665046647;14106.64733381653;14109.71780564383;14141.363638636287;14199.78700319496;14206;6123.693815309217;6168.946371546113;6205.906911396332;6213.141954700798;6213.545649468435;916.7845556294266;1010.1361250304201;1019.1133713669008;1038.2317085356933;1045.174312293295;28714.712852871206;28862.98979535706;29106;29187.708122918924;29336;957.3537861943161;1049.522467277387;1085.919510087468;1086.7554800169898;1167.3637867362308;12207.450664720109;12750;13493.122947008413;13502;14019.929900350433;281300;287581;287658;287699;289445;53718.46281537213;54162.45837541653;54200.45799541954;54233.91532169335;54396.64008399742;1271.1165739810929;1327.8406591208923;1442.1563385419647;1450.2821103553808;1454.3528129982267;26997;27950.86024569864;29183.97856075027;31707.841460792548;32108.678913211505;45575.77212113918;52775.47224527859;55132.72433637806;55756.72121639366;55974.4025597437;354772;411053;422791;422836;423399;42594.57405425906;43047;43187.56812431836;43656.126877462906;43775.343369848844;44788.88027799331;44932;45114.77442612897;45330.54669453263;46463;37081.81459092687;38415.03962400962;39351.80324098361;39611.60388396079;39614;37793.62206377901;38564.421533676454;39486.605133948295;39610.603893961845;39780;36024.81987590045;37263.813680931424;37500;37513;37577;30290.69709302967;30353;31294.591743371147;33383.66616333806;33568.16079598029;22961.770382295963;24656.333426305817;25243.621345680196;25622.48755024852;26318 20:36:52 INFO - PROCESS | 1979 | |2;jquery.html;369.42369902951395;374.1170836825094;374.54118704586887;377.5959723096286;378.81816727970556;15804.604884877885;16300.918495407535;19442.41672749818;20180.59638807225;20734.585308293845;19279.710804337945;19362.515937101543;19954.800451995477;20023.699644505345;20039.799602003975;5746.396628354015;5799.333076696192;5960.433758792929;5961.642301461904;6000.909986350208;3926.0773718176206;4100.261952848486;5835.679037652927;5928.525717942554;6090.269167699882;6050.546209034318;6057.787977420791;6071.66605836681;6085.2393450818645;6096.055111457731;5865.530757539408;5978;6027.276726792791;6030.728617212236;6054.878902421971;5719.170720245541;5719.342275638313;5733.251358335706;5734.655920644775;5736.024875771129;12783;13365.331733413388;13409.86590134096;13427;13434.664133396645;1985.5731017831235;2047.2527527452373;2250.0662225176534;2282.372347604422;2349.8237632177656;9592.424454532751;9610.615575376976;9763.170130538912;10170.186385089175;10214.642487512901;1681.5123614152003;1722.4488163787594;1758.6746451906438;1797.4585602475902;1805.3230038735473;83524;99266.5036674812;105323;105654;107713.61431928372;9008.369414140947;9066.727998160066;11037;11159.665210043711;11218.55125794959;13514.662133446742;13565.525206617722;13570.728585428433;13570.93214533921;13601.31993400326;8140.552269625109;8292.792680183044;8293.129221431664;8351.498910065415;8364.958175209085;8398.328133749286;8400.285975692012;8407.663693452316;8474.1949514796;8485.533295668798;4390.275604525282;4460.710053846489;4509.188346097669;4516.458025037016;4521.84173553924;1738.5566680496393;1810.6650269700147;1835.7980622131554;1840.07996001999;1873.8756745952592;375.6938095452198;892.5537231384308;954.71358592422;965.35803690545;994.3487016004528;9818.65634702782;11527.423628818526;11527.76944461123;11566.65300041;11647.242929209575;412.8720096769951;461.42322097378275;896.9013408525057;954.2175416158683;973.7662960889336;9890.802183956424;10175.796484070277;10211.438370889673;10671.146308295472;10684.465776711133;606600;612733;612983;624176;630574;107334.46332768287;109482.24142068616;110682.33976490359;111630.44184779187;112418.43790780994;1010.2170817616259;1019.108280254777;1025.7128004158847;1027.5324727249083;1048.3290693956026;12799.680007999503;17395.304187832346;17611.471655850346;17931.641367172324;17944.19251133676;48623.0275394483;49992.50007499878;50386;50396.49603503918;50709.49290507195;48043.75978120087;71145.6442717783;77370;78249.2175078242;81168.34742436722;8109.10799812032;8221.465604735673;8222.917770822454;8296.211859873303;8303.916960830556;10991.780164396507;12932.741345173232;13147.802782958455;13378.86621133815;13500.93249533746;11211.383373914514;11652.009579185526;11665.24175928562;11675.941620291844;11702.122340824642;11188.272762270426;11440.053583389215;11495.597654082067;11817.645470635895;12006.939965300118;9755.463449510062;10832.404217768099;11872.703182420508;11977.101717371057;12011;8110.553919534483;8241.175882411711;8241.670333186605;8291.41960062814;8317.750467485985;8471.322294216325;10200.571919931364;10290.794184116425;11104.389258590854;11115.610953616584 20:36:52 INFO - PROCESS | 1979 | |3;mootools.html;1412.0327575610713;1536.7080254751593;1552.565281721118;1756.1394916490915;1899.7150427435893;7816.921830781691;8473.152684731524;8649.524276164808;8663.436876603017;8670.696525621604;8288.792780180498;8529.530875801844;8532.8720069199;8544.401891867572;8544.572771361423;2150.139944022396;2416.32342943976;2433.440308728989;2460.052879641342;2463.75362463754;2451.166603354859;2474.9010039598393;2476.232367965927;2481.2308184462872;2481.491294284667;2426.1265944260053;2447.1312683997194;2449.2774631483753;2449.80401567875;2450.2894160693377;2175.260411460103;2409.9999999999914;2450.142450142436;2451.754824517534;2454.607262837955;1974.2399176317222;2384.511175209078;2404.8436851604765;2410.9879450602634;2413.3604594782396;8582.957085214597;8619.827603447897;8669.349798765117;8673.739787806377;8683.609237584324;5220.138677118271;5308.389535203462;5362.892742145174;5369.543588794957;5420.512153906128;3137.247060705437;3627.093226693327;3704.407294832814;3745.250949810049;3760.8871733848027;919.0350132360994;972.1785091597588;1072.4423299884018;1083.9973024951967;1092.8634220410763;11637.127215458875;11713.882861171365;11715.53137874484;11724.824127638092;11738.94130529342;4775.474697783241;4878.463369029404;4901.779419926112;4954.1082605130705;4957.479464656231;10063.69808905734;10069.144122749502;10083.142932850644;10090.596376145018;10093.444860532594;4961;5405.972970135203;5424.213489044067;5439.646422982493;5452.754626041838;4067.4102255173425;4460.241758900995;4816.253480710496;4883.853484395474;4891.413030436371;3938.665213456888;3955.5253369595835;3961.643452089326;3995.1011022520283;4016.9196616067516;1210.1468464732343;1248.4818800197997;1304.067591671959;1317.80232965056;1322.418136020148;1069.2889228662852;1081.8701755789355;1113.7883802077579;1365.3105181883284;1376.5732622886937;8098.919010809935;8153.429259951747;8207.917920820715;8208.753737387888;8220.876686849702;514.3750343332869;516.9250458683545;516.94830516948;521.163532530291;530.1385248970423;6174.44430001302;6210.720517576629;6257.655828929453;6271.310155882849;6272.341404152589;10161.695149145537;10491.737706557396;10534.841977370346;10606.628767993083;10630.202734794766;10201.54093065799;10348.741281468023;10472.057514823702;10477.580896764197;10495.580176792842;8123.4313598047565;8317.376196785266;8376.288015518627;8380.664773409238;8403.117672644406;8051.315638170587;8077.919220807952;8091.676332946617;8136.430449868452;8195.508269503849;8388.699751538521;8860.867086993829;9348.579313930753;9525.857112143462;9666;9767.609295628095;10022.098011179029;10032.247581431568;10159.898401015895;10164.186865050926;6475.352464753675;6855.4172895304455;6902.344277293649;7555.282248186413;7619.961900190464;8163.877541836759;8164;8192.221738934792;8206.835863282582;8213.219744124299;7272.490925635155;7355.374793142642;7365.447591430557;7499.88750168737;7542.509736867306;7204;7309.634518273959;7324;7365.52124111931;7578.772636820904;7635.732749353746;7653.770386888402;7687.0391201099865;7697.230276972258;7701.768946931601;6871.224498973165;6928.584284942919;6944.756933507303;7002.124734408199;7017.614031228331;7020.719171233298;7022.859542809218;7060.964695176696;7085.681144348414;7100.289971002859 20:36:52 INFO - PROCESS | 1979 | |4;prototype.html;262.3153569184429;327.9229381095442;332.9600447946246;334.10293362322165;340.1733786897837;6413.070104834796;6556.73773049078;6574.276829548746;6622.337766223382;6644.3023482534245;6496.577722448038;6583.67081645917;6597.406233438989;6599.142111525507;6616.305287944769;4159.771212583307;4628;4662.696924699901;4808.663393562443;4825.7587120644;4613.561711637406;4668.089722504113;4694.3662605548325;4731.81072757091;4738.19450693383;4655.557722016403;4732.100900828831;4742.146413645542;4755.9286610700865;4758.452777930548;4723.669343145981;4741.122892264925;4743.810247590092;4760.381150450454;4770.212914869043;3854.209886973164;3941.881743547698;4028.053407449247;4028.2547728669997;4032.4354590357375;6147.0779383092895;6188.628682279078;6200.914839903044;6232.283287421959;6244.0321750128805;4784.378030856001;5280.683159010433;5502.752376143083;5518.862028449281;5521.613487055908;5832.862591794602;6743.460523158135;6905.75829845953;6941.479389045841;6942.2363540011065;4453.688241823042;4455.4876189238;4464.374987501752;4464.776761161961;4471.329300604935;6985.545939513966;7335.193128755833;7378.9631051844935;7395.556266624019;7397.630118494108;4520.751358675238;4558.270676691714;4564.8402305919135;4566.132434837436;4573.794179261941;4629.166749984967;4638.79125439356;4641.489436162019;4642.512536183652;4652.55800698933;5470.316210473691;5485.588580856452;5491.862703432446;5512.972435137879;5515.365732940683;6736.427403670645;6983.406410455066;6987.930120698829;7003.824904377431;7006.789796306119;1580.2019979910071;1603.214424931775;1623.7239669256019;1627.4873414874278;1627.804663440371;1021.3718563083798;1029.0686928329724;1039.2517387481003;1045.4041196517912;1050.9211809114347;6403.135576697179;6567.474602031826;6594.241662208811;6605.735770569219;6613.834654133685;7063.505554611128;7180.246074162243;7184.49708520409;7193.568385896759;7214.96392518034;5432.945670543244;6561.048647946021;6618.271990081087;6630.569013014138;6642.667866606747;3790.3935370340614;3839.1745774658584;3847.4228865669816;3851.287511810324;3855.575886652466;7330.413566914634;7691.115521714963;7709.7301594443925;7712.498687585401;7739.922600774033;7492.550446973199;7530.096388433423;7539.849203015909;7541.283578060075;7573.583452910143;7675.884861727079;7684.500507466997;7686.577238251838;7688.192739762245;7694.384449244159;7277.708891644275;7282.490225684363;7284.49008569395;7286.927130728624;7287.927120728725;6878.27778083294;7117.67970441321;7135.464840137114;7151.928480715334;7228.746993855189;6294.559380843297;7641.669290866339;7744.419168562493;7769.6892124316655;7769.805754856174;3801.5438147422487;4552.863414097583;4598.034412773221;4600.4479462464715;4613.561711637389;6448.677566121582;7258.274172582699;7273.309035641606;7275.672594733355;7277.9272207277245;6530.47756179514;6764.797056088325;7001.614911179934;7024.824379390556;7062.611556364449;6954.79135625932;6979.197392299748;7014;7020;7030.3321184487395;5588.441155884379;6197.504199663926;6335.334789847;6860.279670634512;6868.690908909211;7012.789616311519;7024;7024.789256322319;7034.472414568825;7035.296470352924;6595.571287866273;6610.768623098361;6862.794116176523;6867.416269617139;6885.793426197222 20:36:52 INFO - PROCESS | 1979 | |5;yui.html;696.9512134150609;733.1715161867089;736.9742059027935;740.1414359343163;798.2616080125883;15028.173450460234;15194.620134496643;15209.163496007715;15218.923905380458;15231;12989.74020519589;13516.797248041286;13578.185308881473;13619.795703064461;13640.454381824715;806.2582424169777;854.5001174313019;868.4745728834059;870.8650159225331;873.3842640938124;856.644492535597;867.7526904832124;868.1708967935606;869.0831173112364;871.6077765005741;913.3423934766957;916.6241840845255;916.9821498137062;921.4977837078775;924.4453328003211;899.685110211424;909.9772505687345;911.007002367416;911.867779172023;911.867779172023;677.8983152527111;679.5854528737466;679.7824696097251;680.4114441008542;681.6830173969079;10939.671809845717;13023.413946372437;13057.086003979724;13060.346982650924;13091.14907531017;11338.71653208668;11379.667168230493;11410;11907.16649834512;12070.27578345302;9510.09654082861;9627.759306017406;9634.229261659051;9639.325247232697;9646.565904534313;3408.1820363112924;3452.3613131570487;3463.341965026637;3464.064702530328;3465.081753335368;64008.03987940185;74855.87716184207;84443;84858;86201;9397.060065475387;9495.57269922855;9584.90415095854;9937.900620993698;9956.402615843073;17567;20330.186792528428;20348.880811555508;20373;20376.79623203749;6010;7211.423086153095;7418.814529636802;7426.62866856655;7450.441216908754;4107.0553772631865;4109.938350924738;4120.464339635828;4139.4204811326435;4152.854650087233;3511.9639706286707;3517.718582513393;3542.7165826734313;3547.166415892263;3550.183457804719;636.662568838507;646.5829539946708;650.2944305428568;661.3650895140719;668.6422763821332;496.8708135884696;580.1298052920619;589.131031728206;616.6485103490967;624.2696045626627;7999.524073927202;8089.595520224083;8297.95851020741;8432.114627964098;8521.82956340882;513.3403576404303;575.3010092737344;612.9785457508966;615.5444970721634;619.170311782205;3351.5140304656175;3863.7874916879277;4045.4134150548007;4073.877783666495;4145.0880806222585;94775.52612236894;95679;97264.51367743115;97318;97741;55081;62240.37759622346;81106;81935.18064819394;82913;62908.37091629025;63209.05186422207;63338.09985700437;63377.36622633807;63608.68195658992;8428;8506.574671266535;8547.82904341922;8567.74296771098;8769.38614296993;42824.78587607042;44741.328880066176;49039.75480122577;53249;55171;70597.64701176461;70617;71215;72244.9163262541;72421.6378918102;11060.557577696802;11121.666350009513;11132.587165310782;11220.66338009861;11670.696144163972;11866.288022718665;12047.457864396298;12065.939670301592;12068.698282543006;12292.877071229532;11549;11584.652460426201;11648.242864214139;11679.182457227913;12038.879611204125;11426.94286528562;11499.195056345976;11843.993260572948;12033.411253219696;12295.815562766387;11257.831132533182;11295.3787541686;11390.202685811913;11403.885961140615;11850.407479626158;9474.57364418589;9524.95237523808;9541.904580954102;9974.950125249326;10050.24623153281;8833.558322083998;8992.325575581988;9111.863322050307;9958.103770660675;9971.950140249251 20:36:52 INFO - PROCESS | 1979 | __end_tp_report 20:36:52 INFO - PROCESS | 1979 | __start_cc_report 20:36:52 INFO - PROCESS | 1979 | _x_x_mozilla_cycle_collect,815 20:36:52 INFO - PROCESS | 1979 | __end_cc_report 20:36:52 INFO - PROCESS | 1979 | __startTimestamp1456115812382__endTimestamp 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | ------- Summary: start ------- 20:36:52 INFO - PROCESS | 1979 | Number of tests: 6 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | [#0] dojo.html Cycles:165 Average:5675.64 Median:5855.68 stddev:627.65 (10.7%) stddev-sans-first:603.42 20:36:52 INFO - PROCESS | 1979 | Values: 3389.9 3426.5 3454.7 3478.1 3486.7 5571.6 5616.3 5632.0 5639.5 5658.6 5640.4 5707.9 5709.1 5713.3 5714.0 5125.7 5144.3 5191.4 5193.7 5243.7 5235.6 5235.9 5244.6 5249.4 5250.5 5109.5 5114.0 5117.6 5160.7 5242.7 5143.6 5199.1 5200.8 5206.7 5259.3 4972.8 5039.5 5094.6 5126.2 5175.5 5481.7 5509.5 5533.8 5590.9 5612.4 6136.5 6137.4 6142.0 6158.8 6171.2 6123.8 6154.8 6213.8 6225.0 6227.6 5012.0 5298.1 5301.8 5706.1 5753.4 6186.8 6199.8 6229.8 6230.6 6240.4 5920.3 6038.3 6095.4 6109.5 6130.8 6131.8 6144.7 6168.4 6171.0 6184.5 6059.2 6106.8 6123.5 6143.6 6148.0 5148.2 6044.5 6117.2 6141.1 6205.8 4876.4 4882.4 4882.6 4915.4 4931.0 4319.3 4396.8 4400.2 4408.0 4424.9 5629.3 5695.2 5748.6 5765.7 5830.8 6165.1 6167.6 6187.2 6195.5 6199.5 5543.9 5735.7 5742.7 5757.8 5771.8 5335.4 5381.0 5385.3 5388.9 5437.8 6311.8 6358.1 6362.2 6368.0 6378.0 6114.1 6138.7 6226.3 6235.8 6247.7 6265.2 6289.7 6338.7 6348.1 6353.2 6119.7 6139.7 6151.3 6153.7 6158.4 6116.5 6139.8 6215.7 6224.2 6229.8 6019.2 6046.6 6055.6 6057.7 6100.6 4538.7 5901.2 6002.5 6029.2 6030.6 5676.7 5715.5 5845.3 5855.7 5875.3 5877.1 5940.9 5964.6 6055.3 6131.0 5755.5 5843.8 5865.2 5890.3 5894.5 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | [#1] ext.html Cycles:180 Average:54604.63 Median:38976.61 stddev:107673.63 (276.3%) stddev-sans-first:107898.93 20:36:52 INFO - PROCESS | 1979 | Values: 457.3 459.4 520.4 524.4 570.9 28821.8 36750.3 37236.0 37370.0 37374.9 32317.5 33152.5 39926.0 40069.8 40102.6 9161.1 9528.0 9528.8 9534.3 9549.9 9330.2 9478.3 9481.1 9483.0 9625.8 9465.5 9530.4 9538.3 9547.4 9570.7 9544.3 9631.5 9632.4 9640.0 9643.3 9501.9 9619.6 9626.7 9634.9 9637.0 38795.2 39158.0 39220.8 39241.8 39267.8 3103.8 3159.0 3207.6 3379.2 3419.0 27540.6 28536.1 29234.4 29272.0 29310.4 2739.6 2821.5 2844.8 2849.2 2878.4 489363.6 493307.0 497865.0 498772.0 499963.0 43167.1 43810.0 43836.0 44071.3 63390.7 43002.4 43088.0 43242.4 43252.1 43345.3 12993.9 15184.1 15463.1 15463.1 15539.9 12358.8 12415.4 12422.0 12432.9 12616.7 14106.6 14109.7 14141.4 14199.8 14206.0 6123.7 6168.9 6205.9 6213.1 6213.5 916.8 1010.1 1019.1 1038.2 1045.2 28714.7 28863.0 29106.0 29187.7 29336.0 957.4 1049.5 1085.9 1086.8 1167.4 12207.5 12750.0 13493.1 13502.0 14019.9 281300.0 287581.0 287658.0 287699.0 289445.0 53718.5 54162.5 54200.5 54233.9 54396.6 1271.1 1327.8 1442.2 1450.3 1454.4 26997.0 27950.9 29184.0 31707.8 32108.7 45575.8 52775.5 55132.7 55756.7 55974.4 354772.0 411053.0 422791.0 422836.0 423399.0 42594.6 43047.0 43187.6 43656.1 43775.3 44788.9 44932.0 45114.8 45330.5 46463.0 37081.8 38415.0 39351.8 39611.6 39614.0 37793.6 38564.4 39486.6 39610.6 39780.0 36024.8 37263.8 37500.0 37513.0 37577.0 30290.7 30353.0 31294.6 33383.7 33568.2 22961.8 24656.3 25243.6 25622.5 26318.0 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | [#2] jquery.html Cycles:180 Average:33486.50 Median:374.33 stddev:102195.64 (27301.0%) stddev-sans-first:102452.07 20:36:52 INFO - PROCESS | 1979 | Values: 369.4 374.1 374.5 377.6 378.8 15804.6 16300.9 19442.4 20180.6 20734.6 19279.7 19362.5 19954.8 20023.7 20039.8 5746.4 5799.3 5960.4 5961.6 6000.9 3926.1 4100.3 5835.7 5928.5 6090.3 6050.5 6057.8 6071.7 6085.2 6096.1 5865.5 5978.0 6027.3 6030.7 6054.9 5719.2 5719.3 5733.3 5734.7 5736.0 12783.0 13365.3 13409.9 13427.0 13434.7 1985.6 2047.3 2250.1 2282.4 2349.8 9592.4 9610.6 9763.2 10170.2 10214.6 1681.5 1722.4 1758.7 1797.5 1805.3 83524.0 99266.5 105323.0 105654.0 107713.6 9008.4 9066.7 11037.0 11159.7 11218.6 13514.7 13565.5 13570.7 13570.9 13601.3 8140.6 8292.8 8293.1 8351.5 8365.0 8398.3 8400.3 8407.7 8474.2 8485.5 4390.3 4460.7 4509.2 4516.5 4521.8 1738.6 1810.7 1835.8 1840.1 1873.9 375.7 892.6 954.7 965.4 994.3 9818.7 11527.4 11527.8 11566.7 11647.2 412.9 461.4 896.9 954.2 973.8 9890.8 10175.8 10211.4 10671.1 10684.5 606600.0 612733.0 612983.0 624176.0 630574.0 107334.5 109482.2 110682.3 111630.4 112418.4 1010.2 1019.1 1025.7 1027.5 1048.3 12799.7 17395.3 17611.5 17931.6 17944.2 48623.0 49992.5 50386.0 50396.5 50709.5 48043.8 71145.6 77370.0 78249.2 81168.3 8109.1 8221.5 8222.9 8296.2 8303.9 10991.8 12932.7 13147.8 13378.9 13500.9 11211.4 11652.0 11665.2 11675.9 11702.1 11188.3 11440.1 11495.6 11817.6 12006.9 9755.5 10832.4 11872.7 11977.1 12011.0 8110.6 8241.2 8241.7 8291.4 8317.8 8471.3 10200.6 10290.8 11104.4 11115.6 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | [#3] mootools.html Cycles:180 Average:5984.44 Median:519.06 stddev:3180.22 (612.7%) stddev-sans-first:3170.57 20:36:52 INFO - PROCESS | 1979 | Values: 1412.0 1536.7 1552.6 1756.1 1899.7 7816.9 8473.2 8649.5 8663.4 8670.7 8288.8 8529.5 8532.9 8544.4 8544.6 2150.1 2416.3 2433.4 2460.1 2463.8 2451.2 2474.9 2476.2 2481.2 2481.5 2426.1 2447.1 2449.3 2449.8 2450.3 2175.3 2410.0 2450.1 2451.8 2454.6 1974.2 2384.5 2404.8 2411.0 2413.4 8583.0 8619.8 8669.3 8673.7 8683.6 5220.1 5308.4 5362.9 5369.5 5420.5 3137.2 3627.1 3704.4 3745.3 3760.9 919.0 972.2 1072.4 1084.0 1092.9 11637.1 11713.9 11715.5 11724.8 11738.9 4775.5 4878.5 4901.8 4954.1 4957.5 10063.7 10069.1 10083.1 10090.6 10093.4 4961.0 5406.0 5424.2 5439.6 5452.8 4067.4 4460.2 4816.3 4883.9 4891.4 3938.7 3955.5 3961.6 3995.1 4016.9 1210.1 1248.5 1304.1 1317.8 1322.4 1069.3 1081.9 1113.8 1365.3 1376.6 8098.9 8153.4 8207.9 8208.8 8220.9 514.4 516.9 516.9 521.2 530.1 6174.4 6210.7 6257.7 6271.3 6272.3 10161.7 10491.7 10534.8 10606.6 10630.2 10201.5 10348.7 10472.1 10477.6 10495.6 8123.4 8317.4 8376.3 8380.7 8403.1 8051.3 8077.9 8091.7 8136.4 8195.5 8388.7 8860.9 9348.6 9525.9 9666.0 9767.6 10022.1 10032.2 10159.9 10164.2 6475.4 6855.4 6902.3 7555.3 7620.0 8163.9 8164.0 8192.2 8206.8 8213.2 7272.5 7355.4 7365.4 7499.9 7542.5 7204.0 7309.6 7324.0 7365.5 7578.8 7635.7 7653.8 7687.0 7697.2 7701.8 6871.2 6928.6 6944.8 7002.1 7017.6 7020.7 7022.9 7061.0 7085.7 7100.3 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | [#4] prototype.html Cycles:180 Average:5685.23 Median:6543.61 stddev:1847.85 (28.2%) stddev-sans-first:1807.64 20:36:52 INFO - PROCESS | 1979 | Values: 262.3 327.9 333.0 334.1 340.2 6413.1 6556.7 6574.3 6622.3 6644.3 6496.6 6583.7 6597.4 6599.1 6616.3 4159.8 4628.0 4662.7 4808.7 4825.8 4613.6 4668.1 4694.4 4731.8 4738.2 4655.6 4732.1 4742.1 4755.9 4758.5 4723.7 4741.1 4743.8 4760.4 4770.2 3854.2 3941.9 4028.1 4028.3 4032.4 6147.1 6188.6 6200.9 6232.3 6244.0 4784.4 5280.7 5502.8 5518.9 5521.6 5832.9 6743.5 6905.8 6941.5 6942.2 4453.7 4455.5 4464.4 4464.8 4471.3 6985.5 7335.2 7379.0 7395.6 7397.6 4520.8 4558.3 4564.8 4566.1 4573.8 4629.2 4638.8 4641.5 4642.5 4652.6 5470.3 5485.6 5491.9 5513.0 5515.4 6736.4 6983.4 6987.9 7003.8 7006.8 1580.2 1603.2 1623.7 1627.5 1627.8 1021.4 1029.1 1039.3 1045.4 1050.9 6403.1 6567.5 6594.2 6605.7 6613.8 7063.5 7180.2 7184.5 7193.6 7215.0 5432.9 6561.0 6618.3 6630.6 6642.7 3790.4 3839.2 3847.4 3851.3 3855.6 7330.4 7691.1 7709.7 7712.5 7739.9 7492.6 7530.1 7539.8 7541.3 7573.6 7675.9 7684.5 7686.6 7688.2 7694.4 7277.7 7282.5 7284.5 7286.9 7287.9 6878.3 7117.7 7135.5 7151.9 7228.7 6294.6 7641.7 7744.4 7769.7 7769.8 3801.5 4552.9 4598.0 4600.4 4613.6 6448.7 7258.3 7273.3 7275.7 7277.9 6530.5 6764.8 7001.6 7024.8 7062.6 6954.8 6979.2 7014.0 7020.0 7030.3 5588.4 6197.5 6335.3 6860.3 6868.7 7012.8 7024.0 7024.8 7034.5 7035.3 6595.6 6610.8 6862.8 6867.4 6885.8 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - PROCESS | 1979 | [#5] yui.html Cycles:180 Average:17968.66 Median:63273.58 stddev:25534.62 (40.4%) stddev-sans-first:25573.32 20:36:52 INFO - PROCESS | 1979 | Values: 697.0 733.2 737.0 740.1 798.3 15028.2 15194.6 15209.2 15218.9 15231.0 12989.7 13516.8 13578.2 13619.8 13640.5 806.3 854.5 868.5 870.9 873.4 856.6 867.8 868.2 869.1 871.6 913.3 916.6 917.0 921.5 924.4 899.7 910.0 911.0 911.9 911.9 677.9 679.6 679.8 680.4 681.7 10939.7 13023.4 13057.1 13060.3 13091.1 11338.7 11379.7 11410.0 11907.2 12070.3 9510.1 9627.8 9634.2 9639.3 9646.6 3408.2 3452.4 3463.3 3464.1 3465.1 64008.0 74855.9 84443.0 84858.0 86201.0 9397.1 9495.6 9584.9 9937.9 9956.4 17567.0 20330.2 20348.9 20373.0 20376.8 6010.0 7211.4 7418.8 7426.6 7450.4 4107.1 4109.9 4120.5 4139.4 4152.9 3512.0 3517.7 3542.7 3547.2 3550.2 636.7 646.6 650.3 661.4 668.6 496.9 580.1 589.1 616.6 624.3 7999.5 8089.6 8298.0 8432.1 8521.8 513.3 575.3 613.0 615.5 619.2 3351.5 3863.8 4045.4 4073.9 4145.1 94775.5 95679.0 97264.5 97318.0 97741.0 55081.0 62240.4 81106.0 81935.2 82913.0 62908.4 63209.1 63338.1 63377.4 63608.7 8428.0 8506.6 8547.8 8567.7 8769.4 42824.8 44741.3 49039.8 53249.0 55171.0 70597.6 70617.0 71215.0 72244.9 72421.6 11060.6 11121.7 11132.6 11220.7 11670.7 11866.3 12047.5 12065.9 12068.7 12292.9 11549.0 11584.7 11648.2 11679.2 12038.9 11426.9 11499.2 11844.0 12033.4 12295.8 11257.8 11295.4 11390.2 11403.9 11850.4 9474.6 9525.0 9541.9 9975.0 10050.2 8833.6 8992.3 9111.9 9958.1 9972.0 20:36:52 INFO - PROCESS | 1979 | -------- Summary: end -------- 20:36:52 INFO - PROCESS | 1979 | 20:36:52 INFO - TEST-INFO | 1979: exit 0 20:36:52 INFO - TEST-OK | dromaeo_css | took 1113911ms 20:36:52 INFO - TEST-START | kraken 20:36:52 INFO - operating with platform_type : mac_ 20:36:52 INFO - Initialising browser for kraken test... 20:36:52 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmp3Ff4Rq/profile http://localhost:49610/getInfo.html) 20:36:55 INFO - PROCESS | 1983 | __metrics Screen width/height:1600/1200 20:36:55 INFO - PROCESS | 1983 | colorDepth:24 20:36:55 INFO - PROCESS | 1983 | Browser inner width/height: 1024/689 20:36:55 INFO - PROCESS | 1983 | __metrics 20:36:55 INFO - PROCESS | 1983 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:36:55 INFO - PROCESS | 1983 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:36:55 INFO - TEST-INFO | 1983: exit 0 20:36:55 INFO - Browser initialized. 20:36:55 INFO - Running cycle 1/1 for kraken test... 20:36:55 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmp3Ff4Rq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:07 INFO - PROCESS | 1985 | RSS: Main: 244449280 20:37:07 INFO - PROCESS | 1985 | 20:37:10 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49610/tests/kraken/driver.html?testName=audio-beat-detection) 20:37:10 INFO - PROCESS | 1985 | RSS: Main: 290148352 20:37:10 INFO - PROCESS | 1985 | 20:37:13 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49610/tests/kraken/driver.html?testName=audio-dft) 20:37:13 INFO - PROCESS | 1985 | RSS: Main: 300437504 20:37:13 INFO - PROCESS | 1985 | 20:37:17 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49610/tests/kraken/driver.html?testName=audio-fft) 20:37:18 INFO - PROCESS | 1985 | RSS: Main: 285380608 20:37:18 INFO - PROCESS | 1985 | 20:37:20 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49610/tests/kraken/driver.html?testName=audio-oscillator) 20:37:20 INFO - PROCESS | 1985 | RSS: Main: 286564352 20:37:20 INFO - PROCESS | 1985 | 20:37:22 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49610/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:37:23 INFO - PROCESS | 1985 | RSS: Main: 287477760 20:37:23 INFO - PROCESS | 1985 | 20:37:26 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49610/tests/kraken/driver.html?testName=imaging-darkroom) 20:37:26 INFO - PROCESS | 1985 | RSS: Main: 288362496 20:37:26 INFO - PROCESS | 1985 | 20:37:29 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49610/tests/kraken/driver.html?testName=imaging-desaturate) 20:37:30 INFO - PROCESS | 1985 | RSS: Main: 289312768 20:37:30 INFO - PROCESS | 1985 | 20:37:32 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49610/tests/kraken/driver.html?testName=json-parse-financial) 20:37:33 INFO - PROCESS | 1985 | RSS: Main: 289775616 20:37:33 INFO - PROCESS | 1985 | 20:37:35 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49610/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:37:35 INFO - PROCESS | 1985 | RSS: Main: 325185536 20:37:35 INFO - PROCESS | 1985 | 20:37:37 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:37:38 INFO - PROCESS | 1985 | RSS: Main: 323059712 20:37:38 INFO - PROCESS | 1985 | 20:37:40 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:37:40 INFO - PROCESS | 1985 | RSS: Main: 332623872 20:37:40 INFO - PROCESS | 1985 | 20:37:43 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:37:43 INFO - PROCESS | 1985 | RSS: Main: 334073856 20:37:43 INFO - PROCESS | 1985 | 20:37:46 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:37:47 INFO - PROCESS | 1985 | RSS: Main: 333651968 20:37:47 INFO - PROCESS | 1985 | 20:37:48 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49610/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49610/tests/kraken/driver.html?testName=ai-astar) 20:37:48 INFO - PROCESS | 1985 | RSS: Main: 393707520 20:37:48 INFO - PROCESS | 1985 | 20:37:48 INFO - PROCESS | 1985 | __start_tp_report 20:37:48 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 20:37:48 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 20:37:48 INFO - PROCESS | 1985 | |i|pagename|runs| 20:37:48 INFO - PROCESS | 1985 | |0;ai-astar;110;109;110;111;109;110;115;110;111;112 20:37:48 INFO - PROCESS | 1985 | |1;audio-beat-detection;157;116;142;155;119;140;138;123;187;108 20:37:48 INFO - PROCESS | 1985 | |2;audio-dft;192;185;186;195;255;175;253;260;184;182 20:37:48 INFO - PROCESS | 1985 | |3;audio-fft;76;78;117;103;80;56;62;74;71;54 20:37:48 INFO - PROCESS | 1985 | |4;audio-oscillator;88;95;123;78;78;92;110;78;78;109 20:37:48 INFO - PROCESS | 1985 | |5;imaging-gaussian-blur;84;90;84;90;83;89;83;97;131;117 20:37:48 INFO - PROCESS | 1985 | |6;imaging-darkroom;92;95;93;115;149;93;92;92;93;92 20:37:48 INFO - PROCESS | 1985 | |7;imaging-desaturate;86;87;84;87;87;84;87;87;84;93 20:37:49 INFO - PROCESS | 1985 | |8;json-parse-financial;55;54;54;53;54;56;55;64;52;52 20:37:49 INFO - PROCESS | 1985 | |9;json-stringify-tinderbox;62;68;67;72;71;67;66;67;70;68 20:37:49 INFO - PROCESS | 1985 | |10;stanford-crypto-aes;83;84;83;82;86;99;106;106;84;84 20:37:49 INFO - PROCESS | 1985 | |11;stanford-crypto-ccm;133;128;118;128;126;127;121;125;120;126 20:37:49 INFO - PROCESS | 1985 | |12;stanford-crypto-pbkdf2;141;128;145;167;168;131;141;139;138;138 20:37:49 INFO - PROCESS | 1985 | |13;stanford-crypto-sha256-iterative;67;67;63;65;67;68;66;68;66;66 20:37:49 INFO - PROCESS | 1985 | __end_tp_report 20:37:49 INFO - PROCESS | 1985 | __start_cc_report 20:37:49 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,1127 20:37:49 INFO - PROCESS | 1985 | __end_cc_report 20:37:49 INFO - PROCESS | 1985 | __startTimestamp1456115868990__endTimestamp 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | ------- Summary: start ------- 20:37:49 INFO - PROCESS | 1985 | Number of tests: 14 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:1.77 (1.6%) stddev-sans-first:1.86 20:37:49 INFO - PROCESS | 1985 | Values: 110.0 109.0 110.0 111.0 109.0 110.0 115.0 110.0 111.0 112.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:141.00 stddev:23.66 (16.8%) stddev-sans-first:24.13 20:37:49 INFO - PROCESS | 1985 | Values: 157.0 116.0 142.0 155.0 119.0 140.0 138.0 123.0 187.0 108.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#2] audio-dft Cycles:10 Average:206.70 Median:193.50 stddev:34.48 (17.8%) stddev-sans-first:36.16 20:37:49 INFO - PROCESS | 1985 | Values: 192.0 185.0 186.0 195.0 255.0 175.0 253.0 260.0 184.0 182.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#3] audio-fft Cycles:10 Average:77.10 Median:72.50 stddev:19.80 (27.3%) stddev-sans-first:20.99 20:37:49 INFO - PROCESS | 1985 | Values: 76.0 78.0 117.0 103.0 80.0 56.0 62.0 74.0 71.0 54.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:78.00 stddev:16.24 (20.8%) stddev-sans-first:17.13 20:37:49 INFO - PROCESS | 1985 | Values: 88.0 95.0 123.0 78.0 78.0 92.0 110.0 78.0 78.0 109.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:86.50 stddev:16.33 (18.9%) stddev-sans-first:16.84 20:37:49 INFO - PROCESS | 1985 | Values: 84.0 90.0 84.0 90.0 83.0 89.0 83.0 97.0 131.0 117.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:92.50 stddev:18.41 (19.9%) stddev-sans-first:19.26 20:37:49 INFO - PROCESS | 1985 | Values: 92.0 95.0 93.0 115.0 149.0 93.0 92.0 92.0 93.0 92.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:2.63 (3.0%) stddev-sans-first:2.78 20:37:49 INFO - PROCESS | 1985 | Values: 86.0 87.0 84.0 87.0 87.0 84.0 87.0 87.0 84.0 93.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.45 (6.3%) stddev-sans-first:3.66 20:37:49 INFO - PROCESS | 1985 | Values: 55.0 54.0 54.0 53.0 54.0 56.0 55.0 64.0 52.0 52.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:2.82 (4.1%) stddev-sans-first:2.07 20:37:49 INFO - PROCESS | 1985 | Values: 62.0 68.0 67.0 72.0 71.0 67.0 66.0 67.0 70.0 68.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:84.00 stddev:9.88 (11.8%) stddev-sans-first:10.17 20:37:49 INFO - PROCESS | 1985 | Values: 83.0 84.0 83.0 82.0 86.0 99.0 106.0 106.0 84.0 84.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:4.44 (3.5%) stddev-sans-first:3.71 20:37:49 INFO - PROCESS | 1985 | Values: 133.0 128.0 118.0 128.0 126.0 127.0 121.0 125.0 120.0 126.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:141.00 stddev:13.52 (9.6%) stddev-sans-first:14.30 20:37:49 INFO - PROCESS | 1985 | Values: 141.0 128.0 145.0 167.0 168.0 131.0 141.0 139.0 138.0 138.0 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - PROCESS | 1985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 20:37:49 INFO - PROCESS | 1985 | Values: 67.0 67.0 63.0 65.0 67.0 68.0 66.0 68.0 66.0 66.0 20:37:49 INFO - PROCESS | 1985 | -------- Summary: end -------- 20:37:49 INFO - PROCESS | 1985 | 20:37:49 INFO - TEST-INFO | 1985: exit 0 20:37:49 INFO - TEST-OK | kraken | took 56950ms 20:37:49 INFO - SUITE-END | took 1170s 20:37:50 INFO - Completed test suite (00:19:31) 20:37:50 INFO - Working with test: dromaeo_css 20:37:50 INFO - Generating results file: dromaeo_css 20:37:50 INFO - Working with test: kraken 20:37:50 INFO - Generating results file: kraken 20:37:50 INFO - javascript benchmark 20:37:50 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:37:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 20:37:50 INFO - process_Request line: dromaeo_css 7313.12 graph.html#tests=[[72,64,59]] 20:37:50 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:37:50 INFO - process_Request line: kraken 1455.40 graph.html#tests=[[232,64,59]] 20:37:50 INFO - RETURN: dromaeo_css: 7313.12 20:37:50 INFO - RETURN: kraken: 1455.40 20:37:50 INFO - javascript benchmark 20:37:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3389.932201355973, 3426.503157042229, 3454.7236221102316, 3478.06092355064, 3486.651334866512, 5571.609987300891, 5616.3260408751, 5632.0, 5639.520640745536, 5658.6038977271555, 5640.351359593648, 5707.857303567413, 5709.0580054290995, 5713.285839270091, 5714.028615135427, 5125.743712814363, 5144.305518754976, 5191.377034755835, 5193.662411943231, 5243.6853788772605, 5235.55497782689, 5235.895282094356, 5244.606654500909, 5249.42256351801, 5250.501202385767, 5109.514596113363, 5114.028334616411, 5117.5650069744115, 5160.716160611165, 5242.737863106849, 5143.562797162245, 5199.090159222121, 5200.817971371002, 5206.713630750307, 5259.342582177228, 4972.801087956477, 5039.546440820343, 5094.566961808251, 5126.2054381570915, 5175.508326708957, 5481.671099733989, 5509.47659972306, 5533.806316778933, 5590.86022849432, 5612.410696876851, 6136.509079273647, 6137.447629713302, 6142.0, 6158.815235542941, 6171.197744293258, 6123.8162855114415, 6154.78458253959, 6213.782517611862, 6224.9688751556405, 6227.564070515065, 5011.972545628138, 5298.125809241432, 5301.761420735999, 5706.087026075849, 5753.424657534297, 6186.752529898844, 6199.845003874939, 6229.813105606749, 6230.563860529719, 6240.4071613196675, 5920.348761636216, 6038.275406951194, 6095.359987201368, 6109.541784366191, 6130.754769809247, 6131.816045518642, 6144.692765361714, 6168.414000669929, 6170.969145154246, 6184.5052395808225, 6059.21230240066, 6106.847328816815, 6123.540734444934, 6143.56995010354, 6147.96926015376, 5148.2020286855595, 6044.516438684895, 6117.188044311343, 6141.109539116803, 6205.751769929243, 4876.390451193601, 4882.414110306786, 4882.5605695487575, 4915.4347250065985, 4931.038447502774, 4319.265724826787, 4396.802143903532, 4400.22995975703, 4407.977960110179, 4424.867253982386, 5629.296337957755, 5695.231143795618, 5748.597598168171, 5765.740541675551, 5830.76676932918, 6165.075238714139, 6167.629942203482, 6187.195664563578, 6195.535334849904, 6199.504039676815, 5543.944560554342, 5735.7418916148035, 5742.7415766290615, 5757.798477053283, 5771.769129234867, 5335.386430560535, 5381.0, 5385.3268341457315, 5388.865278368072, 5437.8368648940595, 6311.842203944938, 6358.1416508771645, 6362.204724409449, 6367.968160159169, 6378.011408231731, 6114.144019837137, 6138.664296166039, 6226.25284965807, 6235.812925612239, 6247.656378899204, 6265.216847894013, 6289.685515724287, 6338.746450141943, 6348.143000694847, 6353.237611486651, 6119.694015299307, 6139.662318572521, 6151.323354431099, 6153.6923153841235, 6158.3841615838055, 6116.457510225511, 6139.754409823557, 6215.65813880241, 6224.190855188796, 6229.781957631461, 6019.18740969981, 6046.5767396281835, 6055.576109672281, 6057.697115144313, 6100.633961962297, 4538.72767633943, 5901.203337549376, 6002.489788368038, 6029.246344206974, 6030.577859549965, 5676.68778217202, 5715.542756579547, 5845.298564172326, 5855.677937713466, 5875.294964604275, 5877.089051197071, 5940.910886336622, 5964.612300200473, 6055.273367195965, 6130.969345153246, 5755.53955683536, 5843.7954671587995, 5865.237519122486, 5890.3226128994, 5894.469497745224], "unit": "score", "name": "dojo.html", "value": 5637.354462055125}, {"lowerIsBetter": false, "replicates": [457.26608792887413, 459.35001972209324, 520.3703518742323, 524.4440892653787, 570.8629928817085, 28821.847126114957, 36750.26499470009, 37235.99999999996, 37370.0, 37374.878753637364, 32317.51523727146, 33152.502712459274, 39926.0, 40069.797906062864, 40102.59897401025, 9161.129692679186, 9527.952360238189, 9528.761780955463, 9534.284928630346, 9549.856752148724, 9330.160285574297, 9478.28912831537, 9481.099295566944, 9483.0, 9625.759356016086, 9465.526723663823, 9530.38052526587, 9538.284628652878, 9547.379420337656, 9570.712878613618, 9544.284178686592, 9631.470269135194, 9632.422054676706, 9639.951800241024, 9643.324967252294, 9501.857472137923, 9619.56711947964, 9626.711198664052, 9634.855477167848, 9637.036296370377, 38795.22409551821, 39158.0, 39220.80389598062, 39241.82274531769, 39267.80366098151, 3103.7516998640053, 3158.98420507896, 3207.631122420905, 3379.222778760874, 3418.9658103418897, 27540.586891196646, 28536.14391568256, 29234.415311693647, 29272.0, 29310.413791724048, 2739.561670132789, 2821.4780265650716, 2844.8293102413922, 2849.244950088228, 2878.352370716572, 489363.5531822354, 493307.0, 497865.0, 498772.0, 499963.0, 43167.13665726668, 43810.0, 43836.0, 44071.33892991608, 63390.68304658539, 43002.35496467556, 43088.0, 43242.351364729555, 43252.13495730068, 43345.34981975273, 12993.870061299265, 15184.088954662755, 15463.072215667096, 15463.072215667096, 15539.922300388653, 12358.75282494345, 12415.379231038412, 12422.0, 12432.937835310766, 12616.747665046647, 14106.64733381653, 14109.71780564383, 14141.363638636287, 14199.78700319496, 14206.0, 6123.693815309217, 6168.946371546113, 6205.906911396332, 6213.141954700798, 6213.545649468435, 916.7845556294266, 1010.1361250304201, 1019.1133713669008, 1038.2317085356933, 1045.174312293295, 28714.712852871206, 28862.98979535706, 29106.0, 29187.708122918924, 29336.0, 957.3537861943161, 1049.522467277387, 1085.919510087468, 1086.7554800169898, 1167.3637867362308, 12207.450664720109, 12750.0, 13493.122947008413, 13502.0, 14019.929900350433, 281300.0, 287581.0, 287658.0, 287699.0, 289445.0, 53718.46281537213, 54162.45837541653, 54200.45799541954, 54233.91532169335, 54396.64008399742, 1271.1165739810929, 1327.8406591208923, 1442.1563385419647, 1450.2821103553808, 1454.3528129982267, 26997.0, 27950.86024569864, 29183.97856075027, 31707.841460792548, 32108.678913211505, 45575.77212113918, 52775.47224527859, 55132.72433637806, 55756.72121639366, 55974.4025597437, 354772.0, 411053.0, 422791.0, 422836.0, 423399.0, 42594.57405425906, 43047.0, 43187.56812431836, 43656.126877462906, 43775.343369848844, 44788.88027799331, 44932.0, 45114.77442612897, 45330.54669453263, 46463.0, 37081.81459092687, 38415.03962400962, 39351.80324098361, 39611.60388396079, 39614.0, 37793.62206377901, 38564.421533676454, 39486.605133948295, 39610.603893961845, 39780.0, 36024.81987590045, 37263.813680931424, 37500.0, 37513.0, 37577.0, 30290.69709302967, 30353.0, 31294.591743371147, 33383.66616333806, 33568.16079598029, 22961.770382295963, 24656.333426305817, 25243.621345680196, 25622.48755024852, 26318.0], "unit": "score", "name": "ext.html", "value": 18544.94788899035}, {"lowerIsBetter": false, "replicates": [369.42369902951395, 374.1170836825094, 374.54118704586887, 377.5959723096286, 378.81816727970556, 15804.604884877885, 16300.918495407535, 19442.41672749818, 20180.59638807225, 20734.585308293845, 19279.710804337945, 19362.515937101543, 19954.800451995477, 20023.699644505345, 20039.799602003975, 5746.396628354015, 5799.333076696192, 5960.433758792929, 5961.642301461904, 6000.909986350208, 3926.0773718176206, 4100.261952848486, 5835.679037652927, 5928.525717942554, 6090.269167699882, 6050.546209034318, 6057.787977420791, 6071.66605836681, 6085.2393450818645, 6096.055111457731, 5865.530757539408, 5978.0, 6027.276726792791, 6030.728617212236, 6054.878902421971, 5719.170720245541, 5719.342275638313, 5733.251358335706, 5734.655920644775, 5736.024875771129, 12783.0, 13365.331733413388, 13409.86590134096, 13427.0, 13434.664133396645, 1985.5731017831235, 2047.2527527452373, 2250.0662225176534, 2282.372347604422, 2349.8237632177656, 9592.424454532751, 9610.615575376976, 9763.170130538912, 10170.186385089175, 10214.642487512901, 1681.5123614152003, 1722.4488163787594, 1758.6746451906438, 1797.4585602475902, 1805.3230038735473, 83524.0, 99266.5036674812, 105323.0, 105654.0, 107713.61431928372, 9008.369414140947, 9066.727998160066, 11037.0, 11159.665210043711, 11218.55125794959, 13514.662133446742, 13565.525206617722, 13570.728585428433, 13570.93214533921, 13601.31993400326, 8140.552269625109, 8292.792680183044, 8293.129221431664, 8351.498910065415, 8364.958175209085, 8398.328133749286, 8400.285975692012, 8407.663693452316, 8474.1949514796, 8485.533295668798, 4390.275604525282, 4460.710053846489, 4509.188346097669, 4516.458025037016, 4521.84173553924, 1738.5566680496393, 1810.6650269700147, 1835.7980622131554, 1840.07996001999, 1873.8756745952592, 375.6938095452198, 892.5537231384308, 954.71358592422, 965.35803690545, 994.3487016004528, 9818.65634702782, 11527.423628818526, 11527.76944461123, 11566.65300041, 11647.242929209575, 412.8720096769951, 461.42322097378275, 896.9013408525057, 954.2175416158683, 973.7662960889336, 9890.802183956424, 10175.796484070277, 10211.438370889673, 10671.146308295472, 10684.465776711133, 606600.0, 612733.0, 612983.0, 624176.0, 630574.0, 107334.46332768287, 109482.24142068616, 110682.33976490359, 111630.44184779187, 112418.43790780994, 1010.2170817616259, 1019.108280254777, 1025.7128004158847, 1027.5324727249083, 1048.3290693956026, 12799.680007999503, 17395.304187832346, 17611.471655850346, 17931.641367172324, 17944.19251133676, 48623.0275394483, 49992.50007499878, 50386.0, 50396.49603503918, 50709.49290507195, 48043.75978120087, 71145.6442717783, 77370.0, 78249.2175078242, 81168.34742436722, 8109.10799812032, 8221.465604735673, 8222.917770822454, 8296.211859873303, 8303.916960830556, 10991.780164396507, 12932.741345173232, 13147.802782958455, 13378.86621133815, 13500.93249533746, 11211.383373914514, 11652.009579185526, 11665.24175928562, 11675.941620291844, 11702.122340824642, 11188.272762270426, 11440.053583389215, 11495.597654082067, 11817.645470635895, 12006.939965300118, 9755.463449510062, 10832.404217768099, 11872.703182420508, 11977.101717371057, 12011.0, 8110.553919534483, 8241.175882411711, 8241.670333186605, 8291.41960062814, 8317.750467485985, 8471.322294216325, 10200.571919931364, 10290.794184116425, 11104.389258590854, 11115.610953616584], "unit": "score", "name": "jquery.html", "value": 8883.49704925417}, {"lowerIsBetter": false, "replicates": [1412.0327575610713, 1536.7080254751593, 1552.565281721118, 1756.1394916490915, 1899.7150427435893, 7816.921830781691, 8473.152684731524, 8649.524276164808, 8663.436876603017, 8670.696525621604, 8288.792780180498, 8529.530875801844, 8532.8720069199, 8544.401891867572, 8544.572771361423, 2150.139944022396, 2416.32342943976, 2433.440308728989, 2460.052879641342, 2463.75362463754, 2451.166603354859, 2474.9010039598393, 2476.232367965927, 2481.2308184462872, 2481.491294284667, 2426.1265944260053, 2447.1312683997194, 2449.2774631483753, 2449.80401567875, 2450.2894160693377, 2175.260411460103, 2409.9999999999914, 2450.142450142436, 2451.754824517534, 2454.607262837955, 1974.2399176317222, 2384.511175209078, 2404.8436851604765, 2410.9879450602634, 2413.3604594782396, 8582.957085214597, 8619.827603447897, 8669.349798765117, 8673.739787806377, 8683.609237584324, 5220.138677118271, 5308.389535203462, 5362.892742145174, 5369.543588794957, 5420.512153906128, 3137.247060705437, 3627.093226693327, 3704.407294832814, 3745.250949810049, 3760.8871733848027, 919.0350132360994, 972.1785091597588, 1072.4423299884018, 1083.9973024951967, 1092.8634220410763, 11637.127215458875, 11713.882861171365, 11715.53137874484, 11724.824127638092, 11738.94130529342, 4775.474697783241, 4878.463369029404, 4901.779419926112, 4954.1082605130705, 4957.479464656231, 10063.69808905734, 10069.144122749502, 10083.142932850644, 10090.596376145018, 10093.444860532594, 4961.0, 5405.972970135203, 5424.213489044067, 5439.646422982493, 5452.754626041838, 4067.4102255173425, 4460.241758900995, 4816.253480710496, 4883.853484395474, 4891.413030436371, 3938.665213456888, 3955.5253369595835, 3961.643452089326, 3995.1011022520283, 4016.9196616067516, 1210.1468464732343, 1248.4818800197997, 1304.067591671959, 1317.80232965056, 1322.418136020148, 1069.2889228662852, 1081.8701755789355, 1113.7883802077579, 1365.3105181883284, 1376.5732622886937, 8098.919010809935, 8153.429259951747, 8207.917920820715, 8208.753737387888, 8220.876686849702, 514.3750343332869, 516.9250458683545, 516.94830516948, 521.163532530291, 530.1385248970423, 6174.44430001302, 6210.720517576629, 6257.655828929453, 6271.310155882849, 6272.341404152589, 10161.695149145537, 10491.737706557396, 10534.841977370346, 10606.628767993083, 10630.202734794766, 10201.54093065799, 10348.741281468023, 10472.057514823702, 10477.580896764197, 10495.580176792842, 8123.4313598047565, 8317.376196785266, 8376.288015518627, 8380.664773409238, 8403.117672644406, 8051.315638170587, 8077.919220807952, 8091.676332946617, 8136.430449868452, 8195.508269503849, 8388.699751538521, 8860.867086993829, 9348.579313930753, 9525.857112143462, 9666.0, 9767.609295628095, 10022.098011179029, 10032.247581431568, 10159.898401015895, 10164.186865050926, 6475.352464753675, 6855.4172895304455, 6902.344277293649, 7555.282248186413, 7619.961900190464, 8163.877541836759, 8164.0, 8192.221738934792, 8206.835863282582, 8213.219744124299, 7272.490925635155, 7355.374793142642, 7365.447591430557, 7499.88750168737, 7542.509736867306, 7204.0, 7309.634518273959, 7324.0, 7365.52124111931, 7578.772636820904, 7635.732749353746, 7653.770386888402, 7687.0391201099865, 7697.230276972258, 7701.768946931601, 6871.224498973165, 6928.584284942919, 6944.756933507303, 7002.124734408199, 7017.614031228331, 7020.719171233298, 7022.859542809218, 7060.964695176696, 7085.681144348414, 7100.289971002859], "unit": "score", "name": "mootools.html", "value": 4784.072850639861}, {"lowerIsBetter": false, "replicates": [262.3153569184429, 327.9229381095442, 332.9600447946246, 334.10293362322165, 340.1733786897837, 6413.070104834796, 6556.73773049078, 6574.276829548746, 6622.337766223382, 6644.3023482534245, 6496.577722448038, 6583.67081645917, 6597.406233438989, 6599.142111525507, 6616.305287944769, 4159.771212583307, 4628.0, 4662.696924699901, 4808.663393562443, 4825.7587120644, 4613.561711637406, 4668.089722504113, 4694.3662605548325, 4731.81072757091, 4738.19450693383, 4655.557722016403, 4732.100900828831, 4742.146413645542, 4755.9286610700865, 4758.452777930548, 4723.669343145981, 4741.122892264925, 4743.810247590092, 4760.381150450454, 4770.212914869043, 3854.209886973164, 3941.881743547698, 4028.053407449247, 4028.2547728669997, 4032.4354590357375, 6147.0779383092895, 6188.628682279078, 6200.914839903044, 6232.283287421959, 6244.0321750128805, 4784.378030856001, 5280.683159010433, 5502.752376143083, 5518.862028449281, 5521.613487055908, 5832.862591794602, 6743.460523158135, 6905.75829845953, 6941.479389045841, 6942.2363540011065, 4453.688241823042, 4455.4876189238, 4464.374987501752, 4464.776761161961, 4471.329300604935, 6985.545939513966, 7335.193128755833, 7378.9631051844935, 7395.556266624019, 7397.630118494108, 4520.751358675238, 4558.270676691714, 4564.8402305919135, 4566.132434837436, 4573.794179261941, 4629.166749984967, 4638.79125439356, 4641.489436162019, 4642.512536183652, 4652.55800698933, 5470.316210473691, 5485.588580856452, 5491.862703432446, 5512.972435137879, 5515.365732940683, 6736.427403670645, 6983.406410455066, 6987.930120698829, 7003.824904377431, 7006.789796306119, 1580.2019979910071, 1603.214424931775, 1623.7239669256019, 1627.4873414874278, 1627.804663440371, 1021.3718563083798, 1029.0686928329724, 1039.2517387481003, 1045.4041196517912, 1050.9211809114347, 6403.135576697179, 6567.474602031826, 6594.241662208811, 6605.735770569219, 6613.834654133685, 7063.505554611128, 7180.246074162243, 7184.49708520409, 7193.568385896759, 7214.96392518034, 5432.945670543244, 6561.048647946021, 6618.271990081087, 6630.569013014138, 6642.667866606747, 3790.3935370340614, 3839.1745774658584, 3847.4228865669816, 3851.287511810324, 3855.575886652466, 7330.413566914634, 7691.115521714963, 7709.7301594443925, 7712.498687585401, 7739.922600774033, 7492.550446973199, 7530.096388433423, 7539.849203015909, 7541.283578060075, 7573.583452910143, 7675.884861727079, 7684.500507466997, 7686.577238251838, 7688.192739762245, 7694.384449244159, 7277.708891644275, 7282.490225684363, 7284.49008569395, 7286.927130728624, 7287.927120728725, 6878.27778083294, 7117.67970441321, 7135.464840137114, 7151.928480715334, 7228.746993855189, 6294.559380843297, 7641.669290866339, 7744.419168562493, 7769.6892124316655, 7769.805754856174, 3801.5438147422487, 4552.863414097583, 4598.034412773221, 4600.4479462464715, 4613.561711637389, 6448.677566121582, 7258.274172582699, 7273.309035641606, 7275.672594733355, 7277.9272207277245, 6530.47756179514, 6764.797056088325, 7001.614911179934, 7024.824379390556, 7062.611556364449, 6954.79135625932, 6979.197392299748, 7014.0, 7020.0, 7030.3321184487395, 5588.441155884379, 6197.504199663926, 6335.334789847, 6860.279670634512, 6868.690908909211, 7012.789616311519, 7024.0, 7024.789256322319, 7034.472414568825, 7035.296470352924, 6595.571287866273, 6610.768623098361, 6862.794116176523, 6867.416269617139, 6885.793426197222], "unit": "score", "name": "prototype.html", "value": 5065.734083498082}, {"lowerIsBetter": false, "replicates": [696.9512134150609, 733.1715161867089, 736.9742059027935, 740.1414359343163, 798.2616080125883, 15028.173450460234, 15194.620134496643, 15209.163496007715, 15218.923905380458, 15231.0, 12989.74020519589, 13516.797248041286, 13578.185308881473, 13619.795703064461, 13640.454381824715, 806.2582424169777, 854.5001174313019, 868.4745728834059, 870.8650159225331, 873.3842640938124, 856.644492535597, 867.7526904832124, 868.1708967935606, 869.0831173112364, 871.6077765005741, 913.3423934766957, 916.6241840845255, 916.9821498137062, 921.4977837078775, 924.4453328003211, 899.685110211424, 909.9772505687345, 911.007002367416, 911.867779172023, 911.867779172023, 677.8983152527111, 679.5854528737466, 679.7824696097251, 680.4114441008542, 681.6830173969079, 10939.671809845717, 13023.413946372437, 13057.086003979724, 13060.346982650924, 13091.14907531017, 11338.71653208668, 11379.667168230493, 11410.0, 11907.16649834512, 12070.27578345302, 9510.09654082861, 9627.759306017406, 9634.229261659051, 9639.325247232697, 9646.565904534313, 3408.1820363112924, 3452.3613131570487, 3463.341965026637, 3464.064702530328, 3465.081753335368, 64008.03987940185, 74855.87716184207, 84443.0, 84858.0, 86201.0, 9397.060065475387, 9495.57269922855, 9584.90415095854, 9937.900620993698, 9956.402615843073, 17567.0, 20330.186792528428, 20348.880811555508, 20373.0, 20376.79623203749, 6010.0, 7211.423086153095, 7418.814529636802, 7426.62866856655, 7450.441216908754, 4107.0553772631865, 4109.938350924738, 4120.464339635828, 4139.4204811326435, 4152.854650087233, 3511.9639706286707, 3517.718582513393, 3542.7165826734313, 3547.166415892263, 3550.183457804719, 636.662568838507, 646.5829539946708, 650.2944305428568, 661.3650895140719, 668.6422763821332, 496.8708135884696, 580.1298052920619, 589.131031728206, 616.6485103490967, 624.2696045626627, 7999.524073927202, 8089.595520224083, 8297.95851020741, 8432.114627964098, 8521.82956340882, 513.3403576404303, 575.3010092737344, 612.9785457508966, 615.5444970721634, 619.170311782205, 3351.5140304656175, 3863.7874916879277, 4045.4134150548007, 4073.877783666495, 4145.0880806222585, 94775.52612236894, 95679.0, 97264.51367743115, 97318.0, 97741.0, 55081.0, 62240.37759622346, 81106.0, 81935.18064819394, 82913.0, 62908.37091629025, 63209.05186422207, 63338.09985700437, 63377.36622633807, 63608.68195658992, 8428.0, 8506.574671266535, 8547.82904341922, 8567.74296771098, 8769.38614296993, 42824.78587607042, 44741.328880066176, 49039.75480122577, 53249.0, 55171.0, 70597.64701176461, 70617.0, 71215.0, 72244.9163262541, 72421.6378918102, 11060.557577696802, 11121.666350009513, 11132.587165310782, 11220.66338009861, 11670.696144163972, 11866.288022718665, 12047.457864396298, 12065.939670301592, 12068.698282543006, 12292.877071229532, 11549.0, 11584.652460426201, 11648.242864214139, 11679.182457227913, 12038.879611204125, 11426.94286528562, 11499.195056345976, 11843.993260572948, 12033.411253219696, 12295.815562766387, 11257.831132533182, 11295.3787541686, 11390.202685811913, 11403.885961140615, 11850.407479626158, 9474.57364418589, 9524.95237523808, 9541.904580954102, 9974.950125249326, 10050.24623153281, 8833.558322083998, 8992.325575581988, 9111.863322050307, 9958.103770660675, 9971.950140249251], "unit": "score", "name": "yui.html", "value": 6796.099465169114}], "name": "dromaeo_css", "value": 7313.125783517299}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 115.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [157.0, 116.0, 142.0, 155.0, 119.0, 140.0, 138.0, 123.0, 187.0, 108.0], "unit": "score", "name": "audio-beat-detection", "value": 138.5}, {"lowerIsBetter": true, "replicates": [192.0, 185.0, 186.0, 195.0, 255.0, 175.0, 253.0, 260.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 206.7}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 117.0, 103.0, 80.0, 56.0, 62.0, 74.0, 71.0, 54.0], "unit": "score", "name": "audio-fft", "value": 77.1}, {"lowerIsBetter": true, "replicates": [88.0, 95.0, 123.0, 78.0, 78.0, 92.0, 110.0, 78.0, 78.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 84.0, 90.0, 83.0, 89.0, 83.0, 97.0, 131.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 93.0, 115.0, 149.0, 93.0, 92.0, 92.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 100.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 84.0, 87.0, 87.0, 84.0, 87.0, 87.0, 84.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 56.0, 55.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 67.0, 72.0, 71.0, 67.0, 66.0, 67.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 82.0, 86.0, 99.0, 106.0, 106.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.7}, {"lowerIsBetter": true, "replicates": [133.0, 128.0, 118.0, 128.0, 126.0, 127.0, 121.0, 125.0, 120.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 145.0, 167.0, 168.0, 131.0, 141.0, 139.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 63.0, 65.0, 67.0, 68.0, 66.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1455.3999999999999}]} 20:37:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1455.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7313.12"}}} 20:37:50 INFO - Return code: 0 20:37:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:37:50 INFO - # TBPL SUCCESS # 20:37:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:37:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:37:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:37:50 INFO - 2016-02-21 20:37:50.720 screenresolution[1989:18869] starting screenresolution argv=screenresolution get 20:37:50 INFO - 2016-02-21 20:37:50.723 screenresolution[1989:18869] Display 0: 1600x1200x32@60 20:37:50 INFO - 2016-02-21 20:37:50.729 screenresolution[1990:18872] starting screenresolution argv=screenresolution list 20:37:50 INFO - Available Modes on Display 0 20:37:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:37:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:37:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:37:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:37:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:37:50 INFO - Intel Iris: 20:37:50 INFO - Chipset Model: Intel Iris 20:37:50 INFO - Type: GPU 20:37:50 INFO - Bus: Built-In 20:37:50 INFO - VRAM (Dynamic, Max): 1536 MB 20:37:50 INFO - Vendor: Intel (0x8086) 20:37:50 INFO - Device ID: 0x0a2e 20:37:50 INFO - Revision ID: 0x0009 20:37:50 INFO - Displays: 20:37:50 INFO - Display: 20:37:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:37:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:37:50 INFO - Display Serial Number: 1600x1200 60 20:37:50 INFO - Main Display: Yes 20:37:50 INFO - Mirror: Off 20:37:50 INFO - Online: Yes 20:37:50 INFO - Rotation: Supported 20:37:50 INFO - Return code: 0 20:37:50 INFO - Running post-action listener: _resource_record_post_action 20:37:50 INFO - Running post-run listener: _resource_record_post_run 20:37:52 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2379776; Write bytes: 710096896; Read time: 35; Write time: 1976 20:37:52 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386638336; Write bytes: 382045184; Read time: 28527; Write time: 742 20:37:52 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2379776; Write bytes: 302590976; Read time: 35; Write time: 1179 20:37:52 INFO - Running post-run listener: _upload_blobber_files 20:37:52 INFO - Blob upload gear active. 20:37:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:37:52 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 20:37:52 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'] 20:37:52 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 20:37:52 INFO - (blobuploader) - INFO - Open directory for files ... 20:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:53 INFO - (blobuploader) - INFO - Done attempting. 20:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:54 INFO - (blobuploader) - INFO - Done attempting. 20:37:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:37:54 INFO - Return code: 0 20:37:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:37:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:37:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cd604a124ef51ab506e0be34b20e903a65e2534dab922ae712ffe4604f1f6029b30012680528842b3efb379809c603a41717292e8376cf069ebf9a6785e4330", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddfeb76b086c433baf3a40b6fcba5a7e5de19c779f12f5b25cc16ca5ad3ed6a2bd7515d89e487571b85a2c7b81f91ccd0667431c414cb34713f5976e41a6cbd"} 20:37:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:37:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:37:54 INFO - Contents: 20:37:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cd604a124ef51ab506e0be34b20e903a65e2534dab922ae712ffe4604f1f6029b30012680528842b3efb379809c603a41717292e8376cf069ebf9a6785e4330", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddfeb76b086c433baf3a40b6fcba5a7e5de19c779f12f5b25cc16ca5ad3ed6a2bd7515d89e487571b85a2c7b81f91ccd0667431c414cb34713f5976e41a6cbd"} 20:37:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:37:54 INFO - Copying logs to upload dir... 20:37:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:37:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.281091 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-21 20:37:54.726150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-21 20:37:54.730018) ========= 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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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/0cd604a124ef51ab506e0be34b20e903a65e2534dab922ae712ffe4604f1f6029b30012680528842b3efb379809c603a41717292e8376cf069ebf9a6785e4330", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddfeb76b086c433baf3a40b6fcba5a7e5de19c779f12f5b25cc16ca5ad3ed6a2bd7515d89e487571b85a2c7b81f91ccd0667431c414cb34713f5976e41a6cbd"} build_url:https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010799 build_url: 'https://queue.taskcluster.net/v1/task/DWY3F7S4SduMPIzdZvExgg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cd604a124ef51ab506e0be34b20e903a65e2534dab922ae712ffe4604f1f6029b30012680528842b3efb379809c603a41717292e8376cf069ebf9a6785e4330", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ddfeb76b086c433baf3a40b6fcba5a7e5de19c779f12f5b25cc16ca5ad3ed6a2bd7515d89e487571b85a2c7b81f91ccd0667431c414cb34713f5976e41a6cbd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-21 20:37:54.760865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:37:54.761187) ========= 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.3mreFqzjrm/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.1VModsug1m/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-21 20:37:54.810440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 20:37:54.810763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-21 20:37:54.811150) ========= ========= Total master_lag: 0.32 =========