builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0055 starttime: 1455673076.07 results: success (0) buildid: 20160216155249 builduid: eb8da95b759440a0b1d8db3b45d7adef revision: 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 17:37:56.071218) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 17:37:56.071640) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 17:37:56.071928) ========= 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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.005694 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 17:37:56.109162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2016-02-16 17:37:56.109486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 8 secs) (at 2016-02-16 17:38:04.955892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-02-16 17:38:04.956263) ========= 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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.006024 ========= master_lag: 4.59 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-02-16 17:38:09.548722) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 17:38:09.549032) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 17:38:09.549390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-16 17:38:09.549693) ========= 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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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-16 17:38:10-- 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% 9.66M=0.001s 2016-02-16 17:38:10 (9.66 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198545 ========= master_lag: 4.85 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-16 17:38:14.597646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-02-16 17:38:14.597958) ========= 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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.027062 ========= master_lag: 8.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-02-16 17:38:22.700835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-16 17:38:22.701222) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b --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 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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-16 17:38:23,344 truncating revision to first 12 chars 2016-02-16 17:38:23,344 Setting DEBUG logging. 2016-02-16 17:38:23,344 attempt 1/10 2016-02-16 17:38:23,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/58d7cfbf806c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 17:38:24,348 unpacking tar archive at: fx-team-58d7cfbf806c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.244761 ========= master_lag: 2.95 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-16 17:38:26.891659) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-02-16 17:38:26.891984) ========= echo 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b program finished with exit code 0 elapsedTime=0.006156 script_repo_revision: '58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b' ========= master_lag: 5.88 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 5 secs) (at 2016-02-16 17:38:32.777399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-02-16 17:38:32.777728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-02-16 17:38:38.008599) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-16 17:38:38.008926) ========= /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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:38:38 INFO - MultiFileLogger online at 20160216 17:38:38 in /builds/slave/test 17:38:38 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 17:38:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:38:38 INFO - {'append_to_log': False, 17:38:38 INFO - 'base_work_dir': '/builds/slave/test', 17:38:38 INFO - 'blob_upload_branch': 'Fx-Team', 17:38:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:38:38 INFO - 'branch': 'Fx-Team', 17:38:38 INFO - 'buildbot_json_path': 'buildprops.json', 17:38:38 INFO - 'config_files': ('talos/mac_config.py',), 17:38:38 INFO - 'default_actions': ('clobber', 17:38:38 INFO - 'read-buildbot-config', 17:38:38 INFO - 'download-and-extract', 17:38:38 INFO - 'populate-webroot', 17:38:38 INFO - 'create-virtualenv', 17:38:38 INFO - 'install', 17:38:38 INFO - 'run-tests'), 17:38:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:38:38 INFO - 'download_minidump_stackwalk': True, 17:38:38 INFO - 'download_symbols': 'ondemand', 17:38:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:38:38 INFO - 'tooltool.py': '/tools/tooltool.py', 17:38:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:38:38 INFO - '/tools/misc-python/virtualenv.py')}, 17:38:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:38:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:38:38 INFO - 'installer_path': 'installer.exe', 17:38:38 INFO - 'log_level': 'info', 17:38:38 INFO - 'log_name': 'talos', 17:38:38 INFO - 'log_to_console': True, 17:38:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:38:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:38:38 INFO - 'opt_config_files': (), 17:38:38 INFO - 'pip_index': False, 17:38:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:38:38 INFO - 'cmd': ('bash', 17:38:38 INFO - '-c', 17:38:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:38:38 INFO - 'enabled': True, 17:38:38 INFO - 'halt_on_failure': False, 17:38:38 INFO - 'name': 'check_screen_resolution'},), 17:38:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:38:38 INFO - 'cmd': ('bash', 17:38:38 INFO - '-c', 17:38:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:38:38 INFO - 'enabled': True, 17:38:38 INFO - 'halt_on_failure': False, 17:38:38 INFO - 'name': 'check_screen_resolution'},), 17:38:38 INFO - 'run_cmd_checks_enabled': True, 17:38:38 INFO - 'sps_profile': False, 17:38:38 INFO - 'sps_profile_interval': 0, 17:38:38 INFO - 'suite': 'dromaeojs', 17:38:38 INFO - 'system_bits': '32', 17:38:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:38:38 INFO - 'title': 't-yosemite-r7-0055', 17:38:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:38:38 INFO - 'use_talos_json': True, 17:38:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:38:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:38:38 INFO - 'work_dir': 'build'} 17:38:38 INFO - ##### 17:38:38 INFO - ##### Running clobber step. 17:38:38 INFO - ##### 17:38:38 INFO - Running pre-action listener: _resource_record_pre_action 17:38:38 INFO - Running main action method: clobber 17:38:38 INFO - rmtree: /builds/slave/test/build 17:38:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:38:40 INFO - Running post-action listener: _resource_record_post_action 17:38:40 INFO - ##### 17:38:40 INFO - ##### Running read-buildbot-config step. 17:38:40 INFO - ##### 17:38:40 INFO - Running pre-action listener: _resource_record_pre_action 17:38:40 INFO - Running main action method: read_buildbot_config 17:38:40 INFO - Using buildbot properties: 17:38:40 INFO - { 17:38:40 INFO - "project": "", 17:38:40 INFO - "product": "firefox", 17:38:40 INFO - "script_repo_revision": "production", 17:38:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:38:40 INFO - "repository": "", 17:38:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:38:40 INFO - "buildid": "20160216155249", 17:38:40 INFO - "pgo_build": "False", 17:38:40 INFO - "basedir": "/builds/slave/test", 17:38:40 INFO - "buildnumber": 369, 17:38:40 INFO - "slavename": "t-yosemite-r7-0055", 17:38:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:38:40 INFO - "platform": "yosemite_r7", 17:38:40 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:38:40 INFO - "branch": "fx-team", 17:38:40 INFO - "repo_path": "integration/fx-team", 17:38:40 INFO - "revision": "58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b", 17:38:40 INFO - "stage_platform": "macosx64", 17:38:40 INFO - "builduid": "eb8da95b759440a0b1d8db3b45d7adef", 17:38:40 INFO - "slavebuilddir": "test" 17:38:40 INFO - } 17:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:38:40 INFO - Running post-action listener: _resource_record_post_action 17:38:40 INFO - ##### 17:38:40 INFO - ##### Running download-and-extract step. 17:38:40 INFO - ##### 17:38:40 INFO - Running pre-action listener: _resource_record_pre_action 17:38:40 INFO - Running main action method: download_and_extract 17:38:40 INFO - mkdir: /builds/slave/test/build/tests 17:38:40 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')]} 17:38:40 INFO - https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/test_packages.json 17:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/test_packages.json 17:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:38:41 INFO - Downloaded 1277 bytes. 17:38:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:38:41 INFO - Using the following test package requirements: 17:38:41 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:38:41 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:38:41 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:38:41 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'jsshell-mac.zip'], 17:38:41 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:38:41 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:38:41 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:38:41 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:38:41 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:38:41 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:38:41 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:38:41 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:38:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:41 INFO - https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:42 INFO - Downloaded 17803642 bytes. 17:38:42 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'] 17:38:42 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 17:38:45 INFO - Return code: 0 17:38:45 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 17:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:45 INFO - https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:47 INFO - Downloaded 17803642 bytes. 17:38:47 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'] 17:38:47 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 17:38:50 INFO - Return code: 0 17:38:50 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')]} 17:38:50 INFO - https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:51 INFO - Downloaded 10707071 bytes. 17:38:51 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'] 17:38:51 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 17:38:51 INFO - Return code: 0 17:38:51 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')]} 17:38:51 INFO - https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:38:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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 17:38:55 INFO - Downloaded 111187589 bytes. 17:38:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:55 INFO - mkdir: /builds/slave/test/properties 17:38:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:55 INFO - Contents: 17:38:55 INFO - build_url:https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:38:56 INFO - Running post-action listener: _resource_record_post_action 17:38:56 INFO - Running post-action listener: set_extra_try_arguments 17:38:56 INFO - ##### 17:38:56 INFO - ##### Running populate-webroot step. 17:38:56 INFO - ##### 17:38:56 INFO - Running pre-action listener: _resource_record_pre_action 17:38:56 INFO - Running main action method: populate_webroot 17:38:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:56 INFO - '--tppagecycles', 17:38:56 INFO - '7'], 17:38:56 INFO - 'tests': ['tsvgm']}}, 17:38:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:38:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:38:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'tests': ['damp', 'tps']}, 17:38:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['damp', 'tps']}, 17:38:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:38:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:56 INFO - 'other': {'tests': ['a11yr', 17:38:56 INFO - 'ts_paint', 17:38:56 INFO - 'tpaint', 17:38:56 INFO - 'sessionrestore', 17:38:56 INFO - 'sessionrestore_no_auto_restore']}, 17:38:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['a11yr', 17:38:56 INFO - 'ts_paint', 17:38:56 INFO - 'tpaint', 17:38:56 INFO - 'sessionrestore', 17:38:56 INFO - 'sessionrestore_no_auto_restore']}, 17:38:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['a11yr', 17:38:56 INFO - 'ts_paint', 17:38:56 INFO - 'tpaint', 17:38:56 INFO - 'sessionrestore', 17:38:56 INFO - 'sessionrestore_no_auto_restore']}, 17:38:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['a11yr', 17:38:56 INFO - 'ts_paint', 17:38:56 INFO - 'tpaint', 17:38:56 INFO - 'sessionrestore', 17:38:56 INFO - 'sessionrestore_no_auto_restore']}, 17:38:56 INFO - 'other_l64': {'tests': ['a11yr', 17:38:56 INFO - 'ts_paint', 17:38:56 INFO - 'tpaint', 17:38:56 INFO - 'sessionrestore', 17:38:56 INFO - 'sessionrestore_no_auto_restore']}, 17:38:56 INFO - 'other_nol64': {'tests': ['a11yr', 17:38:56 INFO - 'ts_paint', 17:38:56 INFO - 'tpaint', 17:38:56 INFO - 'sessionrestore', 17:38:56 INFO - 'sessionrestore_no_auto_restore']}, 17:38:56 INFO - 'svgr': {'tests': ['tsvgx', 17:38:56 INFO - 'tsvgr_opacity', 17:38:56 INFO - 'tart', 17:38:56 INFO - 'tscrollx', 17:38:56 INFO - 'cart']}, 17:38:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['tsvgx', 17:38:56 INFO - 'tsvgr_opacity', 17:38:56 INFO - 'tart', 17:38:56 INFO - 'tscrollx', 17:38:56 INFO - 'cart']}, 17:38:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'tests': ['tp5o']}, 17:38:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'talos_options': ['--e10s'], 17:38:56 INFO - 'tests': ['tp5o']}, 17:38:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'talos_options': ['--xperf_path', 17:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:56 INFO - 'tests': ['tp5n']}, 17:38:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:56 INFO - 'talos_options': ['--e10s', 17:38:56 INFO - '--xperf_path', 17:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:56 INFO - 'tests': ['tp5n']}}, 17:38:56 INFO - 'talos.zip': {'path': '', 17:38:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:56 INFO - Running post-action listener: _resource_record_post_action 17:38:56 INFO - ##### 17:38:56 INFO - ##### Running create-virtualenv step. 17:38:56 INFO - ##### 17:38:56 INFO - Running pre-action listener: _resource_record_pre_action 17:38:56 INFO - Running main action method: create_virtualenv 17:38:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:38:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:56 INFO - Using real prefix '/tools/python27' 17:38:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:39:00 INFO - Installing pip.................done. 17:39:00 INFO - Return code: 0 17:39:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:00 INFO - 'HOME': '/Users/cltbld', 17:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:00 INFO - 'LOGNAME': 'cltbld', 17:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:00 INFO - 'MOZ_NO_REMOTE': '1', 17:39:00 INFO - 'NO_EM_RESTART': '1', 17:39:00 INFO - 'PAGER': '/bin/cat', 17:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:00 INFO - 'PWD': '/builds/slave/test', 17:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:00 INFO - 'SHELL': '/bin/bash', 17:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:00 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:00 INFO - 'USER': 'cltbld', 17:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:00 INFO - 'XPC_FLAGS': '0x0', 17:39:00 INFO - 'XPC_SERVICE_NAME': '0', 17:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:39:00 INFO - Cleaning up... 17:39:00 INFO - Return code: 0 17:39:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:00 INFO - 'HOME': '/Users/cltbld', 17:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:00 INFO - 'LOGNAME': 'cltbld', 17:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:00 INFO - 'MOZ_NO_REMOTE': '1', 17:39:00 INFO - 'NO_EM_RESTART': '1', 17:39:00 INFO - 'PAGER': '/bin/cat', 17:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:00 INFO - 'PWD': '/builds/slave/test', 17:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:00 INFO - 'SHELL': '/bin/bash', 17:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:00 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:00 INFO - 'USER': 'cltbld', 17:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:00 INFO - 'XPC_FLAGS': '0x0', 17:39:00 INFO - 'XPC_SERVICE_NAME': '0', 17:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:00 INFO - Downloading/unpacking psutil>=0.7.1 17:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:39:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:03 INFO - Installing collected packages: psutil 17:39:03 INFO - Running setup.py install for psutil 17:39:03 INFO - building 'psutil._psutil_osx' extension 17:39:03 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 INFO - building 'psutil._psutil_posix' extension 17:39:04 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 17:39:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:39:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:39:04 INFO - ^ 17:39:04 INFO - 1 warning generated. 17:39:04 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 17:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:04 INFO - Successfully installed psutil 17:39:04 INFO - Cleaning up... 17:39:04 INFO - Return code: 0 17:39:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:04 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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:04 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 17:39:04 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 17:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:04 INFO - 'HOME': '/Users/cltbld', 17:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:04 INFO - 'LOGNAME': 'cltbld', 17:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:04 INFO - 'MOZ_NO_REMOTE': '1', 17:39:04 INFO - 'NO_EM_RESTART': '1', 17:39:04 INFO - 'PAGER': '/bin/cat', 17:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:04 INFO - 'PWD': '/builds/slave/test', 17:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:04 INFO - 'SHELL': '/bin/bash', 17:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:04 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:04 INFO - 'USER': 'cltbld', 17:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:04 INFO - 'XPC_FLAGS': '0x0', 17:39:04 INFO - 'XPC_SERVICE_NAME': '0', 17:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:39:05 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 17:39:05 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 17:39:05 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 17:39:05 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 17:39:05 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 17:39:05 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 17:39:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:39:07 INFO - Installing collected packages: mozsystemmonitor 17:39:07 INFO - Running setup.py install for mozsystemmonitor 17:39:07 INFO - Successfully installed mozsystemmonitor 17:39:07 INFO - Cleaning up... 17:39:07 INFO - Return code: 0 17:39:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:07 INFO - 'HOME': '/Users/cltbld', 17:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:07 INFO - 'LOGNAME': 'cltbld', 17:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:07 INFO - 'MOZ_NO_REMOTE': '1', 17:39:07 INFO - 'NO_EM_RESTART': '1', 17:39:07 INFO - 'PAGER': '/bin/cat', 17:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:07 INFO - 'PWD': '/builds/slave/test', 17:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:07 INFO - 'SHELL': '/bin/bash', 17:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:07 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:07 INFO - 'USER': 'cltbld', 17:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:07 INFO - 'XPC_FLAGS': '0x0', 17:39:07 INFO - 'XPC_SERVICE_NAME': '0', 17:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:10 INFO - Downloading blobuploader-1.2.4.tar.gz 17:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:39:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:39:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:11 INFO - Downloading docopt-0.6.1.tar.gz 17:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:39:11 INFO - Installing collected packages: blobuploader, requests, docopt 17:39:11 INFO - Running setup.py install for blobuploader 17:39:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:39:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:39:11 INFO - Running setup.py install for requests 17:39:12 INFO - Running setup.py install for docopt 17:39:12 INFO - Successfully installed blobuploader requests docopt 17:39:12 INFO - Cleaning up... 17:39:12 INFO - Return code: 0 17:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:12 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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:12 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 17:39:12 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 17:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:12 INFO - 'HOME': '/Users/cltbld', 17:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:12 INFO - 'LOGNAME': 'cltbld', 17:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:12 INFO - 'MOZ_NO_REMOTE': '1', 17:39:12 INFO - 'NO_EM_RESTART': '1', 17:39:12 INFO - 'PAGER': '/bin/cat', 17:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:12 INFO - 'PWD': '/builds/slave/test', 17:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:12 INFO - 'SHELL': '/bin/bash', 17:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:12 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:12 INFO - 'USER': 'cltbld', 17:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:12 INFO - 'XPC_FLAGS': '0x0', 17:39:12 INFO - 'XPC_SERVICE_NAME': '0', 17:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:12 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-XqMEXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:12 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-kzyjI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:12 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-mMWVEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:12 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-kJVnCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Eqtq4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-_flr9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-KW7XJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-l_wqYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-vQc6ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-L97bL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-IYVyH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-0LoE1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Il6qxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:13 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-JAVM5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-GLU1KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-idf7rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:14 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-0v5ZZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:14 INFO - Running setup.py install for manifestparser 17:39:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:14 INFO - Running setup.py install for mozcrash 17:39:14 INFO - Running setup.py install for mozdebug 17:39:14 INFO - Running setup.py install for mozdevice 17:39:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:39:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:14 INFO - Running setup.py install for mozfile 17:39:15 INFO - Running setup.py install for mozhttpd 17:39:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Running setup.py install for mozinfo 17:39:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Running setup.py install for mozInstall 17:39:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Running setup.py install for mozleak 17:39:15 INFO - Running setup.py install for mozlog 17:39:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Running setup.py install for moznetwork 17:39:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:15 INFO - Running setup.py install for mozprocess 17:39:16 INFO - Running setup.py install for mozprofile 17:39:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:16 INFO - Running setup.py install for mozrunner 17:39:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:16 INFO - Running setup.py install for mozscreenshot 17:39:16 INFO - Running setup.py install for moztest 17:39:16 INFO - Running setup.py install for mozversion 17:39:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:16 INFO - Cleaning up... 17:39:16 INFO - Return code: 0 17:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:16 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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:16 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 17:39:16 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 17:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:16 INFO - 'HOME': '/Users/cltbld', 17:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:16 INFO - 'LOGNAME': 'cltbld', 17:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:16 INFO - 'MOZ_NO_REMOTE': '1', 17:39:16 INFO - 'NO_EM_RESTART': '1', 17:39:16 INFO - 'PAGER': '/bin/cat', 17:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:16 INFO - 'PWD': '/builds/slave/test', 17:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:16 INFO - 'SHELL': '/bin/bash', 17:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:16 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:16 INFO - 'USER': 'cltbld', 17:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:16 INFO - 'XPC_FLAGS': '0x0', 17:39:16 INFO - 'XPC_SERVICE_NAME': '0', 17:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-CkNVS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-ls1cIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-eskAhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-TM3fXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-LuIjha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-qDY1Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-kDkNdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-87ALR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:17 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)) 17:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:17 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-ZZ0KzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-3trLub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-b5661C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-7Co5IZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-RS_ybm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-gQ23sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-GNBSJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-1zvAdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:18 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)) 17:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:18 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-RvUrJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:18 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)) 17:39:18 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)) 17:39:18 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)) 17:39:18 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)) 17:39:18 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)) 17:39:18 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)) 17:39:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:21 INFO - Downloading blessings-1.6.tar.gz 17:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:21 INFO - Installing collected packages: blessings 17:39:21 INFO - Running setup.py install for blessings 17:39:21 INFO - Successfully installed blessings 17:39:21 INFO - Cleaning up... 17:39:21 INFO - Return code: 0 17:39:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:21 INFO - Reading from file tmpfile_stdout 17:39:21 INFO - Current package versions: 17:39:21 INFO - blessings == 1.6 17:39:21 INFO - blobuploader == 1.2.4 17:39:21 INFO - docopt == 0.6.1 17:39:21 INFO - manifestparser == 1.1 17:39:21 INFO - mozInstall == 1.12 17:39:21 INFO - mozcrash == 0.16 17:39:21 INFO - mozdebug == 0.1 17:39:21 INFO - mozdevice == 0.48 17:39:21 INFO - mozfile == 1.2 17:39:21 INFO - mozhttpd == 0.7 17:39:21 INFO - mozinfo == 0.9 17:39:21 INFO - mozleak == 0.1 17:39:21 INFO - mozlog == 3.1 17:39:21 INFO - moznetwork == 0.27 17:39:21 INFO - mozprocess == 0.22 17:39:21 INFO - mozprofile == 0.28 17:39:21 INFO - mozrunner == 6.11 17:39:21 INFO - mozscreenshot == 0.1 17:39:21 INFO - mozsystemmonitor == 0.0 17:39:21 INFO - moztest == 0.7 17:39:21 INFO - mozversion == 1.4 17:39:21 INFO - psutil == 3.1.1 17:39:21 INFO - requests == 1.2.3 17:39:21 INFO - wsgiref == 0.1.2 17:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:21 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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:21 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 17:39:21 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 17:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:21 INFO - 'HOME': '/Users/cltbld', 17:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:21 INFO - 'LOGNAME': 'cltbld', 17:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:21 INFO - 'MOZ_NO_REMOTE': '1', 17:39:21 INFO - 'NO_EM_RESTART': '1', 17:39:21 INFO - 'PAGER': '/bin/cat', 17:39:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:21 INFO - 'PWD': '/builds/slave/test', 17:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:21 INFO - 'SHELL': '/bin/bash', 17:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:21 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:21 INFO - 'USER': 'cltbld', 17:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:21 INFO - 'XPC_FLAGS': '0x0', 17:39:21 INFO - 'XPC_SERVICE_NAME': '0', 17:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 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)) 17:39:22 INFO - Cleaning up... 17:39:22 INFO - Return code: 0 17:39:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:22 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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:22 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 17:39:22 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 17:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:22 INFO - 'HOME': '/Users/cltbld', 17:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:22 INFO - 'LOGNAME': 'cltbld', 17:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:22 INFO - 'MOZ_NO_REMOTE': '1', 17:39:22 INFO - 'NO_EM_RESTART': '1', 17:39:22 INFO - 'PAGER': '/bin/cat', 17:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:22 INFO - 'PWD': '/builds/slave/test', 17:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:22 INFO - 'SHELL': '/bin/bash', 17:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:22 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:22 INFO - 'USER': 'cltbld', 17:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:22 INFO - 'XPC_FLAGS': '0x0', 17:39:22 INFO - 'XPC_SERVICE_NAME': '0', 17:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:22 INFO - Downloading/unpacking jsonschema 17:39:22 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 17:39:22 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 17:39:22 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 17:39:22 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 17:39:22 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 17:39:22 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 17:39:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:39:24 INFO - Downloading/unpacking functools32 (from jsonschema) 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:25 INFO - Downloading functools32-3.2.3-2.tar.gz 17:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:39:25 INFO - warning: no files found matching '*.txt' 17:39:25 INFO - no previously-included directories found matching 'build' 17:39:25 INFO - no previously-included directories found matching 'dist' 17:39:25 INFO - no previously-included directories found matching '.git*' 17:39:25 INFO - Installing collected packages: jsonschema, functools32 17:39:25 INFO - Running setup.py install for functools32 17:39:25 INFO - warning: no files found matching '*.txt' 17:39:25 INFO - no previously-included directories found matching 'build' 17:39:25 INFO - no previously-included directories found matching 'dist' 17:39:25 INFO - no previously-included directories found matching '.git*' 17:39:25 INFO - Successfully installed jsonschema functools32 17:39:25 INFO - Cleaning up... 17:39:25 INFO - Return code: 0 17:39:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:25 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 0x105600a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056084c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f960a599d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, '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.ASxXkflsAm/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.iG4KY3Za2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 17:39:25 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 17:39:25 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 17:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:25 INFO - 'HOME': '/Users/cltbld', 17:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:25 INFO - 'LOGNAME': 'cltbld', 17:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:25 INFO - 'MOZ_NO_REMOTE': '1', 17:39:25 INFO - 'NO_EM_RESTART': '1', 17:39:25 INFO - 'PAGER': '/bin/cat', 17:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:25 INFO - 'PWD': '/builds/slave/test', 17:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:25 INFO - 'SHELL': '/bin/bash', 17:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:39:25 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:25 INFO - 'USER': 'cltbld', 17:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:25 INFO - 'XPC_FLAGS': '0x0', 17:39:25 INFO - 'XPC_SERVICE_NAME': '0', 17:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:25 INFO - Downloading/unpacking flake8 17:39:25 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 17:39:25 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 17:39:25 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 17:39:25 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 17:39:25 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 17:39:25 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 17:39:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:39:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:39:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 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 17:39:28 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 17:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:29 INFO - no previously-included directories found matching 'docs/_build' 17:39:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:39:29 INFO - Running setup.py install for pep8 17:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:29 INFO - no previously-included directories found matching 'docs/_build' 17:39:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:39:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:39:29 INFO - Cleaning up... 17:39:29 INFO - Return code: 0 17:39:29 INFO - Running post-action listener: _resource_record_post_action 17:39:29 INFO - Running post-action listener: _start_resource_monitoring 17:39:29 INFO - Starting resource monitoring. 17:39:29 INFO - ##### 17:39:29 INFO - ##### Running install step. 17:39:29 INFO - ##### 17:39:29 INFO - Running pre-action listener: _resource_record_pre_action 17:39:29 INFO - Running main action method: install 17:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:29 INFO - Reading from file tmpfile_stdout 17:39:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:29 INFO - Reading from file tmpfile_stdout 17:39:29 INFO - Output received: 17:39:29 INFO - Usage: mozinstall [options] installer 17:39:29 INFO - Options: 17:39:29 INFO - -h, --help show this help message and exit 17:39:29 INFO - -d DEST, --destination=DEST 17:39:29 INFO - Directory to install application into. [default: 17:39:29 INFO - "/builds/slave/test"] 17:39:29 INFO - --app=APP Application being installed. [default: firefox] 17:39:29 INFO - mkdir: /builds/slave/test/build/application 17:39:29 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'] 17:39:29 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 17:40:04 INFO - Reading from file tmpfile_stdout 17:40:04 INFO - Output received: 17:40:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:40:04 INFO - Running post-action listener: _resource_record_post_action 17:40:04 INFO - ##### 17:40:04 INFO - ##### Running run-tests step. 17:40:04 INFO - ##### 17:40:04 INFO - Running pre-action listener: _resource_record_pre_action 17:40:04 INFO - Running main action method: run_tests 17:40:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:40:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:40:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:40:04 INFO - 2016-02-16 17:40:04.308 screenresolution[1657:7620] starting screenresolution argv=screenresolution get 17:40:04 INFO - 2016-02-16 17:40:04.311 screenresolution[1657:7620] Display 0: 1600x1200x32@60 17:40:04 INFO - 2016-02-16 17:40:04.317 screenresolution[1658:7623] starting screenresolution argv=screenresolution list 17:40:04 INFO - Available Modes on Display 0 17:40:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:40:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:40:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:40:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:40:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:40:04 INFO - Intel Iris: 17:40:04 INFO - Chipset Model: Intel Iris 17:40:04 INFO - Type: GPU 17:40:04 INFO - Bus: Built-In 17:40:04 INFO - VRAM (Dynamic, Max): 1536 MB 17:40:04 INFO - Vendor: Intel (0x8086) 17:40:04 INFO - Device ID: 0x0a2e 17:40:04 INFO - Revision ID: 0x0009 17:40:04 INFO - Displays: 17:40:04 INFO - Display: 17:40:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:40:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:40:04 INFO - Display Serial Number: 1600x1200 60 17:40:04 INFO - Main Display: Yes 17:40:04 INFO - Mirror: Off 17:40:04 INFO - Online: Yes 17:40:04 INFO - Rotation: Supported 17:40:04 INFO - Return code: 0 17:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:40:04 INFO - Python 2.7.3 17:40:04 INFO - Return code: 0 17:40:04 INFO - grabbing minidump binary from tooltool 17:40: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')]} 17:40:04 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 0x1054a4d30>, '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 0x1052c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10549bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:40:04 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 17:40:04 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 17:40:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:40:04 INFO - Return code: 0 17:40:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:40:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:40:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:40:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:40:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:40:05 INFO - Return code: 0 17:40:05 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/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--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 17:40:05 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/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0055 --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 17:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ASxXkflsAm/Render', 17:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:40:05 INFO - 'HOME': '/Users/cltbld', 17:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:40:05 INFO - 'LOGNAME': 'cltbld', 17:40:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:40:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:05 INFO - 'MOZ_NO_REMOTE': '1', 17:40:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:40:05 INFO - 'NO_EM_RESTART': '1', 17:40:05 INFO - 'PAGER': '/bin/cat', 17:40:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:05 INFO - 'PWD': '/builds/slave/test', 17:40:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:40:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:40:05 INFO - 'SHELL': '/bin/bash', 17:40:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iG4KY3Za2d/Listeners', 17:40:05 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 17:40:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:40:05 INFO - 'USER': 'cltbld', 17:40:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:40:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:05 INFO - 'XPC_FLAGS': '0x0', 17:40:05 INFO - 'XPC_SERVICE_NAME': '0', 17:40:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:40:05 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/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--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 17:40:06 INFO - mozversion application_buildid: 20160216155249 17:40:06 INFO - mozversion application_changeset: 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b 17:40:06 INFO - mozversion application_display_name: Nightly 17:40:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:40:06 INFO - mozversion application_name: Firefox 17:40:06 INFO - mozversion application_remotingname: firefox 17:40:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:40:06 INFO - mozversion application_vendor: Mozilla 17:40:06 INFO - mozversion application_version: 47.0a1 17:40:06 INFO - mozversion platform_buildid: 20160216155249 17:40:06 INFO - mozversion platform_changeset: 58d7cfbf806c14041d13bd7b1e7e4b2a6eb9285b 17:40:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:40:06 INFO - mozversion platform_version: 47.0a1 17:40:06 INFO - using testdate: 1455673206 17:40:06 INFO - actual date: 1455673206 17:40:06 INFO - starting webserver on 'localhost:49274' 17:40:06 INFO - SUITE-START | Running 2 tests 17:40:06 INFO - TEST-START | dromaeo_css 17:40:06 INFO - operating with platform_type : mac_ 17:40:06 INFO - Initialising browser for dromaeo_css test... 17:40:06 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmpqMAZct/profile http://localhost:49274/getInfo.html) 17:40:08 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 17:40:08 INFO - PROCESS | 1676 | colorDepth:24 17:40:08 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 17:40:08 INFO - PROCESS | 1676 | __metrics 17:40:08 INFO - PROCESS | 1676 | 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" 17:40:08 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:40:09 INFO - TEST-INFO | 1676: exit 0 17:40:09 INFO - Browser initialized. 17:40:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:40:09 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmpqMAZct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:21 INFO - PROCESS | 1679 | RSS: Main: 244510720 17:40:21 INFO - PROCESS | 1679 | 17:41:12 INFO - PROCESS | 1679 | 1455673272129 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] 17:43:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 17:43:24 INFO - PROCESS | 1679 | RSS: Main: 343830528 17:43:24 INFO - PROCESS | 1679 | 17:46:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 17:46:27 INFO - PROCESS | 1679 | RSS: Main: 376651776 17:46:27 INFO - PROCESS | 1679 | 17:49:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 17:49:30 INFO - PROCESS | 1679 | RSS: Main: 374747136 17:49:30 INFO - PROCESS | 1679 | 17:52:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 17:52:32 INFO - PROCESS | 1679 | RSS: Main: 336977920 17:52:32 INFO - PROCESS | 1679 | 17:55:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 17:55:36 INFO - PROCESS | 1679 | RSS: Main: 344485888 17:55:36 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 17:58:39 INFO - PROCESS | 1679 | RSS: Main: 383123456 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | __start_tp_report 17:58:39 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 17:58:39 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 17:58:39 INFO - PROCESS | 1679 | |i|pagename|runs| 17:58:39 INFO - PROCESS | 1679 | |0;dojo.html;2889.9885040235918;3508.7193024558037;3528.9823550882234;3551.2187318789856;3585.910352241194;5707.4292570742955;5719.08494640857;5724.284464441945;5754.683492407921;5784.595078344518;5584.357798853133;5690.5447564194865;5694.487496125348;5801.680907550083;5832.883342333151;5158.123119069767;5186.636935414523;5191.558717509016;5232.424433312332;5329.014132385521;5314.548263397596;5321.6540924839765;5349;5367.436419175989;5394.595405344595;5191.974040129775;5212.192110222903;5271.341082364705;5279;5294.10000299948;5215.400228973679;5220.556252718486;5225.4513276105845;5227.059129356714;5283.445238249967;5154.716490593016;5187.48125187482;5196.8960620787375;5217.895642087175;5218.869528261824;5535.474129957688;5613;5619.887602247973;5647.576431767634;5684.54523638108;6214.8135555933395;6221.222347206599;6226.439620434183;6254.34329395416;6319.241690997063;5310.176922577007;6200.844978875519;6266.561340706153;6299.212598425197;6319.6524191169465;5821.970890145522;5836.708164591753;5848.502877255396;5850.6782126983;5901.17383566301;5259.921101183485;6188.535859810442;6220.657863817443;6273.874522509615;6298.464630506367;6192.102145189013;6217.782377616762;6222.688865556704;6224.190855188796;6250.843728906813;6158.7228574714245;6331.620102793847;6341.3341599132345;6348.206474190726;6359.3640635936035;5064.392272927199;6215.34738852423;6306.590071645328;6313.463355614824;6320.968395157995;6282.18331616896;6310.873782524323;6313;6314.747410103544;6326.082718005863;4842.15262329098;4864.318995340655;4915.26271059344;4919.581835543947;4968.652194346361;4449.443819522559;4470.530594287618;4471.731696098244;4480.39514665516;4517.051419201939;5695.088785794253;5770.5095066919785;5782.479576838105;5808.30300363959;5836.562257830679;6309.495240380758;6315;6317.1156038154695;6324.71538780756;6332.778352757631;4485.327200919888;5294.338207724035;5366.221897824872;5672.461116193955;5722.141678748138;5342.439043900412;5353.384360798558;5376.973115134399;5383.273258110184;5443.074677304868;6251.156093927261;6278.497720182374;6297.055441683692;6307.716152773136;6311.810645680637;6237.781677641261;6257.874842503215;6310.936890631035;6316.7157477914525;6323.9683801580695;6260.937390626035;6295.3704629538515;6326.0510923360025;6356.650384228912;6372.490200784019;6217.347178546188;6251.156093927261;6254.749810007731;6257;6263.404976527223;6200.286966998853;6304.464120549805;6308.243010838729;6323.051542268512;6323.051542268697;6065.059915713072;6117.785877494266;6127.6936153193055;6164.260288765377;6180;6127.479164270909;6139;6153.292371377349;6158.107074474086;6158.507319414346;5767.423257674367;5776.797812076557;5938.406159384027;5995.730192141451;6070.575059745775;6096.417461711209;6174.351693072343;6177.166082578794;6183.5671502994355;6186.288576813724;4991.251312303184;5998.993858552326;6017.909731354121;6032.426919442646;6065.514758819372 17:58:39 INFO - PROCESS | 1679 | |1;ext.html;477.2650118817022;527.6174773289363;528.735632183908;584.5937073733754;614.3978900677336;24420.023199072017;29069.273268168305;29412;29457.821687132542;29465.558016629766;30430.23924401891;37731.62268377315;38330.8083459583;38416.03959901004;38628.841134765935;8256.298214651732;8260.710875119372;9404.905950940489;9564.426134431922;9570.617175312978;9326.393784403992;9488.573014214342;9488.952555237249;9499.572519236652;9515.23878089751;9464.337496375256;9522.285828562852;9548.713538593853;9550.665726699566;9636.229101671885;9567.56945937431;9630.98874618162;9636.42181469114;9636.662716804949;9658.420494770266;9525.428474291495;9637.951810240975;9646.565904534313;9655.372400793925;9660.082292182231;37961.810190949145;38349.424758628644;38358.23283534341;38417.807910960546;38503.61496385028;3008.5637582550407;3465.237647717498;3612.8916132516065;3710.7402481826284;3989.122393073548;27631.44081226595;27822.582661260098;27982.580261296098;28160.43679126406;28454.66612972984;2579.729128441524;2774.597683335925;2787.5261205595098;2943.1170648805273;2962.4075184963094;375773;376126;376603;377146;377505;50659.73350666189;51541.742291288305;51722;58616.413835861094;59312.703436482545;50804.49195508072;61390.693046534485;62896;62948.37051629517;63216.68391658012;15496.767548486781;15510.84489155094;15685.05889646625;15693.215339232993;15727.44953926607;11954.222975506564;12016.759664806656;12030.578929737418;12031;12099.395030248452;13687.726245475034;16078.75881861773;16422;16434.178291085398;18062.729059064124;7779.4554381192775;7892.605369731606;7897.842043159105;7908.52548847071;7967.402444816662;823.3536673711108;919.6597259014208;945.6548359848606;1065.4086981725218;1078.164422572497;29209;29273.268168295963;29297.707022929924;29972;29979;1025.3266560211891;1073.9301945373525;1087.7117563845586;1105.2042529378834;1150.8676502202354;13112.868871311355;13249.271290079138;13296.202227866359;13335.199888006751;13339.06626536133;526186;529604;530885;532160;533097;51066.723331917;51837.740811295705;51905;51933.96132077337;52083.218751718756;1306.8627794081674;1424.1739790921447;1426.686129051607;1426.86444787745;1461.751502244621;23940.34889702327;25786.742132579184;27491.450170996868;28185.43629127447;28455.857720711265;42105.57894421017;46357.304640431095;46843.063138737714;46868;46911.530884690714;475196;477156;477964;478858;479690;26605.7339426611;28668.28329291701;30355.696443035285;30883;31278;37624;37820.43269350907;37881.43177852279;38353;38593.614063859;32170.35659286848;32971;33199.502007469426;33223.33553328968;35217.647823522464;27680.86159569189;33676.831615841766;33947.49078763771;34262;34363;32515.349693005533;33135.83432082824;33152.66847331592;33681.663183367855;34369.65630343665;28944.56583151212;29918.25204369908;29971.400571988874;31127.84436077805;31729.524057139624;23299.068037278317;23359.766402336438;23641.881790591626;23656.580605163745;23667.171648992204 17:58:39 INFO - PROCESS | 1679 | |2;jquery.html;362.78414343465636;367.86756767563674;370.242853364869;373.78133791731835;376.17617417854876;15530.912836101477;15632.921835390836;18622.348217812378;19656.21375144994;20354.185832566698;11303.26528775629;11454.942725286362;11746.00158986485;11763.294202347864;11775.7644847103;3932.370820668694;5103.2090026045835;5292.761825717833;5296.523312901838;5301.655392399501;4018.2365350583295;5752;5999.250093738283;6009.218801555791;6016.398360163992;5955.88088238235;6045.093236014611;6380.776672816452;6384.680765961706;6393.872122557546;5836.5914385993;5954.434328738763;6148.200733904586;6323.715432805535;6362.109304697323;5662.490375866192;5671.602987790856;5672.092465205588;5677.063284558043;5678.26182596264;18311.908440457846;20211.393658190133;21712.457188570253;22337.441563960867;24523.386915327083;2155;2182.74898386686;2193.5283913958574;2201.559688062378;2672.652555167835;9667.661631842922;10017.348872323275;10069.899301007043;10861.239713220079;11986.70033249167;1701.2854601067459;1722.078687901979;1731.919858983592;1740.651869626067;1789.2574581548643;90394.5480272601;96778.51610741901;96812.51593742057;98417.5079124607;98767.50616246945;9133.771655708528;10825.458727063615;11041;11063;11135.721606959729;13217.273049982343;13310.467581296833;13326.400311985984;13332.200067995951;13372.130811497222;6773.559718618372;8298.128696486903;8311.501309921425;8389.706360277483;8393.076761556224;6885.965570172117;8357.373197010249;8379.832403351898;8384.077751447336;8447.493150410872;3964;4147.668186545069;4217.936730948977;4318.460192475941;4430.8449204277695;1791.2745338138075;1806.3677712800677;1812.3481185411406;1813.4559632110313;1828.1407738362948;802.3140215116108;887.272436601993;900.5137225897942;936.1293996583107;974.2254907348674;11115;17660.823391766175;19176.616467670567;19181.424557263304;19289.421317360502;914.7530166854912;917.6054296652503;931.3945935142211;958.5734348215117;958.836997710391;8676.392652514389;9047.81904361909;10184.338018028804;10566.93054876155;10621.53895363949;699231;729818;730899;750085;753915;103199.48400257951;103254.48372758088;105603;106334;107416.46291768647;1114.6098865397046;1121.472907733364;1165.7610189911047;1180.8819118088295;1182.834403183555;14413.85586144125;16779.900460756035;17464;17656;17885.910570447584;49739.25912593042;49781.50218497769;50500.73748156326;50519;51456;63625.363746361945;64604.35395646172;70496.64751676208;73863.63068184625;74459;7184.568925864465;7605.543667379975;7634.4655874088285;7639.923600763921;7704;10178;11559.653210403701;11927.522899084286;11973.700657483632;12032.578859739868;9854.605815767289;10184.694459166238;10371.118454931415;10433.32183408076;10630.468476576294;10258.12805911476;10324.831785325166;10373.896261037595;10445.895541044492;10600;10070.748231293983;10401.791964160826;10480.842787358044;10504.527296271533;10766.031057204576;5539.723013849372;5691.800786972436;6740.831479213059;7339.70641174347;7479.513831600929;7867.606619669108;8198.50808951441;10047;10397.272190946562;10413.062824345845 17:58:39 INFO - PROCESS | 1679 | |3;mootools.html;1426.0017987408817;1533.9233038348084;1572.7876736640558;1791.5342011077116;1922.5482011727233;8126.796830079244;8898.110188981098;9063.27493800496;9110.681126160578;9119.224865886392;8761.299096072315;9011.729648110551;9033.72898813035;9043.547822608876;9046.819063618723;2141;2211.5908556916943;2263.106073101124;2444.8533088014688;2488.3903443656286;2127.7446706395253;2150.2474134053114;2525.6211568264816;2531.0508559290265;2542.288159315385;2414.1550457339877;2482.044412901037;2483.2301986384186;2484.3416494628937;2490.601503759399;2194.9780502194935;2248.6177349850564;2253.5605556916407;2255.9661605075935;2445.2297526279167;2497.5878979968466;2520.117958714454;2524.406764410362;2529.3297276221633;2531.227975467482;8757.080506546785;8923.643054277822;8932.285417166677;8932.910670893272;8960.283177345862;4584.381108550337;5477.068898287301;5501;5530.5022547970875;5547.140193270049;3553.182767963357;3653.0582996871867;3703.5926048134684;3741.401375779862;3750.2124553843723;1052.2375021838466;1056.9048785609255;1083.4203701019994;1092.1317552545745;1104.5471356743697;12412.75174496505;12416.937915310456;12424.068194885329;12438.502459901592;12448.439820208112;4824.879378015507;4976.701397916137;5004.449510553836;5040.36995375578;5048.040872234264;10524;10542.789144217073;10548.314359566604;10548.525316360781;10554.683359499228;5632.633878797865;5633.380328163898;5636.098224284095;5672.8865422691315;5680;5102.234664800236;5139.023585518739;5140.794368225229;5143.948560514422;5147.0735267651435;3331.866725331008;4025.456563363967;4035.4552135461336;4037.273290807624;4078.3066878630702;1324.132693086011;1325.1452812935602;1331.6071758831167;1337.2979185927466;1345.6703107738667;1328.614701736505;1330.8802207801343;1332.8467226268908;1342.6576223063057;1371.2595198592649;8289.212524810133;8321.08468068512;8344.040435350013;8462.619182136696;8464.619092140869;509.2666560153367;513.2685922560337;518.7380372911656;520.7136075158647;520.9765560549785;5711.9718450679275;6064.9090263646085;6193.287771906288;6199.287081985539;6200.596961197508;10539.894601054044;10692;10936.56253749841;10987.945060274807;11025.44872756359;10720.303180293256;10737.248392612599;10822.971817677308;10830.40432776205;10836.458177091272;8245.309711509126;8326.6669333226;8484.915150848536;8545.102764209792;8556.358273129541;8306.127856574973;8320.958395207985;8489.023762267418;8513.659453621785;8520.573971301534;9758.755486238348;9787.46168960714;10092.34399764013;10114.393136411838;10228.028337307944;10115.645952391631;10414.47927603632;10421.166306695597;10480.318779279323;10526.210534209811;8181.754547363588;8312.6674933002;8419.200175983271;8428.831423371375;8438.620262088098;8340.666373344999;8412.87380689278;8425.4944703318;8434.789130271793;8442.873356899529;7843.764687059397;7985.241402066795;7985.64064617082;8093.231143041402;8149.062857771195;7772.145064043064;7796;7836.255555722198;7948.8807667883875;7987.48081374732;7965.128194874084;8009.799755006172;8018.639161237642;8027.2775450209765;8043.597820108854;6674.199096108498;6840.3501667341525;6843.041974123527;6843.3840954314355;7265.309795569412;6698.229703583956;7266.164391095092;7292.708291668274;7310.159331676712;7310.96344518274 17:58:39 INFO - PROCESS | 1679 | |4;prototype.html;319.99200019999495;326.6504839821392;331.3786650031191;335.6727190988785;340.03430258067084;6365.872682546358;6522.282548919615;6542.672866356675;6561.589258309463;6630.569013014157;6350.269718982307;6503;6529.085927970088;6540.149780528536;6566.5075119366;4259.531451540328;4864.10014147383;4866.3673722416215;4904.190808516591;4910.75446227689;4661.953380466202;4759.857204283877;4777.593904518103;4855.975720121394;4916.213405855064;4777.928331075037;4785.832495862645;4797.808087676489;4816;4823.927641085386;4790.065937142259;4801.567858892681;4812.35033270511;4823.831165909176;4831.106245344622;3769.736118471708;3826.521684789401;4134.565870583576;4144.046869220097;4158.272302347077;5929.644221346733;6184.907226391608;6198.876022479571;6216.471599914013;6266.655333956631;4534.5692159245145;4545.931811022837;5482.972585137089;5504.7522861470925;5511.917321240185;5882.941170588282;6638.435732962704;6785.6267905265195;6834.658267086676;6955.165380154363;4590.242609969385;4635.8377456789185;4655.8593144679435;4657.767111644404;4666.719996800169;7141.642917854138;7278.927210727931;7311.926880731178;7370.115586129698;7386.113666360017;4596.908061838744;4749.525047495223;4759.785809638574;4766.475687674353;4777.641676874248;4114.341705327133;4837.153498137812;4849.539293767087;4857.9028419431415;4862.82980095695;5159.045576568347;5275.208718692227;5660.773569057192;5683.403242659544;5719.5996280260815;6997.230304666483;7008.404285635676;7009.474289428314;7017.859642807115;7021.122359705037;1412.4632639596887;1554.8989315694444;1660.5350501859498;1688.797344318665;1691.7631531585587;1086.3101930274333;1098.2970898624887;1103.812351900179;1115.3363748569589;1115.8382034604938;6488.902666459912;6494.993276042221;6500;6533.738650454024;6538.934610653928;7232.927670723226;7238.384737297283;7251.746188883364;7252.601106939063;7313.780586582411;6301.747930082837;6467.2562655294305;6482.481401487964;6484.383983521652;6515.7067931943175;3825.0437390652337;3852;3854.2291541691775;3856.2865869814173;3856.8842934712;7512.962435187789;7518.248175182438;7557.508761930457;7562.621868906533;7607.581583012877;7260.41916646667;7457.0305860238905;7475.8504829903095;7488.737894173678;7498.887516687254;7515.774526764206;7537.321641052332;7538.246175382418;7548.735794247065;7555.659995300225;6995.775739245713;7150.284971502808;7237.782866514013;7292.942523333981;7328.230535793665;7113.03973963529;7143.892841607484;7148.714051437884;7150.892736609059;7254.709811607477;7305.707771689073;7544.509606875536;7585.165631780389;7604.5437273763755;7614.200508946702;4785.712857228577;4799.400074990626;4800.5199480051715;4804.807807687654;4805.975970120127;7257.782266532013;7260.818479538054;7267.200607933229;7268.781936541912;7275.963620181865;6830.45356371499;6953.617551034539;7001.159860816734;7004.15950085993;7007;6982;6994.405475534433;6994.895076573754;7011.4390848733;7012.298770123151;6841.794746157623;6844.452443804584;6849.1780986281965;6871.14110736158;6886.69009894566;6792.728290868507;7028.367446929801;7034.859302813813;7055.082839231072;7079.43364530826;6861.725530978705;6878.209005964178;6882.311768823278;6886.690098945459;6886.69009894566 17:58:39 INFO - PROCESS | 1679 | |5;yui.html;678.0744284052269;683.1494788987711;753.2806170107548;768.4428789127883;786.4887822915105;14589.343479543419;14755;14768.335424905878;14774.482893098744;14778.482753103644;13101;13444.462221511152;13453.596392108228;13459.596212113627;13486.393112309945;690.0994202565649;700.3976580141075;843.0936743001267;849.1041950741965;870.5560164316213;857.8069934264772;867.8481265778495;869.7173418638936;870.264626390702;870.7039606533777;909.1090731083542;913.8492148795441;914.8033172867832;915.7069737683944;916.1434059154711;722.5664601239267;730.2223132364041;732.6776218463859;734.177720952534;878.3807415771929;681.151965802574;681.1553673444943;681.2234053179379;681.5195287322426;682.7917485167022;14346;14380.209088500129;14398.85601143996;14435.206063666494;14478.638034049127;12202.938985305105;12387.274799544177;12506.124571280014;12721.936390318082;12955.028372872071;9890.505474726235;10176.389416634951;10193.439360835151;10204.744881378025;10205;3525.2773181497732;3551.5738111426795;3552.626974167701;3553.538040054802;3558.6085530591613;72156.6392168041;75212.62393688051;78674.81987770245;78728.81906771404;78847.42305153923;9513.33406661527;9552.856707149398;9588.760280992892;9745.853812192823;9748.756281093029;21124.577508449744;21181.258655946967;21186.258480953093;21205.939703015098;21209.469763256042;7452.485071700494;7470.589117598475;7513.924860751323;7748.380129589619;7759.262870027338;3633.927321453556;3779.3575092234387;4069.369247766601;4143.212789570032;4224.471941007374;3549.94675079874;3601.837917293728;3605;3615.457681347819;3616.150204701893;652.5236577298599;672.2235817630644;673.5049738442241;674.8751480976035;683.0710234081744;572.619208226533;613.0742578706097;613.3866133866134;627.8618703885138;645.9418652321219;8114.878276825734;8543.102974187745;8557.48655080697;8601.61292741828;8770.3422243332;513.4531723714232;589.2163422647868;593.4777395891588;611.9082137679295;668.1481111582771;3785.507883975121;3918.3534716771983;3924.9215015699524;4124.278251306009;4487.528809475023;87090;93196.53401732948;93772.53113734387;94048;94805.5259723697;76985;77877;78800;79048;82387.17612823794;71226.64386678033;71554;71845.6407717958;71963;72176.63911680513;8718.60766265507;8745.431546949429;8788.956055219684;8836.381453298207;9006.729798106067;36552;51352;51764;51817.70455738486;52110;66820.66589667214;68979.27551811044;69418;69939;70903.22741931494;10856.728581785519;10953.17851161182;11012.17408694367;11340;12044.879551204725;8820.91179088201;12253.203541769757;12317.384130793604;12342.01263898904;12587.24476531411;11664.88335116638;11669.299842009506;11741.471633776671;11782.823257651313;11882.28706277626;11667.474963626488;11689.766204676029;11734.530618775154;11751.529938802694;11760.176787624785;10858.67423977282;11445.713857153638;11521.88478115208;11543.942280288546;11774.882251177378;9312.115349041831;9362.29782766309;9515.762105947406;9548.522573871418;9955.701328960144;9894;10053.798924021625;10072.597096116073;10087.495625218857;10096.949515252376 17:58:39 INFO - PROCESS | 1679 | __end_tp_report 17:58:39 INFO - PROCESS | 1679 | __start_cc_report 17:58:39 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,931 17:58:39 INFO - PROCESS | 1679 | __end_cc_report 17:58:39 INFO - PROCESS | 1679 | __startTimestamp1455674319798__endTimestamp 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | ------- Summary: start ------- 17:58:39 INFO - PROCESS | 1679 | Number of tests: 6 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5746.37 Median:5995.73 stddev:656.27 (10.9%) stddev-sans-first:618.85 17:58:39 INFO - PROCESS | 1679 | Values: 2890.0 3508.7 3529.0 3551.2 3585.9 5707.4 5719.1 5724.3 5754.7 5784.6 5584.4 5690.5 5694.5 5801.7 5832.9 5158.1 5186.6 5191.6 5232.4 5329.0 5314.5 5321.7 5349.0 5367.4 5394.6 5192.0 5212.2 5271.3 5279.0 5294.1 5215.4 5220.6 5225.5 5227.1 5283.4 5154.7 5187.5 5196.9 5217.9 5218.9 5535.5 5613.0 5619.9 5647.6 5684.5 6214.8 6221.2 6226.4 6254.3 6319.2 5310.2 6200.8 6266.6 6299.2 6319.7 5822.0 5836.7 5848.5 5850.7 5901.2 5259.9 6188.5 6220.7 6273.9 6298.5 6192.1 6217.8 6222.7 6224.2 6250.8 6158.7 6331.6 6341.3 6348.2 6359.4 5064.4 6215.3 6306.6 6313.5 6321.0 6282.2 6310.9 6313.0 6314.7 6326.1 4842.2 4864.3 4915.3 4919.6 4968.7 4449.4 4470.5 4471.7 4480.4 4517.1 5695.1 5770.5 5782.5 5808.3 5836.6 6309.5 6315.0 6317.1 6324.7 6332.8 4485.3 5294.3 5366.2 5672.5 5722.1 5342.4 5353.4 5377.0 5383.3 5443.1 6251.2 6278.5 6297.1 6307.7 6311.8 6237.8 6257.9 6310.9 6316.7 6324.0 6260.9 6295.4 6326.1 6356.7 6372.5 6217.3 6251.2 6254.7 6257.0 6263.4 6200.3 6304.5 6308.2 6323.1 6323.1 6065.1 6117.8 6127.7 6164.3 6180.0 6127.5 6139.0 6153.3 6158.1 6158.5 5767.4 5776.8 5938.4 5995.7 6070.6 6096.4 6174.4 6177.2 6183.6 6186.3 4991.3 5999.0 6017.9 6032.4 6065.5 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:59119.24 Median:3661.82 stddev:124117.11 (3389.5%) stddev-sans-first:124387.19 17:58:39 INFO - PROCESS | 1679 | Values: 477.3 527.6 528.7 584.6 614.4 24420.0 29069.3 29412.0 29457.8 29465.6 30430.2 37731.6 38330.8 38416.0 38628.8 8256.3 8260.7 9404.9 9564.4 9570.6 9326.4 9488.6 9489.0 9499.6 9515.2 9464.3 9522.3 9548.7 9550.7 9636.2 9567.6 9631.0 9636.4 9636.7 9658.4 9525.4 9638.0 9646.6 9655.4 9660.1 37961.8 38349.4 38358.2 38417.8 38503.6 3008.6 3465.2 3612.9 3710.7 3989.1 27631.4 27822.6 27982.6 28160.4 28454.7 2579.7 2774.6 2787.5 2943.1 2962.4 375773.0 376126.0 376603.0 377146.0 377505.0 50659.7 51541.7 51722.0 58616.4 59312.7 50804.5 61390.7 62896.0 62948.4 63216.7 15496.8 15510.8 15685.1 15693.2 15727.4 11954.2 12016.8 12030.6 12031.0 12099.4 13687.7 16078.8 16422.0 16434.2 18062.7 7779.5 7892.6 7897.8 7908.5 7967.4 823.4 919.7 945.7 1065.4 1078.2 29209.0 29273.3 29297.7 29972.0 29979.0 1025.3 1073.9 1087.7 1105.2 1150.9 13112.9 13249.3 13296.2 13335.2 13339.1 526186.0 529604.0 530885.0 532160.0 533097.0 51066.7 51837.7 51905.0 51934.0 52083.2 1306.9 1424.2 1426.7 1426.9 1461.8 23940.3 25786.7 27491.5 28185.4 28455.9 42105.6 46357.3 46843.1 46868.0 46911.5 475196.0 477156.0 477964.0 478858.0 479690.0 26605.7 28668.3 30355.7 30883.0 31278.0 37624.0 37820.4 37881.4 38353.0 38593.6 32170.4 32971.0 33199.5 33223.3 35217.6 27680.9 33676.8 33947.5 34262.0 34363.0 32515.3 33135.8 33152.7 33681.7 34369.7 28944.6 29918.3 29971.4 31127.8 31729.5 23299.1 23359.8 23641.9 23656.6 23667.2 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:36324.18 Median:372.01 stddev:120585.33 (32414.4%) stddev-sans-first:120893.36 17:58:39 INFO - PROCESS | 1679 | Values: 362.8 367.9 370.2 373.8 376.2 15530.9 15632.9 18622.3 19656.2 20354.2 11303.3 11454.9 11746.0 11763.3 11775.8 3932.4 5103.2 5292.8 5296.5 5301.7 4018.2 5752.0 5999.3 6009.2 6016.4 5955.9 6045.1 6380.8 6384.7 6393.9 5836.6 5954.4 6148.2 6323.7 6362.1 5662.5 5671.6 5672.1 5677.1 5678.3 18311.9 20211.4 21712.5 22337.4 24523.4 2155.0 2182.7 2193.5 2201.6 2672.7 9667.7 10017.3 10069.9 10861.2 11986.7 1701.3 1722.1 1731.9 1740.7 1789.3 90394.5 96778.5 96812.5 98417.5 98767.5 9133.8 10825.5 11041.0 11063.0 11135.7 13217.3 13310.5 13326.4 13332.2 13372.1 6773.6 8298.1 8311.5 8389.7 8393.1 6886.0 8357.4 8379.8 8384.1 8447.5 3964.0 4147.7 4217.9 4318.5 4430.8 1791.3 1806.4 1812.3 1813.5 1828.1 802.3 887.3 900.5 936.1 974.2 11115.0 17660.8 19176.6 19181.4 19289.4 914.8 917.6 931.4 958.6 958.8 8676.4 9047.8 10184.3 10566.9 10621.5 699231.0 729818.0 730899.0 750085.0 753915.0 103199.5 103254.5 105603.0 106334.0 107416.5 1114.6 1121.5 1165.8 1180.9 1182.8 14413.9 16779.9 17464.0 17656.0 17885.9 49739.3 49781.5 50500.7 50519.0 51456.0 63625.4 64604.4 70496.6 73863.6 74459.0 7184.6 7605.5 7634.5 7639.9 7704.0 10178.0 11559.7 11927.5 11973.7 12032.6 9854.6 10184.7 10371.1 10433.3 10630.5 10258.1 10324.8 10373.9 10445.9 10600.0 10070.7 10401.8 10480.8 10504.5 10766.0 5539.7 5691.8 6740.8 7339.7 7479.5 7867.6 8198.5 10047.0 10397.3 10413.1 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:6231.09 Median:2807.75 stddev:3361.46 (119.7%) stddev-sans-first:3351.49 17:58:39 INFO - PROCESS | 1679 | Values: 1426.0 1533.9 1572.8 1791.5 1922.5 8126.8 8898.1 9063.3 9110.7 9119.2 8761.3 9011.7 9033.7 9043.5 9046.8 2141.0 2211.6 2263.1 2444.9 2488.4 2127.7 2150.2 2525.6 2531.1 2542.3 2414.2 2482.0 2483.2 2484.3 2490.6 2195.0 2248.6 2253.6 2256.0 2445.2 2497.6 2520.1 2524.4 2529.3 2531.2 8757.1 8923.6 8932.3 8932.9 8960.3 4584.4 5477.1 5501.0 5530.5 5547.1 3553.2 3653.1 3703.6 3741.4 3750.2 1052.2 1056.9 1083.4 1092.1 1104.5 12412.8 12416.9 12424.1 12438.5 12448.4 4824.9 4976.7 5004.4 5040.4 5048.0 10524.0 10542.8 10548.3 10548.5 10554.7 5632.6 5633.4 5636.1 5672.9 5680.0 5102.2 5139.0 5140.8 5143.9 5147.1 3331.9 4025.5 4035.5 4037.3 4078.3 1324.1 1325.1 1331.6 1337.3 1345.7 1328.6 1330.9 1332.8 1342.7 1371.3 8289.2 8321.1 8344.0 8462.6 8464.6 509.3 513.3 518.7 520.7 521.0 5712.0 6064.9 6193.3 6199.3 6200.6 10539.9 10692.0 10936.6 10987.9 11025.4 10720.3 10737.2 10823.0 10830.4 10836.5 8245.3 8326.7 8484.9 8545.1 8556.4 8306.1 8321.0 8489.0 8513.7 8520.6 9758.8 9787.5 10092.3 10114.4 10228.0 10115.6 10414.5 10421.2 10480.3 10526.2 8181.8 8312.7 8419.2 8428.8 8438.6 8340.7 8412.9 8425.5 8434.8 8442.9 7843.8 7985.2 7985.6 8093.2 8149.1 7772.1 7796.0 7836.3 7948.9 7987.5 7965.1 8009.8 8018.6 8027.3 8043.6 6674.2 6840.4 6843.0 6843.4 7265.3 6698.2 7266.2 7292.7 7310.2 7311.0 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:5729.46 Median:6509.35 stddev:1825.38 (28.0%) stddev-sans-first:1784.77 17:58:39 INFO - PROCESS | 1679 | Values: 320.0 326.7 331.4 335.7 340.0 6365.9 6522.3 6542.7 6561.6 6630.6 6350.3 6503.0 6529.1 6540.1 6566.5 4259.5 4864.1 4866.4 4904.2 4910.8 4662.0 4759.9 4777.6 4856.0 4916.2 4777.9 4785.8 4797.8 4816.0 4823.9 4790.1 4801.6 4812.4 4823.8 4831.1 3769.7 3826.5 4134.6 4144.0 4158.3 5929.6 6184.9 6198.9 6216.5 6266.7 4534.6 4545.9 5483.0 5504.8 5511.9 5882.9 6638.4 6785.6 6834.7 6955.2 4590.2 4635.8 4655.9 4657.8 4666.7 7141.6 7278.9 7311.9 7370.1 7386.1 4596.9 4749.5 4759.8 4766.5 4777.6 4114.3 4837.2 4849.5 4857.9 4862.8 5159.0 5275.2 5660.8 5683.4 5719.6 6997.2 7008.4 7009.5 7017.9 7021.1 1412.5 1554.9 1660.5 1688.8 1691.8 1086.3 1098.3 1103.8 1115.3 1115.8 6488.9 6495.0 6500.0 6533.7 6538.9 7232.9 7238.4 7251.7 7252.6 7313.8 6301.7 6467.3 6482.5 6484.4 6515.7 3825.0 3852.0 3854.2 3856.3 3856.9 7513.0 7518.2 7557.5 7562.6 7607.6 7260.4 7457.0 7475.9 7488.7 7498.9 7515.8 7537.3 7538.2 7548.7 7555.7 6995.8 7150.3 7237.8 7292.9 7328.2 7113.0 7143.9 7148.7 7150.9 7254.7 7305.7 7544.5 7585.2 7604.5 7614.2 4785.7 4799.4 4800.5 4804.8 4806.0 7257.8 7260.8 7267.2 7268.8 7276.0 6830.5 6953.6 7001.2 7004.2 7007.0 6982.0 6994.4 6994.9 7011.4 7012.3 6841.8 6844.5 6849.2 6871.1 6886.7 6792.7 7028.4 7034.9 7055.1 7079.4 6861.7 6878.2 6882.3 6886.7 6886.7 17:58:39 INFO - PROCESS | 1679 | 17:58:39 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:18281.71 Median:649.23 stddev:25663.84 (3952.9%) stddev-sans-first:25701.79 17:58:39 INFO - PROCESS | 1679 | Values: 678.1 683.1 753.3 768.4 786.5 14589.3 14755.0 14768.3 14774.5 14778.5 13101.0 13444.5 13453.6 13459.6 13486.4 690.1 700.4 843.1 849.1 870.6 857.8 867.8 869.7 870.3 870.7 909.1 913.8 914.8 915.7 916.1 722.6 730.2 732.7 734.2 878.4 681.2 681.2 681.2 681.5 682.8 14346.0 14380.2 14398.9 14435.2 14478.6 12202.9 12387.3 12506.1 12721.9 12955.0 9890.5 10176.4 10193.4 10204.7 10205.0 3525.3 3551.6 3552.6 3553.5 3558.6 72156.6 75212.6 78674.8 78728.8 78847.4 9513.3 9552.9 9588.8 9745.9 9748.8 21124.6 21181.3 21186.3 21205.9 21209.5 7452.5 7470.6 7513.9 7748.4 7759.3 3633.9 3779.4 4069.4 4143.2 4224.5 3549.9 3601.8 3605.0 3615.5 3616.2 652.5 672.2 673.5 674.9 683.1 572.6 613.1 613.4 627.9 645.9 8114.9 8543.1 8557.5 8601.6 8770.3 513.5 589.2 593.5 611.9 668.1 3785.5 3918.4 3924.9 4124.3 4487.5 87090.0 93196.5 93772.5 94048.0 94805.5 76985.0 77877.0 78800.0 79048.0 82387.2 71226.6 71554.0 71845.6 71963.0 72176.6 8718.6 8745.4 8789.0 8836.4 9006.7 36552.0 51352.0 51764.0 51817.7 52110.0 66820.7 68979.3 69418.0 69939.0 70903.2 10856.7 10953.2 11012.2 11340.0 12044.9 8820.9 12253.2 12317.4 12342.0 12587.2 11664.9 11669.3 11741.5 11782.8 11882.3 11667.5 11689.8 11734.5 11751.5 11760.2 10858.7 11445.7 11521.9 11543.9 11774.9 9312.1 9362.3 9515.8 9548.5 9955.7 9894.0 10053.8 10072.6 10087.5 10096.9 17:58:39 INFO - PROCESS | 1679 | -------- Summary: end -------- 17:58:39 INFO - PROCESS | 1679 | 17:58:40 INFO - TEST-INFO | 1679: exit 0 17:58:40 INFO - TEST-OK | dromaeo_css | took 1114128ms 17:58:40 INFO - TEST-START | kraken 17:58:40 INFO - operating with platform_type : mac_ 17:58:40 INFO - Initialising browser for kraken test... 17:58:40 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmp39LBwG/profile http://localhost:49274/getInfo.html) 17:58:42 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 17:58:42 INFO - PROCESS | 1689 | colorDepth:24 17:58:42 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 17:58:42 INFO - PROCESS | 1689 | __metrics 17:58:42 INFO - PROCESS | 1689 | 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" 17:58:42 INFO - PROCESS | 1689 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:43 INFO - TEST-INFO | 1689: exit 0 17:58:43 INFO - Browser initialized. 17:58:43 INFO - Running cycle 1/1 for kraken test... 17:58:43 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmp39LBwG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:55 INFO - PROCESS | 1691 | RSS: Main: 244793344 17:58:55 INFO - PROCESS | 1691 | 17:58:57 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:58 INFO - PROCESS | 1691 | RSS: Main: 290168832 17:58:58 INFO - PROCESS | 1691 | 17:59:01 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 17:59:01 INFO - PROCESS | 1691 | RSS: Main: 299982848 17:59:01 INFO - PROCESS | 1691 | 17:59:04 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 17:59:05 INFO - PROCESS | 1691 | RSS: Main: 286916608 17:59:05 INFO - PROCESS | 1691 | 17:59:07 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 17:59:08 INFO - PROCESS | 1691 | RSS: Main: 289030144 17:59:08 INFO - PROCESS | 1691 | 17:59:10 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:59:10 INFO - PROCESS | 1691 | RSS: Main: 290951168 17:59:10 INFO - PROCESS | 1691 | 17:59:13 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 17:59:14 INFO - PROCESS | 1691 | RSS: Main: 289120256 17:59:14 INFO - PROCESS | 1691 | 17:59:17 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 17:59:17 INFO - PROCESS | 1691 | RSS: Main: 289341440 17:59:17 INFO - PROCESS | 1691 | 17:59:20 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 17:59:20 INFO - PROCESS | 1691 | RSS: Main: 289701888 17:59:20 INFO - PROCESS | 1691 | 17:59:22 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:59:23 INFO - PROCESS | 1691 | RSS: Main: 324222976 17:59:23 INFO - PROCESS | 1691 | 17:59:24 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:59:25 INFO - PROCESS | 1691 | RSS: Main: 323239936 17:59:25 INFO - PROCESS | 1691 | 17:59:27 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:59:28 INFO - PROCESS | 1691 | RSS: Main: 332279808 17:59:28 INFO - PROCESS | 1691 | 17:59:30 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:59:31 INFO - PROCESS | 1691 | RSS: Main: 334172160 17:59:31 INFO - PROCESS | 1691 | 17:59:33 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:34 INFO - PROCESS | 1691 | RSS: Main: 333414400 17:59:34 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 17:59:36 INFO - PROCESS | 1691 | RSS: Main: 394895360 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | __start_tp_report 17:59:36 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 17:59:36 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 17:59:36 INFO - PROCESS | 1691 | |i|pagename|runs| 17:59:36 INFO - PROCESS | 1691 | |0;ai-astar;111;107;109;110;111;111;116;110;110;109 17:59:36 INFO - PROCESS | 1691 | |1;audio-beat-detection;155;120;143;156;119;169;143;117;157;118 17:59:36 INFO - PROCESS | 1691 | |2;audio-dft;182;184;181;187;188;185;183;185;179;184 17:59:36 INFO - PROCESS | 1691 | |3;audio-fft;78;76;86;83;78;81;83;92;79;68 17:59:36 INFO - PROCESS | 1691 | |4;audio-oscillator;85;91;122;78;81;80;111;76;78;110 17:59:36 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;86;91;85;91;113;140;89;91;86;91 17:59:36 INFO - PROCESS | 1691 | |6;imaging-darkroom;95;95;94;94;93;94;93;101;94;94 17:59:36 INFO - PROCESS | 1691 | |7;imaging-desaturate;84;86;86;87;88;86;88;85;86;87 17:59:36 INFO - PROCESS | 1691 | |8;json-parse-financial;56;55;56;54;54;53;55;64;52;52 17:59:36 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;62;61;73;74;68;66;65;66;67;63 17:59:36 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;83;84;83;81;82;81;80;84;83;82 17:59:36 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;129;128;120;123;132;123;126;115;127;121 17:59:36 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;142;128;139;136;137;124;135;151;136;135 17:59:36 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;67;68;64;66;67;65;67;66;67;65 17:59:36 INFO - PROCESS | 1691 | __end_tp_report 17:59:36 INFO - PROCESS | 1691 | __start_cc_report 17:59:36 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,1205 17:59:36 INFO - PROCESS | 1691 | __end_cc_report 17:59:36 INFO - PROCESS | 1691 | __startTimestamp1455674376284__endTimestamp 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | ------- Summary: start ------- 17:59:36 INFO - PROCESS | 1691 | Number of tests: 14 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:2.32 (2.1%) stddev-sans-first:2.45 17:59:36 INFO - PROCESS | 1691 | Values: 111.0 107.0 109.0 110.0 111.0 111.0 116.0 110.0 110.0 109.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:149.00 stddev:19.67 (13.2%) stddev-sans-first:20.07 17:59:36 INFO - PROCESS | 1691 | Values: 155.0 120.0 143.0 156.0 119.0 169.0 143.0 117.0 157.0 118.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:2.70 (1.5%) stddev-sans-first:2.78 17:59:36 INFO - PROCESS | 1691 | Values: 182.0 184.0 181.0 187.0 188.0 185.0 183.0 185.0 179.0 184.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:80.40 Median:82.00 stddev:6.38 (7.8%) stddev-sans-first:6.71 17:59:36 INFO - PROCESS | 1691 | Values: 78.0 76.0 86.0 83.0 78.0 81.0 83.0 92.0 79.0 68.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:79.00 stddev:16.80 (21.3%) stddev-sans-first:17.67 17:59:36 INFO - PROCESS | 1691 | Values: 85.0 91.0 122.0 78.0 81.0 80.0 111.0 76.0 78.0 110.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:90.00 stddev:17.30 (19.2%) stddev-sans-first:17.95 17:59:36 INFO - PROCESS | 1691 | Values: 86.0 91.0 85.0 91.0 113.0 140.0 89.0 91.0 86.0 91.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:94.00 stddev:2.31 (2.5%) stddev-sans-first:2.45 17:59:36 INFO - PROCESS | 1691 | Values: 95.0 95.0 94.0 94.0 93.0 94.0 93.0 101.0 94.0 94.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.01 17:59:36 INFO - PROCESS | 1691 | Values: 84.0 86.0 86.0 87.0 88.0 86.0 88.0 85.0 86.0 87.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:3.45 (6.3%) stddev-sans-first:3.64 17:59:36 INFO - PROCESS | 1691 | Values: 56.0 55.0 56.0 54.0 54.0 53.0 55.0 64.0 52.0 52.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:4.30 (6.5%) stddev-sans-first:4.24 17:59:36 INFO - PROCESS | 1691 | Values: 62.0 61.0 73.0 74.0 68.0 66.0 65.0 66.0 67.0 63.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 17:59:36 INFO - PROCESS | 1691 | Values: 83.0 84.0 83.0 81.0 82.0 81.0 80.0 84.0 83.0 82.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.50 stddev:4.99 (3.9%) stddev-sans-first:5.01 17:59:36 INFO - PROCESS | 1691 | Values: 129.0 128.0 120.0 123.0 132.0 123.0 126.0 115.0 127.0 121.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:136.50 stddev:7.30 (5.4%) stddev-sans-first:7.45 17:59:36 INFO - PROCESS | 1691 | Values: 142.0 128.0 139.0 136.0 137.0 124.0 135.0 151.0 136.0 135.0 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 17:59:36 INFO - PROCESS | 1691 | Values: 67.0 68.0 64.0 66.0 67.0 65.0 67.0 66.0 67.0 65.0 17:59:36 INFO - PROCESS | 1691 | -------- Summary: end -------- 17:59:36 INFO - PROCESS | 1691 | 17:59:36 INFO - TEST-INFO | 1691: exit 0 17:59:37 INFO - TEST-OK | kraken | took 56712ms 17:59:37 INFO - SUITE-END | took 1170s 17:59:37 INFO - Completed test suite (00:19:31) 17:59:37 INFO - Working with test: dromaeo_css 17:59:37 INFO - Generating results file: dromaeo_css 17:59:37 INFO - Working with test: kraken 17:59:37 INFO - Generating results file: kraken 17:59:37 INFO - javascript benchmark 17:59:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:59:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 17:59:37 INFO - process_Request line: dromaeo_css 7386.45 graph.html#tests=[[72,64,59]] 17:59:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:59:37 INFO - process_Request line: kraken 1413.60 graph.html#tests=[[232,64,59]] 17:59:37 INFO - RETURN: dromaeo_css: 7386.45 17:59:37 INFO - RETURN: kraken: 1413.60 17:59:37 INFO - javascript benchmark 17:59:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2889.9885040235918, 3508.7193024558037, 3528.9823550882234, 3551.2187318789856, 3585.910352241194, 5707.4292570742955, 5719.08494640857, 5724.284464441945, 5754.683492407921, 5784.595078344518, 5584.357798853133, 5690.5447564194865, 5694.487496125348, 5801.680907550083, 5832.883342333151, 5158.123119069767, 5186.636935414523, 5191.558717509016, 5232.424433312332, 5329.014132385521, 5314.548263397596, 5321.6540924839765, 5349.0, 5367.436419175989, 5394.595405344595, 5191.974040129775, 5212.192110222903, 5271.341082364705, 5279.0, 5294.10000299948, 5215.400228973679, 5220.556252718486, 5225.4513276105845, 5227.059129356714, 5283.445238249967, 5154.716490593016, 5187.48125187482, 5196.8960620787375, 5217.895642087175, 5218.869528261824, 5535.474129957688, 5613.0, 5619.887602247973, 5647.576431767634, 5684.54523638108, 6214.8135555933395, 6221.222347206599, 6226.439620434183, 6254.34329395416, 6319.241690997063, 5310.176922577007, 6200.844978875519, 6266.561340706153, 6299.212598425197, 6319.6524191169465, 5821.970890145522, 5836.708164591753, 5848.502877255396, 5850.6782126983, 5901.17383566301, 5259.921101183485, 6188.535859810442, 6220.657863817443, 6273.874522509615, 6298.464630506367, 6192.102145189013, 6217.782377616762, 6222.688865556704, 6224.190855188796, 6250.843728906813, 6158.7228574714245, 6331.620102793847, 6341.3341599132345, 6348.206474190726, 6359.3640635936035, 5064.392272927199, 6215.34738852423, 6306.590071645328, 6313.463355614824, 6320.968395157995, 6282.18331616896, 6310.873782524323, 6313.0, 6314.747410103544, 6326.082718005863, 4842.15262329098, 4864.318995340655, 4915.26271059344, 4919.581835543947, 4968.652194346361, 4449.443819522559, 4470.530594287618, 4471.731696098244, 4480.39514665516, 4517.051419201939, 5695.088785794253, 5770.5095066919785, 5782.479576838105, 5808.30300363959, 5836.562257830679, 6309.495240380758, 6315.0, 6317.1156038154695, 6324.71538780756, 6332.778352757631, 4485.327200919888, 5294.338207724035, 5366.221897824872, 5672.461116193955, 5722.141678748138, 5342.439043900412, 5353.384360798558, 5376.973115134399, 5383.273258110184, 5443.074677304868, 6251.156093927261, 6278.497720182374, 6297.055441683692, 6307.716152773136, 6311.810645680637, 6237.781677641261, 6257.874842503215, 6310.936890631035, 6316.7157477914525, 6323.9683801580695, 6260.937390626035, 6295.3704629538515, 6326.0510923360025, 6356.650384228912, 6372.490200784019, 6217.347178546188, 6251.156093927261, 6254.749810007731, 6257.0, 6263.404976527223, 6200.286966998853, 6304.464120549805, 6308.243010838729, 6323.051542268512, 6323.051542268697, 6065.059915713072, 6117.785877494266, 6127.6936153193055, 6164.260288765377, 6180.0, 6127.479164270909, 6139.0, 6153.292371377349, 6158.107074474086, 6158.507319414346, 5767.423257674367, 5776.797812076557, 5938.406159384027, 5995.730192141451, 6070.575059745775, 6096.417461711209, 6174.351693072343, 6177.166082578794, 6183.5671502994355, 6186.288576813724, 4991.251312303184, 5998.993858552326, 6017.909731354121, 6032.426919442646, 6065.514758819372], "unit": "score", "name": "dojo.html", "value": 5705.693306204127}, {"lowerIsBetter": false, "replicates": [477.2650118817022, 527.6174773289363, 528.735632183908, 584.5937073733754, 614.3978900677336, 24420.023199072017, 29069.273268168305, 29412.0, 29457.821687132542, 29465.558016629766, 30430.23924401891, 37731.62268377315, 38330.8083459583, 38416.03959901004, 38628.841134765935, 8256.298214651732, 8260.710875119372, 9404.905950940489, 9564.426134431922, 9570.617175312978, 9326.393784403992, 9488.573014214342, 9488.952555237249, 9499.572519236652, 9515.23878089751, 9464.337496375256, 9522.285828562852, 9548.713538593853, 9550.665726699566, 9636.229101671885, 9567.56945937431, 9630.98874618162, 9636.42181469114, 9636.662716804949, 9658.420494770266, 9525.428474291495, 9637.951810240975, 9646.565904534313, 9655.372400793925, 9660.082292182231, 37961.810190949145, 38349.424758628644, 38358.23283534341, 38417.807910960546, 38503.61496385028, 3008.5637582550407, 3465.237647717498, 3612.8916132516065, 3710.7402481826284, 3989.122393073548, 27631.44081226595, 27822.582661260098, 27982.580261296098, 28160.43679126406, 28454.66612972984, 2579.729128441524, 2774.597683335925, 2787.5261205595098, 2943.1170648805273, 2962.4075184963094, 375773.0, 376126.0, 376603.0, 377146.0, 377505.0, 50659.73350666189, 51541.742291288305, 51722.0, 58616.413835861094, 59312.703436482545, 50804.49195508072, 61390.693046534485, 62896.0, 62948.37051629517, 63216.68391658012, 15496.767548486781, 15510.84489155094, 15685.05889646625, 15693.215339232993, 15727.44953926607, 11954.222975506564, 12016.759664806656, 12030.578929737418, 12031.0, 12099.395030248452, 13687.726245475034, 16078.75881861773, 16422.0, 16434.178291085398, 18062.729059064124, 7779.4554381192775, 7892.605369731606, 7897.842043159105, 7908.52548847071, 7967.402444816662, 823.3536673711108, 919.6597259014208, 945.6548359848606, 1065.4086981725218, 1078.164422572497, 29209.0, 29273.268168295963, 29297.707022929924, 29972.0, 29979.0, 1025.3266560211891, 1073.9301945373525, 1087.7117563845586, 1105.2042529378834, 1150.8676502202354, 13112.868871311355, 13249.271290079138, 13296.202227866359, 13335.199888006751, 13339.06626536133, 526186.0, 529604.0, 530885.0, 532160.0, 533097.0, 51066.723331917, 51837.740811295705, 51905.0, 51933.96132077337, 52083.218751718756, 1306.8627794081674, 1424.1739790921447, 1426.686129051607, 1426.86444787745, 1461.751502244621, 23940.34889702327, 25786.742132579184, 27491.450170996868, 28185.43629127447, 28455.857720711265, 42105.57894421017, 46357.304640431095, 46843.063138737714, 46868.0, 46911.530884690714, 475196.0, 477156.0, 477964.0, 478858.0, 479690.0, 26605.7339426611, 28668.28329291701, 30355.696443035285, 30883.0, 31278.0, 37624.0, 37820.43269350907, 37881.43177852279, 38353.0, 38593.614063859, 32170.35659286848, 32971.0, 33199.502007469426, 33223.33553328968, 35217.647823522464, 27680.86159569189, 33676.831615841766, 33947.49078763771, 34262.0, 34363.0, 32515.349693005533, 33135.83432082824, 33152.66847331592, 33681.663183367855, 34369.65630343665, 28944.56583151212, 29918.25204369908, 29971.400571988874, 31127.84436077805, 31729.524057139624, 23299.068037278317, 23359.766402336438, 23641.881790591626, 23656.580605163745, 23667.171648992204], "unit": "score", "name": "ext.html", "value": 18446.344979725003}, {"lowerIsBetter": false, "replicates": [362.78414343465636, 367.86756767563674, 370.242853364869, 373.78133791731835, 376.17617417854876, 15530.912836101477, 15632.921835390836, 18622.348217812378, 19656.21375144994, 20354.185832566698, 11303.26528775629, 11454.942725286362, 11746.00158986485, 11763.294202347864, 11775.7644847103, 3932.370820668694, 5103.2090026045835, 5292.761825717833, 5296.523312901838, 5301.655392399501, 4018.2365350583295, 5752.0, 5999.250093738283, 6009.218801555791, 6016.398360163992, 5955.88088238235, 6045.093236014611, 6380.776672816452, 6384.680765961706, 6393.872122557546, 5836.5914385993, 5954.434328738763, 6148.200733904586, 6323.715432805535, 6362.109304697323, 5662.490375866192, 5671.602987790856, 5672.092465205588, 5677.063284558043, 5678.26182596264, 18311.908440457846, 20211.393658190133, 21712.457188570253, 22337.441563960867, 24523.386915327083, 2155.0, 2182.74898386686, 2193.5283913958574, 2201.559688062378, 2672.652555167835, 9667.661631842922, 10017.348872323275, 10069.899301007043, 10861.239713220079, 11986.70033249167, 1701.2854601067459, 1722.078687901979, 1731.919858983592, 1740.651869626067, 1789.2574581548643, 90394.5480272601, 96778.51610741901, 96812.51593742057, 98417.5079124607, 98767.50616246945, 9133.771655708528, 10825.458727063615, 11041.0, 11063.0, 11135.721606959729, 13217.273049982343, 13310.467581296833, 13326.400311985984, 13332.200067995951, 13372.130811497222, 6773.559718618372, 8298.128696486903, 8311.501309921425, 8389.706360277483, 8393.076761556224, 6885.965570172117, 8357.373197010249, 8379.832403351898, 8384.077751447336, 8447.493150410872, 3964.0, 4147.668186545069, 4217.936730948977, 4318.460192475941, 4430.8449204277695, 1791.2745338138075, 1806.3677712800677, 1812.3481185411406, 1813.4559632110313, 1828.1407738362948, 802.3140215116108, 887.272436601993, 900.5137225897942, 936.1293996583107, 974.2254907348674, 11115.0, 17660.823391766175, 19176.616467670567, 19181.424557263304, 19289.421317360502, 914.7530166854912, 917.6054296652503, 931.3945935142211, 958.5734348215117, 958.836997710391, 8676.392652514389, 9047.81904361909, 10184.338018028804, 10566.93054876155, 10621.53895363949, 699231.0, 729818.0, 730899.0, 750085.0, 753915.0, 103199.48400257951, 103254.48372758088, 105603.0, 106334.0, 107416.46291768647, 1114.6098865397046, 1121.472907733364, 1165.7610189911047, 1180.8819118088295, 1182.834403183555, 14413.85586144125, 16779.900460756035, 17464.0, 17656.0, 17885.910570447584, 49739.25912593042, 49781.50218497769, 50500.73748156326, 50519.0, 51456.0, 63625.363746361945, 64604.35395646172, 70496.64751676208, 73863.63068184625, 74459.0, 7184.568925864465, 7605.543667379975, 7634.4655874088285, 7639.923600763921, 7704.0, 10178.0, 11559.653210403701, 11927.522899084286, 11973.700657483632, 12032.578859739868, 9854.605815767289, 10184.694459166238, 10371.118454931415, 10433.32183408076, 10630.468476576294, 10258.12805911476, 10324.831785325166, 10373.896261037595, 10445.895541044492, 10600.0, 10070.748231293983, 10401.791964160826, 10480.842787358044, 10504.527296271533, 10766.031057204576, 5539.723013849372, 5691.800786972436, 6740.831479213059, 7339.70641174347, 7479.513831600929, 7867.606619669108, 8198.50808951441, 10047.0, 10397.272190946562, 10413.062824345845], "unit": "score", "name": "jquery.html", "value": 8856.464732885232}, {"lowerIsBetter": false, "replicates": [1426.0017987408817, 1533.9233038348084, 1572.7876736640558, 1791.5342011077116, 1922.5482011727233, 8126.796830079244, 8898.110188981098, 9063.27493800496, 9110.681126160578, 9119.224865886392, 8761.299096072315, 9011.729648110551, 9033.72898813035, 9043.547822608876, 9046.819063618723, 2141.0, 2211.5908556916943, 2263.106073101124, 2444.8533088014688, 2488.3903443656286, 2127.7446706395253, 2150.2474134053114, 2525.6211568264816, 2531.0508559290265, 2542.288159315385, 2414.1550457339877, 2482.044412901037, 2483.2301986384186, 2484.3416494628937, 2490.601503759399, 2194.9780502194935, 2248.6177349850564, 2253.5605556916407, 2255.9661605075935, 2445.2297526279167, 2497.5878979968466, 2520.117958714454, 2524.406764410362, 2529.3297276221633, 2531.227975467482, 8757.080506546785, 8923.643054277822, 8932.285417166677, 8932.910670893272, 8960.283177345862, 4584.381108550337, 5477.068898287301, 5501.0, 5530.5022547970875, 5547.140193270049, 3553.182767963357, 3653.0582996871867, 3703.5926048134684, 3741.401375779862, 3750.2124553843723, 1052.2375021838466, 1056.9048785609255, 1083.4203701019994, 1092.1317552545745, 1104.5471356743697, 12412.75174496505, 12416.937915310456, 12424.068194885329, 12438.502459901592, 12448.439820208112, 4824.879378015507, 4976.701397916137, 5004.449510553836, 5040.36995375578, 5048.040872234264, 10524.0, 10542.789144217073, 10548.314359566604, 10548.525316360781, 10554.683359499228, 5632.633878797865, 5633.380328163898, 5636.098224284095, 5672.8865422691315, 5680.0, 5102.234664800236, 5139.023585518739, 5140.794368225229, 5143.948560514422, 5147.0735267651435, 3331.866725331008, 4025.456563363967, 4035.4552135461336, 4037.273290807624, 4078.3066878630702, 1324.132693086011, 1325.1452812935602, 1331.6071758831167, 1337.2979185927466, 1345.6703107738667, 1328.614701736505, 1330.8802207801343, 1332.8467226268908, 1342.6576223063057, 1371.2595198592649, 8289.212524810133, 8321.08468068512, 8344.040435350013, 8462.619182136696, 8464.619092140869, 509.2666560153367, 513.2685922560337, 518.7380372911656, 520.7136075158647, 520.9765560549785, 5711.9718450679275, 6064.9090263646085, 6193.287771906288, 6199.287081985539, 6200.596961197508, 10539.894601054044, 10692.0, 10936.56253749841, 10987.945060274807, 11025.44872756359, 10720.303180293256, 10737.248392612599, 10822.971817677308, 10830.40432776205, 10836.458177091272, 8245.309711509126, 8326.6669333226, 8484.915150848536, 8545.102764209792, 8556.358273129541, 8306.127856574973, 8320.958395207985, 8489.023762267418, 8513.659453621785, 8520.573971301534, 9758.755486238348, 9787.46168960714, 10092.34399764013, 10114.393136411838, 10228.028337307944, 10115.645952391631, 10414.47927603632, 10421.166306695597, 10480.318779279323, 10526.210534209811, 8181.754547363588, 8312.6674933002, 8419.200175983271, 8428.831423371375, 8438.620262088098, 8340.666373344999, 8412.87380689278, 8425.4944703318, 8434.789130271793, 8442.873356899529, 7843.764687059397, 7985.241402066795, 7985.64064617082, 8093.231143041402, 8149.062857771195, 7772.145064043064, 7796.0, 7836.255555722198, 7948.8807667883875, 7987.48081374732, 7965.128194874084, 8009.799755006172, 8018.639161237642, 8027.2775450209765, 8043.597820108854, 6674.199096108498, 6840.3501667341525, 6843.041974123527, 6843.3840954314355, 7265.309795569412, 6698.229703583956, 7266.164391095092, 7292.708291668274, 7310.159331676712, 7310.96344518274], "unit": "score", "name": "mootools.html", "value": 4950.274734088578}, {"lowerIsBetter": false, "replicates": [319.99200019999495, 326.6504839821392, 331.3786650031191, 335.6727190988785, 340.03430258067084, 6365.872682546358, 6522.282548919615, 6542.672866356675, 6561.589258309463, 6630.569013014157, 6350.269718982307, 6503.0, 6529.085927970088, 6540.149780528536, 6566.5075119366, 4259.531451540328, 4864.10014147383, 4866.3673722416215, 4904.190808516591, 4910.75446227689, 4661.953380466202, 4759.857204283877, 4777.593904518103, 4855.975720121394, 4916.213405855064, 4777.928331075037, 4785.832495862645, 4797.808087676489, 4816.0, 4823.927641085386, 4790.065937142259, 4801.567858892681, 4812.35033270511, 4823.831165909176, 4831.106245344622, 3769.736118471708, 3826.521684789401, 4134.565870583576, 4144.046869220097, 4158.272302347077, 5929.644221346733, 6184.907226391608, 6198.876022479571, 6216.471599914013, 6266.655333956631, 4534.5692159245145, 4545.931811022837, 5482.972585137089, 5504.7522861470925, 5511.917321240185, 5882.941170588282, 6638.435732962704, 6785.6267905265195, 6834.658267086676, 6955.165380154363, 4590.242609969385, 4635.8377456789185, 4655.8593144679435, 4657.767111644404, 4666.719996800169, 7141.642917854138, 7278.927210727931, 7311.926880731178, 7370.115586129698, 7386.113666360017, 4596.908061838744, 4749.525047495223, 4759.785809638574, 4766.475687674353, 4777.641676874248, 4114.341705327133, 4837.153498137812, 4849.539293767087, 4857.9028419431415, 4862.82980095695, 5159.045576568347, 5275.208718692227, 5660.773569057192, 5683.403242659544, 5719.5996280260815, 6997.230304666483, 7008.404285635676, 7009.474289428314, 7017.859642807115, 7021.122359705037, 1412.4632639596887, 1554.8989315694444, 1660.5350501859498, 1688.797344318665, 1691.7631531585587, 1086.3101930274333, 1098.2970898624887, 1103.812351900179, 1115.3363748569589, 1115.8382034604938, 6488.902666459912, 6494.993276042221, 6500.0, 6533.738650454024, 6538.934610653928, 7232.927670723226, 7238.384737297283, 7251.746188883364, 7252.601106939063, 7313.780586582411, 6301.747930082837, 6467.2562655294305, 6482.481401487964, 6484.383983521652, 6515.7067931943175, 3825.0437390652337, 3852.0, 3854.2291541691775, 3856.2865869814173, 3856.8842934712, 7512.962435187789, 7518.248175182438, 7557.508761930457, 7562.621868906533, 7607.581583012877, 7260.41916646667, 7457.0305860238905, 7475.8504829903095, 7488.737894173678, 7498.887516687254, 7515.774526764206, 7537.321641052332, 7538.246175382418, 7548.735794247065, 7555.659995300225, 6995.775739245713, 7150.284971502808, 7237.782866514013, 7292.942523333981, 7328.230535793665, 7113.03973963529, 7143.892841607484, 7148.714051437884, 7150.892736609059, 7254.709811607477, 7305.707771689073, 7544.509606875536, 7585.165631780389, 7604.5437273763755, 7614.200508946702, 4785.712857228577, 4799.400074990626, 4800.5199480051715, 4804.807807687654, 4805.975970120127, 7257.782266532013, 7260.818479538054, 7267.200607933229, 7268.781936541912, 7275.963620181865, 6830.45356371499, 6953.617551034539, 7001.159860816734, 7004.15950085993, 7007.0, 6982.0, 6994.405475534433, 6994.895076573754, 7011.4390848733, 7012.298770123151, 6841.794746157623, 6844.452443804584, 6849.1780986281965, 6871.14110736158, 6886.69009894566, 6792.728290868507, 7028.367446929801, 7034.859302813813, 7055.082839231072, 7079.43364530826, 6861.725530978705, 6878.209005964178, 6882.311768823278, 6886.690098945459, 6886.69009894566], "unit": "score", "name": "prototype.html", "value": 5121.161515343783}, {"lowerIsBetter": false, "replicates": [678.0744284052269, 683.1494788987711, 753.2806170107548, 768.4428789127883, 786.4887822915105, 14589.343479543419, 14755.0, 14768.335424905878, 14774.482893098744, 14778.482753103644, 13101.0, 13444.462221511152, 13453.596392108228, 13459.596212113627, 13486.393112309945, 690.0994202565649, 700.3976580141075, 843.0936743001267, 849.1041950741965, 870.5560164316213, 857.8069934264772, 867.8481265778495, 869.7173418638936, 870.264626390702, 870.7039606533777, 909.1090731083542, 913.8492148795441, 914.8033172867832, 915.7069737683944, 916.1434059154711, 722.5664601239267, 730.2223132364041, 732.6776218463859, 734.177720952534, 878.3807415771929, 681.151965802574, 681.1553673444943, 681.2234053179379, 681.5195287322426, 682.7917485167022, 14346.0, 14380.209088500129, 14398.85601143996, 14435.206063666494, 14478.638034049127, 12202.938985305105, 12387.274799544177, 12506.124571280014, 12721.936390318082, 12955.028372872071, 9890.505474726235, 10176.389416634951, 10193.439360835151, 10204.744881378025, 10205.0, 3525.2773181497732, 3551.5738111426795, 3552.626974167701, 3553.538040054802, 3558.6085530591613, 72156.6392168041, 75212.62393688051, 78674.81987770245, 78728.81906771404, 78847.42305153923, 9513.33406661527, 9552.856707149398, 9588.760280992892, 9745.853812192823, 9748.756281093029, 21124.577508449744, 21181.258655946967, 21186.258480953093, 21205.939703015098, 21209.469763256042, 7452.485071700494, 7470.589117598475, 7513.924860751323, 7748.380129589619, 7759.262870027338, 3633.927321453556, 3779.3575092234387, 4069.369247766601, 4143.212789570032, 4224.471941007374, 3549.94675079874, 3601.837917293728, 3605.0, 3615.457681347819, 3616.150204701893, 652.5236577298599, 672.2235817630644, 673.5049738442241, 674.8751480976035, 683.0710234081744, 572.619208226533, 613.0742578706097, 613.3866133866134, 627.8618703885138, 645.9418652321219, 8114.878276825734, 8543.102974187745, 8557.48655080697, 8601.61292741828, 8770.3422243332, 513.4531723714232, 589.2163422647868, 593.4777395891588, 611.9082137679295, 668.1481111582771, 3785.507883975121, 3918.3534716771983, 3924.9215015699524, 4124.278251306009, 4487.528809475023, 87090.0, 93196.53401732948, 93772.53113734387, 94048.0, 94805.5259723697, 76985.0, 77877.0, 78800.0, 79048.0, 82387.17612823794, 71226.64386678033, 71554.0, 71845.6407717958, 71963.0, 72176.63911680513, 8718.60766265507, 8745.431546949429, 8788.956055219684, 8836.381453298207, 9006.729798106067, 36552.0, 51352.0, 51764.0, 51817.70455738486, 52110.0, 66820.66589667214, 68979.27551811044, 69418.0, 69939.0, 70903.22741931494, 10856.728581785519, 10953.17851161182, 11012.17408694367, 11340.0, 12044.879551204725, 8820.91179088201, 12253.203541769757, 12317.384130793604, 12342.01263898904, 12587.24476531411, 11664.88335116638, 11669.299842009506, 11741.471633776671, 11782.823257651313, 11882.28706277626, 11667.474963626488, 11689.766204676029, 11734.530618775154, 11751.529938802694, 11760.176787624785, 10858.67423977282, 11445.713857153638, 11521.88478115208, 11543.942280288546, 11774.882251177378, 9312.115349041831, 9362.29782766309, 9515.762105947406, 9548.522573871418, 9955.701328960144, 9894.0, 10053.798924021625, 10072.597096116073, 10087.495625218857, 10096.949515252376], "unit": "score", "name": "yui.html", "value": 6872.370727706647}], "name": "dromaeo_css", "value": 7386.451616117496}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 109.0, 110.0, 111.0, 111.0, 116.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 143.0, 156.0, 119.0, 169.0, 143.0, 117.0, 157.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 139.7}, {"lowerIsBetter": true, "replicates": [182.0, 184.0, 181.0, 187.0, 188.0, 185.0, 183.0, 185.0, 179.0, 184.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 86.0, 83.0, 78.0, 81.0, 83.0, 92.0, 79.0, 68.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 122.0, 78.0, 81.0, 80.0, 111.0, 76.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 91.2}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 85.0, 91.0, 113.0, 140.0, 89.0, 91.0, 86.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 94.0, 93.0, 94.0, 93.0, 101.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.7}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 87.0, 88.0, 86.0, 88.0, 85.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 54.0, 54.0, 53.0, 55.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 73.0, 74.0, 68.0, 66.0, 65.0, 66.0, 67.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 81.0, 82.0, 81.0, 80.0, 84.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [129.0, 128.0, 120.0, 123.0, 132.0, 123.0, 126.0, 115.0, 127.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [142.0, 128.0, 139.0, 136.0, 137.0, 124.0, 135.0, 151.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 64.0, 66.0, 67.0, 65.0, 67.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1413.6000000000001}]} 17:59:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1413.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7386.45"}}} 17:59:37 INFO - Return code: 0 17:59:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:59:37 INFO - # TBPL SUCCESS # 17:59:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:37 INFO - 2016-02-16 17:59:37.708 screenresolution[1695:10041] starting screenresolution argv=screenresolution get 17:59:37 INFO - 2016-02-16 17:59:37.710 screenresolution[1695:10041] Display 0: 1600x1200x32@60 17:59:37 INFO - 2016-02-16 17:59:37.716 screenresolution[1696:10044] starting screenresolution argv=screenresolution list 17:59:37 INFO - Available Modes on Display 0 17:59:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:37 INFO - Intel Iris: 17:59:37 INFO - Chipset Model: Intel Iris 17:59:37 INFO - Type: GPU 17:59:37 INFO - Bus: Built-In 17:59:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:37 INFO - Vendor: Intel (0x8086) 17:59:37 INFO - Device ID: 0x0a2e 17:59:37 INFO - Revision ID: 0x0009 17:59:37 INFO - Displays: 17:59:37 INFO - Display: 17:59:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:37 INFO - Display Serial Number: 1600x1200 60 17:59:37 INFO - Main Display: Yes 17:59:37 INFO - Mirror: Off 17:59:37 INFO - Online: Yes 17:59:37 INFO - Rotation: Supported 17:59:37 INFO - Return code: 0 17:59:37 INFO - Running post-action listener: _resource_record_post_action 17:59:37 INFO - Running post-run listener: _resource_record_post_run 17:59:39 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39433728; Write bytes: 709368832; Read time: 423; Write time: 2017 17:59:39 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391072256; Write bytes: 386344448; Read time: 30128; Write time: 740 17:59:39 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38450688; Write bytes: 301811200; Read time: 408; Write time: 1233 17:59:39 INFO - Running post-run listener: _upload_blobber_files 17:59:39 INFO - Blob upload gear active. 17:59:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:39 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 17:59:39 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'] 17:59:39 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 17:59:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:59:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:40 INFO - (blobuploader) - INFO - Done attempting. 17:59:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:59:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:59:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:41 INFO - (blobuploader) - INFO - Done attempting. 17:59:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:41 INFO - Return code: 0 17:59:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/934c60d9cbda88edba7d7465a0b11060ecbde25d77dd7ee5d792b83fb0721013cff03f61bc393cec592c8427d0fe6272d2d8b7ba43f0eef3dc90fdbd470ce16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b9dd35bf5ca5039c9f800dc515d6ff8f1e70cc444d329ba8c9a7f62f47bfc36c7d85cd9377b10b408f57c65ce8233da4a6d543a529eb507d2f913df6d83d3b"} 17:59:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:41 INFO - Contents: 17:59:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/934c60d9cbda88edba7d7465a0b11060ecbde25d77dd7ee5d792b83fb0721013cff03f61bc393cec592c8427d0fe6272d2d8b7ba43f0eef3dc90fdbd470ce16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b9dd35bf5ca5039c9f800dc515d6ff8f1e70cc444d329ba8c9a7f62f47bfc36c7d85cd9377b10b408f57c65ce8233da4a6d543a529eb507d2f913df6d83d3b"} 17:59:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:41 INFO - Copying logs to upload dir... 17:59:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.278469 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-16 17:59:41.714293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 17:59:41.719564) ========= 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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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/934c60d9cbda88edba7d7465a0b11060ecbde25d77dd7ee5d792b83fb0721013cff03f61bc393cec592c8427d0fe6272d2d8b7ba43f0eef3dc90fdbd470ce16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b9dd35bf5ca5039c9f800dc515d6ff8f1e70cc444d329ba8c9a7f62f47bfc36c7d85cd9377b10b408f57c65ce8233da4a6d543a529eb507d2f913df6d83d3b"} build_url:https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/CWuQr0VUQz22zmgkEZ9ReA/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/934c60d9cbda88edba7d7465a0b11060ecbde25d77dd7ee5d792b83fb0721013cff03f61bc393cec592c8427d0fe6272d2d8b7ba43f0eef3dc90fdbd470ce16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88b9dd35bf5ca5039c9f800dc515d6ff8f1e70cc444d329ba8c9a7f62f47bfc36c7d85cd9377b10b408f57c65ce8233da4a6d543a529eb507d2f913df6d83d3b"}' ========= master_lag: 0.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 17:59:42.048946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 17:59:42.049250) ========= 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.ASxXkflsAm/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.iG4KY3Za2d/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.005184 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 17:59:42.082148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 17:59:42.085494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 17:59:42.091484) ========= ========= Total master_lag: 27.14 =========