builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0060 starttime: 1458175779.65 results: success (0) buildid: 20160316162107 builduid: 985daf6eae2e4da590be172e68d08f2c revision: a4c6d6add2fcbc4bf847270cf27ff23334e2f170 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.649536) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.650157) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.650552) ========= 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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005548 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.676480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.676851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.695198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.695644) ========= 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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005470 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.745198) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.745563) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.746009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.746325) ========= 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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-16 17:49:39-- 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% 10.6M=0.001s 2016-03-16 17:49:39 (10.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.920382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.920710) ========= 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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.027141 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:39.969304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-16 17:49:39.969643) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a4c6d6add2fcbc4bf847270cf27ff23334e2f170 --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 a4c6d6add2fcbc4bf847270cf27ff23334e2f170 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-16 17:49:40,046 truncating revision to first 12 chars 2016-03-16 17:49:40,046 Setting DEBUG logging. 2016-03-16 17:49:40,046 attempt 1/10 2016-03-16 17:49:40,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a4c6d6add2fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 17:49:41,840 unpacking tar archive at: fx-team-a4c6d6add2fc/testing/mozharness/ program finished with exit code 0 elapsedTime=2.027742 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-16 17:49:42.014078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:42.014422) ========= echo a4c6d6add2fcbc4bf847270cf27ff23334e2f170 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4c6d6add2fcbc4bf847270cf27ff23334e2f170'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 a4c6d6add2fcbc4bf847270cf27ff23334e2f170 program finished with exit code 0 elapsedTime=0.005038 script_repo_revision: 'a4c6d6add2fcbc4bf847270cf27ff23334e2f170' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:42.063457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:42.063763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:49:42.077483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-16 17:49:42.077821) ========= /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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:49:42 INFO - MultiFileLogger online at 20160316 17:49:42 in /builds/slave/test 17:49:42 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:49:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:42 INFO - {'append_to_log': False, 17:49:42 INFO - 'base_work_dir': '/builds/slave/test', 17:49:42 INFO - 'blob_upload_branch': 'Fx-Team', 17:49:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:42 INFO - 'branch': 'Fx-Team', 17:49:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:42 INFO - 'config_files': ('talos/mac_config.py',), 17:49:42 INFO - 'default_actions': ('clobber', 17:49:42 INFO - 'read-buildbot-config', 17:49:42 INFO - 'download-and-extract', 17:49:42 INFO - 'populate-webroot', 17:49:42 INFO - 'create-virtualenv', 17:49:42 INFO - 'install', 17:49:42 INFO - 'run-tests'), 17:49:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:42 INFO - 'download_minidump_stackwalk': True, 17:49:42 INFO - 'download_symbols': 'ondemand', 17:49:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:42 INFO - 'installer_path': 'installer.exe', 17:49:42 INFO - 'log_level': 'info', 17:49:42 INFO - 'log_name': 'talos', 17:49:42 INFO - 'log_to_console': True, 17:49:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:49:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:49:42 INFO - 'opt_config_files': (), 17:49:42 INFO - 'pip_index': False, 17:49:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:42 INFO - 'cmd': ('bash', 17:49:42 INFO - '-c', 17:49:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:42 INFO - 'enabled': True, 17:49:42 INFO - 'halt_on_failure': False, 17:49:42 INFO - 'name': 'check_screen_resolution'},), 17:49:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:49:42 INFO - 'cmd': ('bash', 17:49:42 INFO - '-c', 17:49:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:49:42 INFO - 'enabled': True, 17:49:42 INFO - 'halt_on_failure': False, 17:49:42 INFO - 'name': 'check_screen_resolution'},), 17:49:42 INFO - 'run_cmd_checks_enabled': True, 17:49:42 INFO - 'sps_profile': False, 17:49:42 INFO - 'sps_profile_interval': 0, 17:49:42 INFO - 'suite': 'dromaeojs', 17:49:42 INFO - 'system_bits': '32', 17:49:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:42 INFO - 'title': 't-yosemite-r7-0060', 17:49:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:42 INFO - 'use_talos_json': True, 17:49:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:42 INFO - 'work_dir': 'build'} 17:49:42 INFO - ##### 17:49:42 INFO - ##### Running clobber step. 17:49:42 INFO - ##### 17:49:42 INFO - Running pre-action listener: _resource_record_pre_action 17:49:42 INFO - Running main action method: clobber 17:49:42 INFO - rmtree: /builds/slave/test/build 17:49:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:43 INFO - Running post-action listener: _resource_record_post_action 17:49:43 INFO - ##### 17:49:43 INFO - ##### Running read-buildbot-config step. 17:49:43 INFO - ##### 17:49:43 INFO - Running pre-action listener: _resource_record_pre_action 17:49:43 INFO - Running main action method: read_buildbot_config 17:49:43 INFO - Using buildbot properties: 17:49:43 INFO - { 17:49:43 INFO - "project": "", 17:49:43 INFO - "product": "firefox", 17:49:43 INFO - "script_repo_revision": "production", 17:49:43 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:49:43 INFO - "repository": "", 17:49:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:49:43 INFO - "buildid": "20160316162107", 17:49:43 INFO - "pgo_build": "False", 17:49:43 INFO - "basedir": "/builds/slave/test", 17:49:43 INFO - "buildnumber": 511, 17:49:43 INFO - "slavename": "t-yosemite-r7-0060", 17:49:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:49:43 INFO - "platform": "yosemite_r7", 17:49:43 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:49:43 INFO - "branch": "fx-team", 17:49:43 INFO - "repo_path": "integration/fx-team", 17:49:43 INFO - "revision": "a4c6d6add2fcbc4bf847270cf27ff23334e2f170", 17:49:43 INFO - "stage_platform": "macosx64", 17:49:43 INFO - "builduid": "985daf6eae2e4da590be172e68d08f2c", 17:49:43 INFO - "slavebuilddir": "test" 17:49:43 INFO - } 17:49:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:49:43 INFO - Running post-action listener: _resource_record_post_action 17:49:43 INFO - ##### 17:49:43 INFO - ##### Running download-and-extract step. 17:49:43 INFO - ##### 17:49:43 INFO - Running pre-action listener: _resource_record_pre_action 17:49:43 INFO - Running main action method: download_and_extract 17:49:43 INFO - mkdir: /builds/slave/test/build/tests 17:49:43 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:49:43 INFO - https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:49:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:49:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:49:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 17:49:45 INFO - Downloaded 1199 bytes. 17:49:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:49:45 INFO - Using the following test package requirements: 17:49:45 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:49:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:49:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:49:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'jsshell-mac.zip'], 17:49:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:49:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:49:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:49:45 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:49:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:49:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:49:45 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:49:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:49: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:49:45 INFO - https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:49:46 INFO - Downloaded 17854464 bytes. 17:49:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:49:49 INFO - Return code: 0 17:49:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:49 INFO - https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:49:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:49:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:49:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:49:50 INFO - Downloaded 17854464 bytes. 17:49:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:49:53 INFO - Return code: 0 17:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:53 INFO - https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:49:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:49:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:49:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:49:55 INFO - Downloaded 10846462 bytes. 17:49:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:49:56 INFO - Return code: 0 17:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:56 INFO - https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:49:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:49:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:49:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 17:49:58 INFO - Downloaded 111193090 bytes. 17:49:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:49:58 INFO - mkdir: /builds/slave/test/properties 17:49:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:58 INFO - Contents: 17:49:58 INFO - build_url:https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:50:00 INFO - Running post-action listener: _resource_record_post_action 17:50:00 INFO - Running post-action listener: set_extra_try_arguments 17:50:00 INFO - ##### 17:50:00 INFO - ##### Running populate-webroot step. 17:50:00 INFO - ##### 17:50:00 INFO - Running pre-action listener: _resource_record_pre_action 17:50:00 INFO - Running main action method: populate_webroot 17:50:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:50:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:50:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:50:00 INFO - '--tppagecycles', 17:50:00 INFO - '7'], 17:50:00 INFO - 'tests': ['tsvgm']}}, 17:50:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:50:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:50:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:50:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'tests': ['damp', 'tps']}, 17:50:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['damp', 'tps']}, 17:50:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:50:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:00 INFO - 'other': {'tests': ['a11yr', 17:50:00 INFO - 'ts_paint', 17:50:00 INFO - 'tpaint', 17:50:00 INFO - 'sessionrestore', 17:50:00 INFO - 'sessionrestore_no_auto_restore', 17:50:00 INFO - 'tabpaint']}, 17:50:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['a11yr', 17:50:00 INFO - 'ts_paint', 17:50:00 INFO - 'tpaint', 17:50:00 INFO - 'sessionrestore', 17:50:00 INFO - 'sessionrestore_no_auto_restore', 17:50:00 INFO - 'tabpaint']}, 17:50:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['a11yr', 17:50:00 INFO - 'ts_paint', 17:50:00 INFO - 'tpaint', 17:50:00 INFO - 'sessionrestore', 17:50:00 INFO - 'sessionrestore_no_auto_restore', 17:50:00 INFO - 'tabpaint']}, 17:50:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['a11yr', 17:50:00 INFO - 'ts_paint', 17:50:00 INFO - 'tpaint', 17:50:00 INFO - 'sessionrestore', 17:50:00 INFO - 'sessionrestore_no_auto_restore', 17:50:00 INFO - 'tabpaint']}, 17:50:00 INFO - 'other_l64': {'tests': ['a11yr', 17:50:00 INFO - 'ts_paint', 17:50:00 INFO - 'tpaint', 17:50:00 INFO - 'sessionrestore', 17:50:00 INFO - 'sessionrestore_no_auto_restore', 17:50:00 INFO - 'tabpaint']}, 17:50:00 INFO - 'other_nol64': {'tests': ['a11yr', 17:50:00 INFO - 'ts_paint', 17:50:00 INFO - 'tpaint', 17:50:00 INFO - 'sessionrestore', 17:50:00 INFO - 'sessionrestore_no_auto_restore', 17:50:00 INFO - 'tabpaint']}, 17:50:00 INFO - 'svgr': {'tests': ['tsvgx', 17:50:00 INFO - 'tsvgr_opacity', 17:50:00 INFO - 'tart', 17:50:00 INFO - 'tscrollx', 17:50:00 INFO - 'cart']}, 17:50:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['tsvgx', 17:50:00 INFO - 'tsvgr_opacity', 17:50:00 INFO - 'tart', 17:50:00 INFO - 'tscrollx', 17:50:00 INFO - 'cart']}, 17:50:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'tests': ['tp5o']}, 17:50:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'talos_options': ['--e10s'], 17:50:00 INFO - 'tests': ['tp5o']}, 17:50:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'talos_options': ['--xperf_path', 17:50:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:00 INFO - 'tests': ['tp5n']}, 17:50:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:50:00 INFO - 'talos_options': ['--e10s', 17:50:00 INFO - '--xperf_path', 17:50:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:00 INFO - 'tests': ['tp5n']}}, 17:50:00 INFO - 'talos.zip': {'path': '', 17:50:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:50:00 INFO - Running post-action listener: _resource_record_post_action 17:50:00 INFO - ##### 17:50:00 INFO - ##### Running create-virtualenv step. 17:50:00 INFO - ##### 17:50:00 INFO - Running pre-action listener: _resource_record_pre_action 17:50:00 INFO - Running main action method: create_virtualenv 17:50:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:00 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:50:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:00 INFO - Using real prefix '/tools/python27' 17:50:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:04 INFO - Installing pip.................done. 17:50:04 INFO - Return code: 0 17:50:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50: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:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50: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', 'pip>=1.5'] in /builds/slave/test/build 17:50: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 pip>=1.5 17:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:04 INFO - 'HOME': '/Users/cltbld', 17:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:04 INFO - 'LOGNAME': 'cltbld', 17:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:04 INFO - 'MOZ_NO_REMOTE': '1', 17:50:04 INFO - 'NO_EM_RESTART': '1', 17:50:04 INFO - 'PAGER': '/bin/cat', 17:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:04 INFO - 'PWD': '/builds/slave/test', 17:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:04 INFO - 'SHELL': '/bin/bash', 17:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:04 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:04 INFO - 'USER': 'cltbld', 17:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:04 INFO - 'XPC_FLAGS': '0x0', 17:50:04 INFO - 'XPC_SERVICE_NAME': '0', 17:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:04 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:50:04 INFO - Cleaning up... 17:50:04 INFO - Return code: 0 17:50:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:50: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:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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', '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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:50: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 psutil>=0.7.1 17:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:04 INFO - 'HOME': '/Users/cltbld', 17:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:04 INFO - 'LOGNAME': 'cltbld', 17:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:04 INFO - 'MOZ_NO_REMOTE': '1', 17:50:04 INFO - 'NO_EM_RESTART': '1', 17:50:04 INFO - 'PAGER': '/bin/cat', 17:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:04 INFO - 'PWD': '/builds/slave/test', 17:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:04 INFO - 'SHELL': '/bin/bash', 17:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:04 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:04 INFO - 'USER': 'cltbld', 17:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:04 INFO - 'XPC_FLAGS': '0x0', 17:50:04 INFO - 'XPC_SERVICE_NAME': '0', 17:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:04 INFO - Downloading/unpacking psutil>=0.7.1 17:50:04 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:50:04 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:50:04 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:50:04 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:50:04 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:50:04 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:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:07 INFO - Installing collected packages: psutil 17:50:07 INFO - Running setup.py install for psutil 17:50:07 INFO - building 'psutil._psutil_osx' extension 17:50:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:50:08 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:50:08 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:50:08 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:50:08 INFO - building 'psutil._psutil_posix' extension 17:50:08 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:50:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:50:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:50:08 INFO - ^ 17:50:08 INFO - 1 warning generated. 17:50:08 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:50:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:08 INFO - Successfully installed psutil 17:50:08 INFO - Cleaning up... 17:50:08 INFO - Return code: 0 17:50:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:08 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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:08 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:50:08 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:50:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:08 INFO - 'HOME': '/Users/cltbld', 17:50:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:08 INFO - 'LOGNAME': 'cltbld', 17:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:08 INFO - 'MOZ_NO_REMOTE': '1', 17:50:08 INFO - 'NO_EM_RESTART': '1', 17:50:08 INFO - 'PAGER': '/bin/cat', 17:50:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:08 INFO - 'PWD': '/builds/slave/test', 17:50:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:08 INFO - 'SHELL': '/bin/bash', 17:50:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:08 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:08 INFO - 'USER': 'cltbld', 17:50:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:08 INFO - 'XPC_FLAGS': '0x0', 17:50:08 INFO - 'XPC_SERVICE_NAME': '0', 17:50:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:09 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:50:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:11 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:50:11 INFO - Installing collected packages: mozsystemmonitor 17:50:11 INFO - Running setup.py install for mozsystemmonitor 17:50:11 INFO - Successfully installed mozsystemmonitor 17:50:11 INFO - Cleaning up... 17:50:11 INFO - Return code: 0 17:50:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:11 INFO - 'HOME': '/Users/cltbld', 17:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:11 INFO - 'LOGNAME': 'cltbld', 17:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:11 INFO - 'MOZ_NO_REMOTE': '1', 17:50:11 INFO - 'NO_EM_RESTART': '1', 17:50:11 INFO - 'PAGER': '/bin/cat', 17:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:11 INFO - 'PWD': '/builds/slave/test', 17:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:11 INFO - 'SHELL': '/bin/bash', 17:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:11 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:11 INFO - 'USER': 'cltbld', 17:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:11 INFO - 'XPC_FLAGS': '0x0', 17:50:11 INFO - 'XPC_SERVICE_NAME': '0', 17:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:50:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:50:14 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:50:14 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:50:14 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:50:14 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:50:14 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:50:14 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:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:50:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:15 INFO - Downloading docopt-0.6.1.tar.gz 17:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:50:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:50:15 INFO - Running setup.py install for blobuploader 17:50:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:50:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:50:15 INFO - Running setup.py install for requests 17:50:16 INFO - Running setup.py install for docopt 17:50:16 INFO - Successfully installed blobuploader requests docopt 17:50:16 INFO - Cleaning up... 17:50:16 INFO - Return code: 0 17:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50: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:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:16 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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:16 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:50:16 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:50:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:16 INFO - 'HOME': '/Users/cltbld', 17:50:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:16 INFO - 'LOGNAME': 'cltbld', 17:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:16 INFO - 'MOZ_NO_REMOTE': '1', 17:50:16 INFO - 'NO_EM_RESTART': '1', 17:50:16 INFO - 'PAGER': '/bin/cat', 17:50:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:16 INFO - 'PWD': '/builds/slave/test', 17:50:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:16 INFO - 'SHELL': '/bin/bash', 17:50:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:16 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:16 INFO - 'USER': 'cltbld', 17:50:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:16 INFO - 'XPC_FLAGS': '0x0', 17:50:16 INFO - 'XPC_SERVICE_NAME': '0', 17:50:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-_EJWif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-BEOleE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-gXjGNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-5rYZIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-fjn0IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-F1zx1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Qh9Tk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-4Sp0F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-891CmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-4mdxMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-FQXz2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-mKiAyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-fFDRBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:18 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-QYJ9He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:18 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-RkaIe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:18 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-ddTLhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:18 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-VXO3nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:50:18 INFO - Running setup.py install for manifestparser 17:50:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:50:18 INFO - Running setup.py install for mozcrash 17:50:18 INFO - Running setup.py install for mozdebug 17:50:18 INFO - Running setup.py install for mozdevice 17:50:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Running setup.py install for mozfile 17:50:19 INFO - Running setup.py install for mozhttpd 17:50:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Running setup.py install for mozinfo 17:50:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Running setup.py install for mozInstall 17:50:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Running setup.py install for mozleak 17:50:19 INFO - Running setup.py install for mozlog 17:50:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:50:19 INFO - Running setup.py install for moznetwork 17:50:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:50:20 INFO - Running setup.py install for mozprocess 17:50:20 INFO - Running setup.py install for mozprofile 17:50:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:50:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:50:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:50:20 INFO - Running setup.py install for mozrunner 17:50:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:50:20 INFO - Running setup.py install for mozscreenshot 17:50:20 INFO - Running setup.py install for moztest 17:50:20 INFO - Running setup.py install for mozversion 17:50:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:50:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:50:21 INFO - Cleaning up... 17:50:21 INFO - Return code: 0 17:50:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50: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:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50: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:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:21 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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:21 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:50:21 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:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:21 INFO - 'HOME': '/Users/cltbld', 17:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:21 INFO - 'LOGNAME': 'cltbld', 17:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:21 INFO - 'MOZ_NO_REMOTE': '1', 17:50:21 INFO - 'NO_EM_RESTART': '1', 17:50:21 INFO - 'PAGER': '/bin/cat', 17:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:21 INFO - 'PWD': '/builds/slave/test', 17:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:21 INFO - 'SHELL': '/bin/bash', 17:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:21 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:21 INFO - 'USER': 'cltbld', 17:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:21 INFO - 'XPC_FLAGS': '0x0', 17:50:21 INFO - 'XPC_SERVICE_NAME': '0', 17:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:50:21 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-f5AwOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:50:21 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:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:50:21 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Uulron-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:50:21 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-caj6FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:50:21 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:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:50:21 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-W1MRDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:50:21 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:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:50:21 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-wAKPr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:50:21 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:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:50:21 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-EcjlNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-XFJVED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-jUNgK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-_enZET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-F1XLWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-X32n9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-UkbbDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-u0NK2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-XTGCrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-GqQOKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:50:22 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:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:50:22 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-zWqgRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:50:23 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:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:50:23 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-ttf2WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:50:23 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:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:50:23 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:50:23 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:50:23 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:50:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:25 INFO - Downloading blessings-1.6.tar.gz 17:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:50:25 INFO - Installing collected packages: blessings 17:50:25 INFO - Running setup.py install for blessings 17:50:25 INFO - Successfully installed blessings 17:50:25 INFO - Cleaning up... 17:50:25 INFO - Return code: 0 17:50:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:26 INFO - Reading from file tmpfile_stdout 17:50:26 INFO - Current package versions: 17:50:26 INFO - blessings == 1.6 17:50:26 INFO - blobuploader == 1.2.4 17:50:26 INFO - docopt == 0.6.1 17:50:26 INFO - manifestparser == 1.1 17:50:26 INFO - mozInstall == 1.12 17:50:26 INFO - mozcrash == 0.17 17:50:26 INFO - mozdebug == 0.1 17:50:26 INFO - mozdevice == 0.48 17:50:26 INFO - mozfile == 1.2 17:50:26 INFO - mozhttpd == 0.7 17:50:26 INFO - mozinfo == 0.9 17:50:26 INFO - mozleak == 0.1 17:50:26 INFO - mozlog == 3.1 17:50:26 INFO - moznetwork == 0.27 17:50:26 INFO - mozprocess == 0.22 17:50:26 INFO - mozprofile == 0.28 17:50:26 INFO - mozrunner == 6.11 17:50:26 INFO - mozscreenshot == 0.1 17:50:26 INFO - mozsystemmonitor == 0.0 17:50:26 INFO - moztest == 0.7 17:50:26 INFO - mozversion == 1.4 17:50:26 INFO - psutil == 3.1.1 17:50:26 INFO - requests == 1.2.3 17:50:26 INFO - wsgiref == 0.1.2 17:50:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:50:26 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:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:26 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:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:26 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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:26 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:50:26 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:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:26 INFO - 'HOME': '/Users/cltbld', 17:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:26 INFO - 'LOGNAME': 'cltbld', 17:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:26 INFO - 'MOZ_NO_REMOTE': '1', 17:50:26 INFO - 'NO_EM_RESTART': '1', 17:50:26 INFO - 'PAGER': '/bin/cat', 17:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:26 INFO - 'PWD': '/builds/slave/test', 17:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:26 INFO - 'SHELL': '/bin/bash', 17:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:26 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:26 INFO - 'USER': 'cltbld', 17:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:26 INFO - 'XPC_FLAGS': '0x0', 17:50:26 INFO - 'XPC_SERVICE_NAME': '0', 17:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 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:50:26 INFO - Cleaning up... 17:50:26 INFO - Return code: 0 17:50:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:50:26 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:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:26 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:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:26 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 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:26 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:50:26 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:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:26 INFO - 'HOME': '/Users/cltbld', 17:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:26 INFO - 'LOGNAME': 'cltbld', 17:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:26 INFO - 'MOZ_NO_REMOTE': '1', 17:50:26 INFO - 'NO_EM_RESTART': '1', 17:50:26 INFO - 'PAGER': '/bin/cat', 17:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:26 INFO - 'PWD': '/builds/slave/test', 17:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:26 INFO - 'SHELL': '/bin/bash', 17:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:26 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:26 INFO - 'USER': 'cltbld', 17:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:26 INFO - 'XPC_FLAGS': '0x0', 17:50:26 INFO - 'XPC_SERVICE_NAME': '0', 17:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:26 INFO - Downloading/unpacking jsonschema 17:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:50:28 INFO - Downloading/unpacking functools32 (from jsonschema) 17:50: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:50: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:50: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:50: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:50: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:50: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:50:29 INFO - Downloading functools32-3.2.3-2.tar.gz 17:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:50:29 INFO - warning: no files found matching '*.txt' 17:50:29 INFO - no previously-included directories found matching 'build' 17:50:29 INFO - no previously-included directories found matching 'dist' 17:50:29 INFO - no previously-included directories found matching '.git*' 17:50:29 INFO - Installing collected packages: jsonschema, functools32 17:50:29 INFO - Running setup.py install for functools32 17:50:29 INFO - warning: no files found matching '*.txt' 17:50:29 INFO - no previously-included directories found matching 'build' 17:50:29 INFO - no previously-included directories found matching 'dist' 17:50:29 INFO - no previously-included directories found matching '.git*' 17:50:29 INFO - Successfully installed jsonschema functools32 17:50:29 INFO - Cleaning up... 17:50:29 INFO - Return code: 0 17:50:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ce4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95915a1450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, '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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:50:29 INFO - 'HOME': '/Users/cltbld', 17:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:50:29 INFO - 'LOGNAME': 'cltbld', 17:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:29 INFO - 'MOZ_NO_REMOTE': '1', 17:50:29 INFO - 'NO_EM_RESTART': '1', 17:50:29 INFO - 'PAGER': '/bin/cat', 17:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:29 INFO - 'PWD': '/builds/slave/test', 17:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:50:29 INFO - 'SHELL': '/bin/bash', 17:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:50:29 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:50:29 INFO - 'USER': 'cltbld', 17:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:29 INFO - 'XPC_FLAGS': '0x0', 17:50:29 INFO - 'XPC_SERVICE_NAME': '0', 17:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:30 INFO - Downloading/unpacking flake8 17:50:30 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:50:30 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:50:30 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:50:30 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:50:30 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:50:30 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:50:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:50:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:50:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:50:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:50:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:50:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:50:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:50:33 INFO - no previously-included directories found matching 'docs/_build' 17:50:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:50:33 INFO - Running setup.py install for pep8 17:50:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:50:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:50:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:50:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:50:33 INFO - no previously-included directories found matching 'docs/_build' 17:50:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:50:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:50:34 INFO - Cleaning up... 17:50:34 INFO - Return code: 0 17:50:34 INFO - Running post-action listener: _resource_record_post_action 17:50:34 INFO - Running post-action listener: _start_resource_monitoring 17:50:34 INFO - Starting resource monitoring. 17:50:34 INFO - ##### 17:50:34 INFO - ##### Running install step. 17:50:34 INFO - ##### 17:50:34 INFO - Running pre-action listener: _resource_record_pre_action 17:50:34 INFO - Running main action method: install 17:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:34 INFO - Reading from file tmpfile_stdout 17:50:34 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:34 INFO - Reading from file tmpfile_stdout 17:50:34 INFO - Output received: 17:50:34 INFO - Usage: mozinstall [options] installer 17:50:34 INFO - Options: 17:50:34 INFO - -h, --help show this help message and exit 17:50:34 INFO - -d DEST, --destination=DEST 17:50:34 INFO - Directory to install application into. [default: 17:50:34 INFO - "/builds/slave/test"] 17:50:34 INFO - --app=APP Application being installed. [default: firefox] 17:50:34 INFO - mkdir: /builds/slave/test/build/application 17:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:51:09 INFO - Reading from file tmpfile_stdout 17:51:09 INFO - Output received: 17:51:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:51:09 INFO - Running post-action listener: _resource_record_post_action 17:51:09 INFO - ##### 17:51:09 INFO - ##### Running run-tests step. 17:51:09 INFO - ##### 17:51:09 INFO - Running pre-action listener: _resource_record_pre_action 17:51:09 INFO - Running main action method: run_tests 17:51:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:51:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:51:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:51:09 INFO - 2016-03-16 17:51:09.104 screenresolution[1646:7513] starting screenresolution argv=screenresolution get 17:51:09 INFO - 2016-03-16 17:51:09.107 screenresolution[1646:7513] Display 0: 1600x1200x32@60 17:51:09 INFO - 2016-03-16 17:51:09.112 screenresolution[1647:7515] starting screenresolution argv=screenresolution list 17:51:09 INFO - Available Modes on Display 0 17:51:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:51:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:51:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:51:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:51:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:51:09 INFO - Intel Iris: 17:51:09 INFO - Chipset Model: Intel Iris 17:51:09 INFO - Type: GPU 17:51:09 INFO - Bus: Built-In 17:51:09 INFO - VRAM (Dynamic, Max): 1536 MB 17:51:09 INFO - Vendor: Intel (0x8086) 17:51:09 INFO - Device ID: 0x0a2e 17:51:09 INFO - Revision ID: 0x0009 17:51:09 INFO - Displays: 17:51:09 INFO - Display: 17:51:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:51:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:51:09 INFO - Display Serial Number: 1600x1200 60 17:51:09 INFO - Main Display: Yes 17:51:09 INFO - Mirror: Off 17:51:09 INFO - Online: Yes 17:51:09 INFO - Rotation: Supported 17:51:09 INFO - Return code: 0 17:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:09 INFO - Python 2.7.3 17:51:09 INFO - Return code: 0 17:51:09 INFO - grabbing minidump binary from tooltool 17:51:09 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:51:09 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 0x10966ad30>, '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 0x10948edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109661b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:09 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:51:09 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:51:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:09 INFO - Return code: 0 17:51:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:51:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:51:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:51:10 INFO - Return code: 0 17:51:10 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/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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:51:10 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/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkiZcKZe3n/Render', 17:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:51:10 INFO - 'HOME': '/Users/cltbld', 17:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:51:10 INFO - 'LOGNAME': 'cltbld', 17:51:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:10 INFO - 'MOZ_NO_REMOTE': '1', 17:51:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:10 INFO - 'NO_EM_RESTART': '1', 17:51:10 INFO - 'PAGER': '/bin/cat', 17:51:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:10 INFO - 'PWD': '/builds/slave/test', 17:51:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:51:10 INFO - 'SHELL': '/bin/bash', 17:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lsRIk3jgkp/Listeners', 17:51:10 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 17:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:51:10 INFO - 'USER': 'cltbld', 17:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:10 INFO - 'XPC_FLAGS': '0x0', 17:51:10 INFO - 'XPC_SERVICE_NAME': '0', 17:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:51:10 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/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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:51:10 INFO - mozversion application_buildid: 20160316162107 17:51:10 INFO - mozversion application_changeset: a4c6d6add2fcbc4bf847270cf27ff23334e2f170 17:51:10 INFO - mozversion application_display_name: Nightly 17:51:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:10 INFO - mozversion application_name: Firefox 17:51:10 INFO - mozversion application_remotingname: firefox 17:51:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:51:10 INFO - mozversion application_vendor: Mozilla 17:51:10 INFO - mozversion application_version: 48.0a1 17:51:10 INFO - mozversion platform_buildid: 20160316162107 17:51:10 INFO - mozversion platform_changeset: a4c6d6add2fcbc4bf847270cf27ff23334e2f170 17:51:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:51:10 INFO - mozversion platform_version: 48.0a1 17:51:10 INFO - using testdate: 1458175870 17:51:10 INFO - actual date: 1458175870 17:51:10 INFO - starting webserver on 'localhost:49273' 17:51:10 INFO - SUITE-START | Running 2 tests 17:51:10 INFO - TEST-START | dromaeo_css 17:51:10 INFO - operating with platform_type : mac_ 17:51:10 INFO - Initialising browser for dromaeo_css test... 17:51:10 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpBXCmsM/profile http://localhost:49273/getInfo.html) 17:51:13 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 17:51:13 INFO - PROCESS | 1665 | colorDepth:24 17:51:13 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 17:51:13 INFO - PROCESS | 1665 | __metrics 17:51:13 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:51:13 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:51:13 INFO - TEST-INFO | 1665: exit 0 17:51:13 INFO - Browser initialized. 17:51:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:51:13 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpBXCmsM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:25 INFO - PROCESS | 1668 | RSS: Main: 243322880 17:51:25 INFO - PROCESS | 1668 | 17:52:17 INFO - PROCESS | 1668 | 1458175937100 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:54:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:54:28 INFO - PROCESS | 1668 | RSS: Main: 376881152 17:54:28 INFO - PROCESS | 1668 | 17:57:31 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:57:32 INFO - PROCESS | 1668 | RSS: Main: 376188928 17:57:32 INFO - PROCESS | 1668 | 18:00:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 18:00:34 INFO - PROCESS | 1668 | RSS: Main: 371691520 18:00:34 INFO - PROCESS | 1668 | 18:03:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 18:03:37 INFO - PROCESS | 1668 | RSS: Main: 334487552 18:03:37 INFO - PROCESS | 1668 | 18:06:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 18:06:41 INFO - PROCESS | 1668 | RSS: Main: 336519168 18:06:41 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 18:09:44 INFO - PROCESS | 1668 | RSS: Main: 379547648 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | __start_tp_report 18:09:44 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 18:09:44 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 18:09:44 INFO - PROCESS | 1668 | |i|pagename|runs| 18:09:44 INFO - PROCESS | 1668 | |0;dojo.html;3400.166959095022;3477.426224672929;3503.6671516205965;3509.84205710743;3563.037979745469;5327.334083239595;5526.088195447746;5650.350209725878;5662.009148399029;5667.319921609407;5509.696966666832;5605.299337582802;5614.9438505614935;5615.803446879349;5631.493165615104;5084.8983020339665;5114.718690472023;5136.43499215086;5152;5202.479752024805;5212.713300768456;5215.713135777531;5215.817446389377;5216.400113986883;5220.843374698746;5148.510891465305;5173.430922598511;5202.401723801754;5217.843464696065;5238.869028274305;5199.272101905717;5220;5231.843044708665;5248.737563121828;5294.49702278283;5028.622853286018;5072.822451214227;5153.484651534854;5160.664556803796;5164.354455693038;5483.588730845203;5488.69812160331;5545.417731138213;5602.803901863456;5622.381538030813;6167.845803854894;6181.907271390888;6190.3190649028575;6207.906881396782;6209.565330426872;6084.117802918597;6227.906581401283;6280.560360774748;6292.748290068392;6304.87390252197;5651;5698.1452782083015;5714.428557144252;5738.856528586777;5754.856128596819;6249.468795152372;6250.1874756281395;6251.343608920998;6256.6871656417;6268.937310626927;5852.385499522489;5884;6059.7273122709585;6075.179850720185;6083.8479038023515;6114.479856340571;6132.540059495555;6177.413145751147;6177.938220617826;6200.503959683215;6100.206973093469;6105.080114271519;6106.114613381035;6117.112675004028;6119.83850981328;6013.6692481913915;6114.755409783648;6131.417515336036;6160.784372546939;6172.259328880563;4779.378680771478;4794.376731025014;4817.1810792164715;4820.879478013007;4824.059308434892;4336.522982471989;4339.284018137035;4373.125374925028;4398.274284742982;4398.934015989763;4706.4822869485015;5636.689982051026;5649.943500565024;5655.519280861091;5668.121441176624;5248.317718696545;6194.690265486708;6286.591371560834;6286.779962701284;6307.9369206308265;5715.31416230055;5717.17101020358;5723.77104915807;5726.3700992890745;5782.913256301159;5319.946800531945;5321.733913304397;5326.201069839555;5329.280547126166;5331.546818520392;6159.722812473449;6185.41238582334;6264.937350626436;6266.937330626635;6285.402886725754;6245.437910588069;6252.280987686292;6255.155554000152;6260.248770147611;6283.717232724447;6235.033569796688;6243.375662433902;6258.249010118633;6275.592086514362;6293.842653933505;5935.080062590306;6056;6066.575339726177;6101.603395779438;6146.231721034871;6237.625742455467;6247.906281405873;6250.124982502544;6253.96873015632;6267.310595834546;5950.404959504015;5962.2249107615735;5973.616775184193;6009.819705408845;6030.7889223876955;4637.513061128533;5892.469677729025;5935.40645935403;6037.879242415215;6111.205543279523;5133.512316329943;5274.892272622792;5691.886162276648;5834.708264586839;5918.964181268175;5894.145348924296;5945.3757355477055;5989.071693887455;6012.098185272244;6027.75888964454;5836.9416305838095;5846.35690074083;5944.851378715567;5956.583039187215;5977.880442391215 18:09:44 INFO - PROCESS | 1668 | |1;ext.html;515.1860061103457;516.9170587618939;571.7084287013624;643.4530648948395;646.8188907106011;34179.65820341796;39693.80153099238;39916;39923.80419076949;39927.60072399275;42068.15863682725;42631;42663.57336426635;42735.57264427355;42819;9513.5243237838;9749.902500974971;9750.12248897599;9756.073173048584;9784.55969481375;8498.66005359788;9652.034796520362;9729.124378805906;9924.206063514937;9958.452285124315;9873.753156171082;9937.25470589705;9939.55272012761;9942.950285248564;9957.75105622358;9814.16579590732;9827.606895724162;9851.802963940752;9891.505424728806;9914.504274786232;9699.157160139552;9813.558389872473;9821.607135714563;9827.164691001202;9845.507724613812;41292.38061429081;41621.375679364835;41623;41702;41842.953926151786;3194.4090343286566;3602.9819850900576;3835.002899246188;3871.845126194949;3950.1309711863346;24238.39404014896;28928.71071289281;29214.561781573295;29956;29980.400391992258;2693.407450360937;2749.560070388728;2775.5420355641295;2834.518131917579;2850.44416338814;440204;505357;505594;505677;505939;60222.88105510993;60327.396726033054;60382.39617603856;60535.39464605298;60979.39020609737;67250;67426;67466.66266668636;67564.6621766888;67590.66204668945;15501.844981550266;16922.40771572989;17144.314227431012;17176.742348864776;17213.65572688564;11755.294682319089;11840.934315911609;11862;11864.169508134348;13204.943604511616;16442.241335779552;23509.882450587636;23712.85025120597;23774.88112559426;23790;8296.958515207507;10163.695089147337;10314.1748660107;10328.535215915303;10335.534900929477;1019.6176433837311;1027.8972102789662;1050.4852622215212;1095.2771171027084;1111.8888111188978;26112.86943565308;29479.11562653124;29673.554896676567;30044.84977575142;30562.541561876144;1069.4813015687384;1103.2608152537819;1135.239389608964;1177.2583272538418;1232.5870833270956;15017.399304027935;15155.318010689545;15259.313330899915;15651;15662.765058524132;726016;737761;738531;739192;740059;59673.40326596765;60418.39581604215;60580.394196058354;60590.091148632804;60745;1354;1364.501956785766;1446.146773403697;1469.1919444305588;1492.380662025269;29364.706352937053;29499;30157.944471943378;30740.385192296475;31704.682953171097;49720.756981074315;53493.19760203678;57031.42968570427;57071.71464142819;57183.71408142932;416259;418750.90624546685;422782;423271;424230;36966.63033369632;43649.908752281444;44674.3298850524;44895.55104448914;45047.774761125984;43259.783701081295;43700.125997479234;43876.34185487156;44872.77563612292;44874.551254487036;36075;36090;36505.26989460249;37054.258914822094;37113.88658340254;35496.290074198885;35889.64110358863;36218.4567231497;36412.635873640924;36781;35144.12139696528;35688.82155589206;36016;36815.44776828403;37942.8102859495;31469;31663.040623249995;32560.67439325671;32874.17814554655;33082.66917330796;20459;21597.676034859174;23122;24354.147604833746;24890.377740556632 18:09:44 INFO - PROCESS | 1668 | |2;jquery.html;354.7481288285319;361.2828535357316;362.34596553221434;364.4969941480756;367.6103330469701;19450.41648750538;19693.31073412431;20123.899380503095;20541;20572.279970201045;19539.609207815836;20283.898580507113;20514.179432822708;20811.895940520313;20815.895920520416;5181.455947125554;5705.686187259699;5754.597178197528;5767.30792304924;5773.740181691834;4256.106217694288;4395.142947125312;6001.399860014008;6390.169277993854;6683.6658167091455;6568.441682456997;6586.077949087132;6599.076129341896;6607.041978913055;6609.966950165242;6268.999999999977;6536.3463653634735;6544.3782840630065;6552;6554.868902621968;3767.472553842437;5364.865878353034;5579.9163012554845;5612;5645.604807663465;25249.873750631312;25686.48627027449;25699.35751606206;25909.61135582968;25990.35024124393;1969.812867777559;2148.6239908016037;2444.352246654638;2619.89520419183;2807.663080430341;9973.950130249303;11255.887441125566;14127.152370857679;14616.707665846623;14638.780418293734;1732.8527075198624;1753.4739578126512;1773.760542326795;1800.468861685806;1876.3339014649875;103857.48071259595;105044;107439.38840917393;108033;108181.45909270483;11072.723181920355;11076.778464430827;11170.385628790333;11180.329180249211;11317.83023254652;13449.260290684106;13541.39063742134;13541.984351173702;13543.458261669422;13544.729105418033;8633.266172375294;8655;8667.739967800977;8679.17547832955;8794.516301603346;8840.33697472692;8841.867371989425;8861.291096712248;8944.776380590538;8967.551622418852;4470.284754439274;4488.3940668010055;4491.573300536509;4505.098980203972;4566.109608626286;1590.5466941921497;1744.9127543622767;1801.6306657135256;1810.6650269700147;1811.6286161336893;879.8900137482815;879.9604017819214;900.7252787899622;936.8688383626297;986.6793292180071;16592.83407165913;17514.56213594645;18122.365717200097;19585.510362241057;19701.802981969995;954.708813811794;968.2931460034074;1004.598160735697;1014.3761586624173;1019.2966852871643;10334.379937203641;10580.941905809357;10612.734681633021;10618.840717389245;10657.467126643793;517293;527778.3611081997;528939.7106028968;640357;644489;120538.97193144826;128074.71925280814;128148;128268.35865820611;134821.32589337186;981.1464026297025;1034.7102811212872;1055.0662663542666;1068.0294855990685;1070.4433694478828;15199.468018619295;15872.523824284828;18240.087995600432;18362.449126526226;18610;51608.48391516187;52191;52354.47645523496;52706;53087.73456132694;66558.3376664928;75457.24542754501;75914.24085759293;77030;77094.614526927;7381.44639152055;7807;7818.413618978486;7902.130765615662;8117.147699491705;10943.726406839893;12236.75526489483;12327.93836030814;12363.567275145328;12914.806277906027;10873.401962892116;10965.342079475256;10967.83548246761;11185.384803835866;11234.101271898391;10703.036726694634;10730.248882578144;10907.96374344436;10928.071113955402;10974.890251097706;10869.456527173768;11139.387333696724;11167.162462815484;11203.43982800873;11433.485493152662;7413.629318533944;7820.765377038698;7855.882161767464;7924.881126783218;7993.560354180576;8185;10512.57949682004;10607.840882386925;10970.286931349756;11042.116630669367 18:09:44 INFO - PROCESS | 1668 | |3;mootools.html;1413.6112569043519;1566.5457017464935;1573.409971260777;1858.8419984301333;2014.8186663200308;7882.605869706514;8599.871001934967;8769.693060742875;8779.561021948908;8805.823883522342;8279.296259817922;8544.91455085449;8547.829043419128;8553.272971797405;8555.95722021389;2152.547964927367;2402.627592723122;2449.669294645218;2455.238875948453;2468.8518688878635;2143.9249626263086;2485.403503159247;2501.6747822783104;2502.4995000999784;2505.649209110726;2427.7329493755674;2440.9389765255833;2481.2060140754966;2481.838680485772;2494.787943024845;2433.3429973907123;2462;2467.8272520923542;2487.328421326232;2492.962605560918;2463.88912498938;2469.580171370871;2472.4807790364043;2499.762522560354;2501.46218563008;8696.217340439327;8764.386492945496;8766.736997890073;8774.254188393994;8849.115088491164;4797.232442809134;5231.136862417697;5492.066348720727;5494.725263736797;5494.972525137388;3565.625609311037;3651.361011822947;3729.0863738384;3751.8124093795473;3757.8684746034032;1033.3283365812208;1054.741588310861;1054.9050585447346;1065.7388939709742;1069.4171676436283;10833.970772776574;11120.944395278053;11764.470598823074;11852.34812085335;11859.46632401544;4803.927941080887;4858.659893807399;4937.506249375034;4966.627502937295;4967.776450059756;10028.247881408923;10069.79860402788;10095.343802652804;10105.191584673208;10110.191184705205;5483.972580137074;5499.120140777536;5500.779968801203;5504.6421982571;5509.834704958857;4380.058287468146;4538;4855.708657480563;4893.608511319086;4957.256411538298;3877.3602355611574;3952.802359882052;3967.444557761916;3989.9601003989587;4015.7791321477016;1280.7822670146097;1303.7327347893658;1304.2956803326097;1313.6584488032988;1316.3747220070582;1057.878343990451;1082.832161015044;1210.2617403383929;1408.5140626483847;1408.6830463145916;8074.434789564674;8368.916310836814;8377.162283771697;8381.371397145238;8382.329413646894;1181.6676970942033;1183.1836033137108;1196.2882085159317;1204.1270079192516;1215.8966487848454;5274.709890955957;6312.400321969406;6359.077933699587;6364.809055728336;6380.298167201604;10207.489625518694;10630.09644180238;10649.041586257274;10656.307340022873;10672.893271067345;8385.874211886827;10420.843687344695;10447.84328235077;10491;10494.370337779757;8103.432759706882;8211.671533138608;8239.958800206081;8272.131426200403;8300.335973122135;7948.602569871599;7975.880361794694;8020.398470114881;8055.073666528424;8061;9350.719478415658;9481.383710058824;9483.430994140097;9568.712938611852;9582.856257156009;7902.130765615662;9931.404115752788;9975.002499749968;10135.138513226459;10350.378977261389;6808.863822723617;7011.509194356346;7316.597587132759;7562.962185189039;7721.6911323548675;7040.0847889774;8337.95831020841;8407.789805254917;8413.70552030676;8465.915340846514;7348.485606007742;7383.483156179016;7405.185429602631;7554.962225188839;7557.130929943127;7185.173705023989;7198.280171982759;7264.636768161465;7284;7316.158641756266;7672.309492145734;7871.567063811545;7879.251471110236;7899.170587088273;7920.128785833438;7046.541974771829;7060.046893669289;7095.148582170173;7136.143662760502;7143.428525718034;7183.173934997333;7207.6756545956605;7251.202367739439;7257.818554536178;7261.201267860425 18:09:44 INFO - PROCESS | 1668 | |4;prototype.html;320.855614973262;321.7699344968347;327.39268656641946;331.60870173195633;332.3419629134315;6485.740570377186;6502.80491585252;6517.869642607145;6555.180602424697;6602.570832895858;6472.223333200022;6478.416942475176;6480.351964803517;6491.8377040574005;6502.122213501176;4619.099275641234;4705.058988202356;4727.716337019772;4812.7352995585225;4882.755862206894;4786.21027530457;4801.063792560452;4806.110869489138;4832.73419961902;4838.983813399191;4782.13921494131;4790.1856684363565;4796.208625576775;4808.110499557593;4820.156472617296;4574.130915126132;4672.579467847893;4792.30511575823;4801.68789028712;4808.278758186265;4090.9386359204336;4108.4864391951005;4116.115035267402;4117.011917139895;4125.566815484391;6164.044573091178;6166;6226.159468471744;6228.128062071313;6255.343188965184;5584.329880414336;5586.441355864422;5589.161625756169;5589.245451864028;5597.412271711493;6813.693383797741;6823.112995310627;6828.829279268009;6830.282820303896;6860.5540639858245;4260.936085958682;4403.6256918162;4411.404460397869;4417.624501917341;4422.248217802981;5353.57171426285;7143.92856071443;7236.638168091575;7250.45621578389;7251.637418129072;4506.684532082788;4512.751798651106;4513.255312873404;4520.480144783326;4528.41130653013;4579.267317229294;4584.816607335736;4585.770711464414;4602.516735742765;4612;5429.56563474921;5434.592405569598;5437.592180586472;5440.455954404607;5441;5596.636218645856;6602.316409315594;6846.110005699227;6870.7595234166565;6910;1570.89789163704;1578;1591.7851090102688;1594.3463180096105;1596.3933705191953;946.2571881073325;975.7755716185317;1008.9495525223709;1010.7523656704154;1039.589362201926;6289.591176573508;6295;6321.557490975588;6360.459360954371;6364.904526432108;7163.820904477429;7178.748743793943;7188;7194.460415468756;7224.927750722531;6494.740210391531;6513.348665133449;6525.575837570543;6529.249136349381;6539.803805885831;3759.6240375962734;3794.734368594227;3798.3732684106812;3806.809659517013;3812.218495208476;6930.757423490154;7225.313595208447;7558.58427786466;7581.583012934231;7587.203343648947;6036;7375.336219740142;7442.8883566746545;7448.366888814403;7449.88825167623;6117.296510901214;7548.584827834522;7550.395968322631;7553.962230188814;7559.092908850973;6687.164104486939;6714.496412768965;6874.278200788845;7168.319009694071;7182.784516464514;7006.229314775269;7042.577445353295;7066.611336376549;7089.645517724196;7108;7479.88780168287;7529.88705169412;7534.585597792174;7564.773056808304;7575.924240757522;4510.50384457716;4555.521670224579;4556.134334476439;4559.475660299108;4562.7946742397335;7098.929010709827;7132.643367831692;7136.429085673238;7137.179224389261;7138.821529461805;6552.6068435894;6888.586684798727;6894.482913781587;6915.170179578483;6948.374646281859;6904.067950826574;6915.204751453446;6916.861662766616;6917.066196063467;6920.619365934922;6750.189977202767;6751.763688270887;6760.290169532325;6761.357671021246;6764.830879228059;5718.428157184248;6625.469962403093;6880.415164710856;6893.655317234018;6921.792346229621;6474.482041436768;6625.337466253336;6660.333966603301;6733.966330168318;6796.830079248059 18:09:44 INFO - PROCESS | 1668 | |5;yui.html;657.868426314737;728.4099879097931;732.7252280394852;742.1391186223974;823.3166471828383;15029.549113526584;15199;15200.315985780639;15206.695866082699;15217.847821521795;14012.929935350334;14153.363098660559;14416.783748243784;14438.5668429947;14445.566633001;733.7651951375562;751.8796992481205;907.5235501361789;925.3291363761286;936.4755736787421;930.1628534319133;949.278548303291;949.8907625623038;951.9666811661593;954.7994921066585;981.043482604462;983.8622592837008;984.099548912744;985.6550207427415;986.8865080515725;787.7794217619075;974.6832279509188;978.8091322192175;979.2704435195753;996.1532697207316;723.3562129704567;723.7286017743346;723.7683941138838;724.4566575068699;724.561640207672;15236.847631523653;15251.694966100727;15257.847421525754;15261.694766104616;15268.31292591836;12868.806967895489;12892.484300627964;13178.34108294591;13186.142900711424;13317.200967941955;10048.849267260997;10136.594536218543;10153.187744980383;10278.22913281507;10944.002227381872;3107.8135311881133;3540.8760693375607;3606.441001644749;3676.852925882988;3720.9069773255615;85073;85162.57418712928;85529;85670.28659426839;85850.57074714648;9543.570539325747;9685.806283874424;9711.514424278757;9965.950170249102;10599.205059620404;21898.562028759654;22158.88920555419;22161.55676886453;22186.223482178048;22204.88897555502;7652.311291983749;7826.686932522749;7885.526868387915;8020.278174964281;8078.838423231502;4098.4876890388705;4123.731957422758;4154.709170358106;4160.667146628323;4199.328107502785;3599.208174201671;3651.8721844735837;3655.1775850433974;3657.104009517685;3663.377225871608;618.981430557084;669.5915491550151;673.7540797608838;676.1851968378093;686.0909295183901;531.2429787552722;565.0108162035564;589.9026660600953;599.2629066248538;613.1691557939017;7892.802679933047;7901.249381308767;8003.6798528058225;8067.314278286294;8287.668493260322;584.4710536964054;590.3918963467635;593.8693487432757;605.5065121925617;624.4723208888482;3567.839447224881;3738.7569807962395;3763.698904087721;3878.96121038786;3943.7042221832903;64755.67622161859;92020.53989730008;97517.5372369415;98224.52663210058;98475.01524984802;77266.22733772703;78171.21828781639;79661.60169199116;80592.59703701444;82149.58925205335;58901.11648325279;61782.69108654428;62573.68713156405;63462.68268658719;64253.67873160604;7927.960360198162;8194.852720619;8314.708985185489;8328.3337333012;8388.706395276136;53474.73262633662;53537;53948.73025634847;54052;54491;73952;74463;75130;75856;76018;11090.889091108986;11186.83219751688;11196.440177991231;11390.658280251606;11896.048316134862;10061.446620435654;10635.096016838655;11989.280643161439;12128.696782580506;12373.566925157937;11454.255473394203;11478.02436792882;11711;11870.52517899309;12065.09511786602;11533.308001519936;11677.299362038304;11685.474153662935;11694.181407301407;11711.707207319885;9109.90890091117;11350;11753.529858805894;12082.33547154915;12200.023998080309;8679.392442528962;9173;9298.814023719622;9301.953490232776;9380;9108.954455227682;9494.810103798023;9546.665866694633;9549.283803714889;9565.569549370155 18:09:44 INFO - PROCESS | 1668 | __end_tp_report 18:09:44 INFO - PROCESS | 1668 | __start_cc_report 18:09:44 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1169 18:09:44 INFO - PROCESS | 1668 | __end_cc_report 18:09:44 INFO - PROCESS | 1668 | __startTimestamp1458176984477__endTimestamp 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | ------- Summary: start ------- 18:09:44 INFO - PROCESS | 1668 | Number of tests: 6 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5662.95 Median:5846.36 stddev:628.74 (10.8%) stddev-sans-first:605.09 18:09:44 INFO - PROCESS | 1668 | Values: 3400.2 3477.4 3503.7 3509.8 3563.0 5327.3 5526.1 5650.4 5662.0 5667.3 5509.7 5605.3 5614.9 5615.8 5631.5 5084.9 5114.7 5136.4 5152.0 5202.5 5212.7 5215.7 5215.8 5216.4 5220.8 5148.5 5173.4 5202.4 5217.8 5238.9 5199.3 5220.0 5231.8 5248.7 5294.5 5028.6 5072.8 5153.5 5160.7 5164.4 5483.6 5488.7 5545.4 5602.8 5622.4 6167.8 6181.9 6190.3 6207.9 6209.6 6084.1 6227.9 6280.6 6292.7 6304.9 5651.0 5698.1 5714.4 5738.9 5754.9 6249.5 6250.2 6251.3 6256.7 6268.9 5852.4 5884.0 6059.7 6075.2 6083.8 6114.5 6132.5 6177.4 6177.9 6200.5 6100.2 6105.1 6106.1 6117.1 6119.8 6013.7 6114.8 6131.4 6160.8 6172.3 4779.4 4794.4 4817.2 4820.9 4824.1 4336.5 4339.3 4373.1 4398.3 4398.9 4706.5 5636.7 5649.9 5655.5 5668.1 5248.3 6194.7 6286.6 6286.8 6307.9 5715.3 5717.2 5723.8 5726.4 5782.9 5319.9 5321.7 5326.2 5329.3 5331.5 6159.7 6185.4 6264.9 6266.9 6285.4 6245.4 6252.3 6255.2 6260.2 6283.7 6235.0 6243.4 6258.2 6275.6 6293.8 5935.1 6056.0 6066.6 6101.6 6146.2 6237.6 6247.9 6250.1 6254.0 6267.3 5950.4 5962.2 5973.6 6009.8 6030.8 4637.5 5892.5 5935.4 6037.9 6111.2 5133.5 5274.9 5691.9 5834.7 5919.0 5894.1 5945.4 5989.1 6012.1 6027.8 5836.9 5846.4 5944.9 5956.6 5977.9 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:69204.92 Median:21821.97 stddev:151712.44 (695.2%) stddev-sans-first:152050.37 18:09:44 INFO - PROCESS | 1668 | Values: 515.2 516.9 571.7 643.5 646.8 34179.7 39693.8 39916.0 39923.8 39927.6 42068.2 42631.0 42663.6 42735.6 42819.0 9513.5 9749.9 9750.1 9756.1 9784.6 8498.7 9652.0 9729.1 9924.2 9958.5 9873.8 9937.3 9939.6 9943.0 9957.8 9814.2 9827.6 9851.8 9891.5 9914.5 9699.2 9813.6 9821.6 9827.2 9845.5 41292.4 41621.4 41623.0 41702.0 41843.0 3194.4 3603.0 3835.0 3871.8 3950.1 24238.4 28928.7 29214.6 29956.0 29980.4 2693.4 2749.6 2775.5 2834.5 2850.4 440204.0 505357.0 505594.0 505677.0 505939.0 60222.9 60327.4 60382.4 60535.4 60979.4 67250.0 67426.0 67466.7 67564.7 67590.7 15501.8 16922.4 17144.3 17176.7 17213.7 11755.3 11840.9 11862.0 11864.2 13204.9 16442.2 23509.9 23712.9 23774.9 23790.0 8297.0 10163.7 10314.2 10328.5 10335.5 1019.6 1027.9 1050.5 1095.3 1111.9 26112.9 29479.1 29673.6 30044.8 30562.5 1069.5 1103.3 1135.2 1177.3 1232.6 15017.4 15155.3 15259.3 15651.0 15662.8 726016.0 737761.0 738531.0 739192.0 740059.0 59673.4 60418.4 60580.4 60590.1 60745.0 1354.0 1364.5 1446.1 1469.2 1492.4 29364.7 29499.0 30157.9 30740.4 31704.7 49720.8 53493.2 57031.4 57071.7 57183.7 416259.0 418750.9 422782.0 423271.0 424230.0 36966.6 43649.9 44674.3 44895.6 45047.8 43259.8 43700.1 43876.3 44872.8 44874.6 36075.0 36090.0 36505.3 37054.3 37113.9 35496.3 35889.6 36218.5 36412.6 36781.0 35144.1 35688.8 36016.0 36815.4 37942.8 31469.0 31663.0 32560.7 32874.2 33082.7 20459.0 21597.7 23122.0 24354.1 24890.4 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:33745.52 Median:11482.26 stddev:95883.04 (835.1%) stddev-sans-first:96119.24 18:09:44 INFO - PROCESS | 1668 | Values: 354.7 361.3 362.3 364.5 367.6 19450.4 19693.3 20123.9 20541.0 20572.3 19539.6 20283.9 20514.2 20811.9 20815.9 5181.5 5705.7 5754.6 5767.3 5773.7 4256.1 4395.1 6001.4 6390.2 6683.7 6568.4 6586.1 6599.1 6607.0 6610.0 6269.0 6536.3 6544.4 6552.0 6554.9 3767.5 5364.9 5579.9 5612.0 5645.6 25249.9 25686.5 25699.4 25909.6 25990.4 1969.8 2148.6 2444.4 2619.9 2807.7 9974.0 11255.9 14127.2 14616.7 14638.8 1732.9 1753.5 1773.8 1800.5 1876.3 103857.5 105044.0 107439.4 108033.0 108181.5 11072.7 11076.8 11170.4 11180.3 11317.8 13449.3 13541.4 13542.0 13543.5 13544.7 8633.3 8655.0 8667.7 8679.2 8794.5 8840.3 8841.9 8861.3 8944.8 8967.6 4470.3 4488.4 4491.6 4505.1 4566.1 1590.5 1744.9 1801.6 1810.7 1811.6 879.9 880.0 900.7 936.9 986.7 16592.8 17514.6 18122.4 19585.5 19701.8 954.7 968.3 1004.6 1014.4 1019.3 10334.4 10580.9 10612.7 10618.8 10657.5 517293.0 527778.4 528939.7 640357.0 644489.0 120539.0 128074.7 128148.0 128268.4 134821.3 981.1 1034.7 1055.1 1068.0 1070.4 15199.5 15872.5 18240.1 18362.4 18610.0 51608.5 52191.0 52354.5 52706.0 53087.7 66558.3 75457.2 75914.2 77030.0 77094.6 7381.4 7807.0 7818.4 7902.1 8117.1 10943.7 12236.8 12327.9 12363.6 12914.8 10873.4 10965.3 10967.8 11185.4 11234.1 10703.0 10730.2 10908.0 10928.1 10974.9 10869.5 11139.4 11167.2 11203.4 11433.5 7413.6 7820.8 7855.9 7924.9 7993.6 8185.0 10512.6 10607.8 10970.3 11042.1 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6026.14 Median:4967.20 stddev:3127.98 (63.0%) stddev-sans-first:3117.54 18:09:44 INFO - PROCESS | 1668 | Values: 1413.6 1566.5 1573.4 1858.8 2014.8 7882.6 8599.9 8769.7 8779.6 8805.8 8279.3 8544.9 8547.8 8553.3 8556.0 2152.5 2402.6 2449.7 2455.2 2468.9 2143.9 2485.4 2501.7 2502.5 2505.6 2427.7 2440.9 2481.2 2481.8 2494.8 2433.3 2462.0 2467.8 2487.3 2493.0 2463.9 2469.6 2472.5 2499.8 2501.5 8696.2 8764.4 8766.7 8774.3 8849.1 4797.2 5231.1 5492.1 5494.7 5495.0 3565.6 3651.4 3729.1 3751.8 3757.9 1033.3 1054.7 1054.9 1065.7 1069.4 10834.0 11120.9 11764.5 11852.3 11859.5 4803.9 4858.7 4937.5 4966.6 4967.8 10028.2 10069.8 10095.3 10105.2 10110.2 5484.0 5499.1 5500.8 5504.6 5509.8 4380.1 4538.0 4855.7 4893.6 4957.3 3877.4 3952.8 3967.4 3990.0 4015.8 1280.8 1303.7 1304.3 1313.7 1316.4 1057.9 1082.8 1210.3 1408.5 1408.7 8074.4 8368.9 8377.2 8381.4 8382.3 1181.7 1183.2 1196.3 1204.1 1215.9 5274.7 6312.4 6359.1 6364.8 6380.3 10207.5 10630.1 10649.0 10656.3 10672.9 8385.9 10420.8 10447.8 10491.0 10494.4 8103.4 8211.7 8240.0 8272.1 8300.3 7948.6 7975.9 8020.4 8055.1 8061.0 9350.7 9481.4 9483.4 9568.7 9582.9 7902.1 9931.4 9975.0 10135.1 10350.4 6808.9 7011.5 7316.6 7563.0 7721.7 7040.1 8338.0 8407.8 8413.7 8465.9 7348.5 7383.5 7405.2 7555.0 7557.1 7185.2 7198.3 7264.6 7284.0 7316.2 7672.3 7871.6 7879.3 7899.2 7920.1 7046.5 7060.0 7095.1 7136.1 7143.4 7183.2 7207.7 7251.2 7257.8 7261.2 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5630.72 Median:6479.38 stddev:1791.67 (27.7%) stddev-sans-first:1751.81 18:09:44 INFO - PROCESS | 1668 | Values: 320.9 321.8 327.4 331.6 332.3 6485.7 6502.8 6517.9 6555.2 6602.6 6472.2 6478.4 6480.4 6491.8 6502.1 4619.1 4705.1 4727.7 4812.7 4882.8 4786.2 4801.1 4806.1 4832.7 4839.0 4782.1 4790.2 4796.2 4808.1 4820.2 4574.1 4672.6 4792.3 4801.7 4808.3 4090.9 4108.5 4116.1 4117.0 4125.6 6164.0 6166.0 6226.2 6228.1 6255.3 5584.3 5586.4 5589.2 5589.2 5597.4 6813.7 6823.1 6828.8 6830.3 6860.6 4260.9 4403.6 4411.4 4417.6 4422.2 5353.6 7143.9 7236.6 7250.5 7251.6 4506.7 4512.8 4513.3 4520.5 4528.4 4579.3 4584.8 4585.8 4602.5 4612.0 5429.6 5434.6 5437.6 5440.5 5441.0 5596.6 6602.3 6846.1 6870.8 6910.0 1570.9 1578.0 1591.8 1594.3 1596.4 946.3 975.8 1008.9 1010.8 1039.6 6289.6 6295.0 6321.6 6360.5 6364.9 7163.8 7178.7 7188.0 7194.5 7224.9 6494.7 6513.3 6525.6 6529.2 6539.8 3759.6 3794.7 3798.4 3806.8 3812.2 6930.8 7225.3 7558.6 7581.6 7587.2 6036.0 7375.3 7442.9 7448.4 7449.9 6117.3 7548.6 7550.4 7554.0 7559.1 6687.2 6714.5 6874.3 7168.3 7182.8 7006.2 7042.6 7066.6 7089.6 7108.0 7479.9 7529.9 7534.6 7564.8 7575.9 4510.5 4555.5 4556.1 4559.5 4562.8 7098.9 7132.6 7136.4 7137.2 7138.8 6552.6 6888.6 6894.5 6915.2 6948.4 6904.1 6915.2 6916.9 6917.1 6920.6 6750.2 6751.8 6760.3 6761.4 6764.8 5718.4 6625.5 6880.4 6893.7 6921.8 6474.5 6625.3 6660.3 6734.0 6796.8 18:09:44 INFO - PROCESS | 1668 | 18:09:44 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18581.07 Median:31200.84 stddev:26188.42 (83.9%) stddev-sans-first:26227.30 18:09:44 INFO - PROCESS | 1668 | Values: 657.9 728.4 732.7 742.1 823.3 15029.5 15199.0 15200.3 15206.7 15217.8 14012.9 14153.4 14416.8 14438.6 14445.6 733.8 751.9 907.5 925.3 936.5 930.2 949.3 949.9 952.0 954.8 981.0 983.9 984.1 985.7 986.9 787.8 974.7 978.8 979.3 996.2 723.4 723.7 723.8 724.5 724.6 15236.8 15251.7 15257.8 15261.7 15268.3 12868.8 12892.5 13178.3 13186.1 13317.2 10048.8 10136.6 10153.2 10278.2 10944.0 3107.8 3540.9 3606.4 3676.9 3720.9 85073.0 85162.6 85529.0 85670.3 85850.6 9543.6 9685.8 9711.5 9966.0 10599.2 21898.6 22158.9 22161.6 22186.2 22204.9 7652.3 7826.7 7885.5 8020.3 8078.8 4098.5 4123.7 4154.7 4160.7 4199.3 3599.2 3651.9 3655.2 3657.1 3663.4 619.0 669.6 673.8 676.2 686.1 531.2 565.0 589.9 599.3 613.2 7892.8 7901.2 8003.7 8067.3 8287.7 584.5 590.4 593.9 605.5 624.5 3567.8 3738.8 3763.7 3879.0 3943.7 64755.7 92020.5 97517.5 98224.5 98475.0 77266.2 78171.2 79661.6 80592.6 82149.6 58901.1 61782.7 62573.7 63462.7 64253.7 7928.0 8194.9 8314.7 8328.3 8388.7 53474.7 53537.0 53948.7 54052.0 54491.0 73952.0 74463.0 75130.0 75856.0 76018.0 11090.9 11186.8 11196.4 11390.7 11896.0 10061.4 10635.1 11989.3 12128.7 12373.6 11454.3 11478.0 11711.0 11870.5 12065.1 11533.3 11677.3 11685.5 11694.2 11711.7 9109.9 11350.0 11753.5 12082.3 12200.0 8679.4 9173.0 9298.8 9302.0 9380.0 9109.0 9494.8 9546.7 9549.3 9565.6 18:09:44 INFO - PROCESS | 1668 | -------- Summary: end -------- 18:09:44 INFO - PROCESS | 1668 | 18:09:45 INFO - TEST-INFO | 1668: exit 0 18:09:45 INFO - TEST-OK | dromaeo_css | took 1114230ms 18:09:45 INFO - TEST-START | kraken 18:09:45 INFO - operating with platform_type : mac_ 18:09:45 INFO - Initialising browser for kraken test... 18:09:45 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpD8bwl7/profile http://localhost:49273/getInfo.html) 18:09:47 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 18:09:47 INFO - PROCESS | 1677 | colorDepth:24 18:09:47 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 18:09:47 INFO - PROCESS | 1677 | __metrics 18:09:47 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:09:47 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:09:47 INFO - TEST-INFO | 1677: exit 0 18:09:47 INFO - Browser initialized. 18:09:47 INFO - Running cycle 1/1 for kraken test... 18:09:48 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpD8bwl7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:59 INFO - PROCESS | 1679 | RSS: Main: 241803264 18:09:59 INFO - PROCESS | 1679 | 18:10:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:03 INFO - PROCESS | 1679 | RSS: Main: 290283520 18:10:03 INFO - PROCESS | 1679 | 18:10:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 18:10:06 INFO - PROCESS | 1679 | RSS: Main: 300601344 18:10:06 INFO - PROCESS | 1679 | 18:10:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 18:10:10 INFO - PROCESS | 1679 | RSS: Main: 289284096 18:10:10 INFO - PROCESS | 1679 | 18:10:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 18:10:12 INFO - PROCESS | 1679 | RSS: Main: 290652160 18:10:12 INFO - PROCESS | 1679 | 18:10:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:15 INFO - PROCESS | 1679 | RSS: Main: 290525184 18:10:15 INFO - PROCESS | 1679 | 18:10:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:18 INFO - PROCESS | 1679 | RSS: Main: 293150720 18:10:18 INFO - PROCESS | 1679 | 18:10:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:22 INFO - PROCESS | 1679 | RSS: Main: 293359616 18:10:22 INFO - PROCESS | 1679 | 18:10:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 18:10:25 INFO - PROCESS | 1679 | RSS: Main: 292052992 18:10:25 INFO - PROCESS | 1679 | 18:10:27 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:27 INFO - PROCESS | 1679 | RSS: Main: 324407296 18:10:27 INFO - PROCESS | 1679 | 18:10:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:30 INFO - PROCESS | 1679 | RSS: Main: 324665344 18:10:30 INFO - PROCESS | 1679 | 18:10:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:33 INFO - PROCESS | 1679 | RSS: Main: 331595776 18:10:33 INFO - PROCESS | 1679 | 18:10:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:10:36 INFO - PROCESS | 1679 | RSS: Main: 334151680 18:10:36 INFO - PROCESS | 1679 | 18:10:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:10:39 INFO - PROCESS | 1679 | RSS: Main: 333549568 18:10:39 INFO - PROCESS | 1679 | 18:10:40 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 18:10:41 INFO - PROCESS | 1679 | RSS: Main: 393322496 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | __start_tp_report 18:10:41 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 18:10:41 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 18:10:41 INFO - PROCESS | 1679 | |i|pagename|runs| 18:10:41 INFO - PROCESS | 1679 | |0;ai-astar;109;107;111;111;113;113;117;111;111;111 18:10:41 INFO - PROCESS | 1679 | |1;audio-beat-detection;173;152;167;168;121;138;141;119;161;116 18:10:41 INFO - PROCESS | 1679 | |2;audio-dft;183;183;185;187;186;184;186;185;183;182 18:10:41 INFO - PROCESS | 1679 | |3;audio-fft;77;78;86;97;81;84;67;81;77;55 18:10:41 INFO - PROCESS | 1679 | |4;audio-oscillator;91;101;130;80;76;83;119;75;79;117 18:10:41 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;88;94;91;94;91;94;88;94;87 18:10:41 INFO - PROCESS | 1679 | |6;imaging-darkroom;96;147;148;105;95;96;96;97;96;95 18:10:41 INFO - PROCESS | 1679 | |7;imaging-desaturate;85;87;87;84;87;86;88;87;88;87 18:10:41 INFO - PROCESS | 1679 | |8;json-parse-financial;55;55;55;54;55;54;54;63;55;53 18:10:41 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;67;71;74;79;71;67;68;69;67;74 18:10:41 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;84;84;81;81;83;82;73;82;101 18:10:41 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;124;123;121;121;121;123;132;118;105;109 18:10:41 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;136;125;139;138;137;127;141;137;136;140 18:10:41 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;57;63;89;72;66;67;69;90;93;56 18:10:41 INFO - PROCESS | 1679 | __end_tp_report 18:10:41 INFO - PROCESS | 1679 | __start_cc_report 18:10:41 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1320 18:10:41 INFO - PROCESS | 1679 | __end_cc_report 18:10:41 INFO - PROCESS | 1679 | __startTimestamp1458177041212__endTimestamp 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | ------- Summary: start ------- 18:10:41 INFO - PROCESS | 1679 | Number of tests: 14 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.65 18:10:41 INFO - PROCESS | 1679 | Values: 109.0 107.0 111.0 111.0 113.0 113.0 117.0 111.0 111.0 111.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:156.50 stddev:21.75 (13.9%) stddev-sans-first:20.68 18:10:41 INFO - PROCESS | 1679 | Values: 173.0 152.0 167.0 168.0 121.0 138.0 141.0 119.0 161.0 116.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.65 (0.9%) stddev-sans-first:1.67 18:10:41 INFO - PROCESS | 1679 | Values: 183.0 183.0 185.0 187.0 186.0 184.0 186.0 185.0 183.0 182.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:78.30 Median:81.00 stddev:11.21 (13.8%) stddev-sans-first:11.88 18:10:41 INFO - PROCESS | 1679 | Values: 77.0 78.0 86.0 97.0 81.0 84.0 67.0 81.0 77.0 55.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:77.50 stddev:20.34 (26.2%) stddev-sans-first:21.52 18:10:41 INFO - PROCESS | 1679 | Values: 91.0 101.0 130.0 80.0 76.0 83.0 119.0 75.0 79.0 117.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:92.50 stddev:2.96 (3.2%) stddev-sans-first:2.95 18:10:41 INFO - PROCESS | 1679 | Values: 88.0 88.0 94.0 91.0 94.0 91.0 94.0 88.0 94.0 87.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:96.00 stddev:21.49 (22.4%) stddev-sans-first:22.42 18:10:41 INFO - PROCESS | 1679 | Values: 96.0 147.0 148.0 105.0 95.0 96.0 96.0 97.0 96.0 95.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 18:10:41 INFO - PROCESS | 1679 | Values: 85.0 87.0 87.0 84.0 87.0 86.0 88.0 87.0 88.0 87.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.79 (5.1%) stddev-sans-first:2.96 18:10:41 INFO - PROCESS | 1679 | Values: 55.0 55.0 55.0 54.0 55.0 54.0 54.0 63.0 55.0 53.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:3.97 (5.6%) stddev-sans-first:3.98 18:10:41 INFO - PROCESS | 1679 | Values: 67.0 71.0 74.0 79.0 71.0 67.0 68.0 69.0 67.0 74.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:6.95 (8.4%) stddev-sans-first:7.37 18:10:41 INFO - PROCESS | 1679 | Values: 83.0 84.0 84.0 81.0 81.0 83.0 82.0 73.0 82.0 101.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:122.00 stddev:7.67 (6.3%) stddev-sans-first:7.98 18:10:41 INFO - PROCESS | 1679 | Values: 124.0 123.0 121.0 121.0 121.0 123.0 132.0 118.0 105.0 109.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.60 Median:137.50 stddev:5.34 (3.9%) stddev-sans-first:5.66 18:10:41 INFO - PROCESS | 1679 | Values: 136.0 125.0 139.0 138.0 137.0 127.0 141.0 137.0 136.0 140.0 18:10:41 INFO - PROCESS | 1679 | 18:10:41 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:70.50 stddev:13.69 (19.4%) stddev-sans-first:13.36 18:10:41 INFO - PROCESS | 1679 | Values: 57.0 63.0 89.0 72.0 66.0 67.0 69.0 90.0 93.0 56.0 18:10:41 INFO - PROCESS | 1679 | -------- Summary: end -------- 18:10:41 INFO - PROCESS | 1679 | 18:10:42 INFO - TEST-INFO | 1679: exit 0 18:10:42 INFO - TEST-OK | kraken | took 56944ms 18:10:42 INFO - SUITE-END | took 1171s 18:10:42 INFO - Completed test suite (00:19:31) 18:10:42 INFO - javascript benchmark 18:10:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3400.166959095022, 3477.426224672929, 3503.6671516205965, 3509.84205710743, 3563.037979745469, 5327.334083239595, 5526.088195447746, 5650.350209725878, 5662.009148399029, 5667.319921609407, 5509.696966666832, 5605.299337582802, 5614.9438505614935, 5615.803446879349, 5631.493165615104, 5084.8983020339665, 5114.718690472023, 5136.43499215086, 5152.0, 5202.479752024805, 5212.713300768456, 5215.713135777531, 5215.817446389377, 5216.400113986883, 5220.843374698746, 5148.510891465305, 5173.430922598511, 5202.401723801754, 5217.843464696065, 5238.869028274305, 5199.272101905717, 5220.0, 5231.843044708665, 5248.737563121828, 5294.49702278283, 5028.622853286018, 5072.822451214227, 5153.484651534854, 5160.664556803796, 5164.354455693038, 5483.588730845203, 5488.69812160331, 5545.417731138213, 5602.803901863456, 5622.381538030813, 6167.845803854894, 6181.907271390888, 6190.3190649028575, 6207.906881396782, 6209.565330426872, 6084.117802918597, 6227.906581401283, 6280.560360774748, 6292.748290068392, 6304.87390252197, 5651.0, 5698.1452782083015, 5714.428557144252, 5738.856528586777, 5754.856128596819, 6249.468795152372, 6250.1874756281395, 6251.343608920998, 6256.6871656417, 6268.937310626927, 5852.385499522489, 5884.0, 6059.7273122709585, 6075.179850720185, 6083.8479038023515, 6114.479856340571, 6132.540059495555, 6177.413145751147, 6177.938220617826, 6200.503959683215, 6100.206973093469, 6105.080114271519, 6106.114613381035, 6117.112675004028, 6119.83850981328, 6013.6692481913915, 6114.755409783648, 6131.417515336036, 6160.784372546939, 6172.259328880563, 4779.378680771478, 4794.376731025014, 4817.1810792164715, 4820.879478013007, 4824.059308434892, 4336.522982471989, 4339.284018137035, 4373.125374925028, 4398.274284742982, 4398.934015989763, 4706.4822869485015, 5636.689982051026, 5649.943500565024, 5655.519280861091, 5668.121441176624, 5248.317718696545, 6194.690265486708, 6286.591371560834, 6286.779962701284, 6307.9369206308265, 5715.31416230055, 5717.17101020358, 5723.77104915807, 5726.3700992890745, 5782.913256301159, 5319.946800531945, 5321.733913304397, 5326.201069839555, 5329.280547126166, 5331.546818520392, 6159.722812473449, 6185.41238582334, 6264.937350626436, 6266.937330626635, 6285.402886725754, 6245.437910588069, 6252.280987686292, 6255.155554000152, 6260.248770147611, 6283.717232724447, 6235.033569796688, 6243.375662433902, 6258.249010118633, 6275.592086514362, 6293.842653933505, 5935.080062590306, 6056.0, 6066.575339726177, 6101.603395779438, 6146.231721034871, 6237.625742455467, 6247.906281405873, 6250.124982502544, 6253.96873015632, 6267.310595834546, 5950.404959504015, 5962.2249107615735, 5973.616775184193, 6009.819705408845, 6030.7889223876955, 4637.513061128533, 5892.469677729025, 5935.40645935403, 6037.879242415215, 6111.205543279523, 5133.512316329943, 5274.892272622792, 5691.886162276648, 5834.708264586839, 5918.964181268175, 5894.145348924296, 5945.3757355477055, 5989.071693887455, 6012.098185272244, 6027.75888964454, 5836.9416305838095, 5846.35690074083, 5944.851378715567, 5956.583039187215, 5977.880442391215], "unit": "score", "name": "dojo.html", "value": 5625.207172314915}, {"lowerIsBetter": false, "replicates": [515.1860061103457, 516.9170587618939, 571.7084287013624, 643.4530648948395, 646.8188907106011, 34179.65820341796, 39693.80153099238, 39916.0, 39923.80419076949, 39927.60072399275, 42068.15863682725, 42631.0, 42663.57336426635, 42735.57264427355, 42819.0, 9513.5243237838, 9749.902500974971, 9750.12248897599, 9756.073173048584, 9784.55969481375, 8498.66005359788, 9652.034796520362, 9729.124378805906, 9924.206063514937, 9958.452285124315, 9873.753156171082, 9937.25470589705, 9939.55272012761, 9942.950285248564, 9957.75105622358, 9814.16579590732, 9827.606895724162, 9851.802963940752, 9891.505424728806, 9914.504274786232, 9699.157160139552, 9813.558389872473, 9821.607135714563, 9827.164691001202, 9845.507724613812, 41292.38061429081, 41621.375679364835, 41623.0, 41702.0, 41842.953926151786, 3194.4090343286566, 3602.9819850900576, 3835.002899246188, 3871.845126194949, 3950.1309711863346, 24238.39404014896, 28928.71071289281, 29214.561781573295, 29956.0, 29980.400391992258, 2693.407450360937, 2749.560070388728, 2775.5420355641295, 2834.518131917579, 2850.44416338814, 440204.0, 505357.0, 505594.0, 505677.0, 505939.0, 60222.88105510993, 60327.396726033054, 60382.39617603856, 60535.39464605298, 60979.39020609737, 67250.0, 67426.0, 67466.66266668636, 67564.6621766888, 67590.66204668945, 15501.844981550266, 16922.40771572989, 17144.314227431012, 17176.742348864776, 17213.65572688564, 11755.294682319089, 11840.934315911609, 11862.0, 11864.169508134348, 13204.943604511616, 16442.241335779552, 23509.882450587636, 23712.85025120597, 23774.88112559426, 23790.0, 8296.958515207507, 10163.695089147337, 10314.1748660107, 10328.535215915303, 10335.534900929477, 1019.6176433837311, 1027.8972102789662, 1050.4852622215212, 1095.2771171027084, 1111.8888111188978, 26112.86943565308, 29479.11562653124, 29673.554896676567, 30044.84977575142, 30562.541561876144, 1069.4813015687384, 1103.2608152537819, 1135.239389608964, 1177.2583272538418, 1232.5870833270956, 15017.399304027935, 15155.318010689545, 15259.313330899915, 15651.0, 15662.765058524132, 726016.0, 737761.0, 738531.0, 739192.0, 740059.0, 59673.40326596765, 60418.39581604215, 60580.394196058354, 60590.091148632804, 60745.0, 1354.0, 1364.501956785766, 1446.146773403697, 1469.1919444305588, 1492.380662025269, 29364.706352937053, 29499.0, 30157.944471943378, 30740.385192296475, 31704.682953171097, 49720.756981074315, 53493.19760203678, 57031.42968570427, 57071.71464142819, 57183.71408142932, 416259.0, 418750.90624546685, 422782.0, 423271.0, 424230.0, 36966.63033369632, 43649.908752281444, 44674.3298850524, 44895.55104448914, 45047.774761125984, 43259.783701081295, 43700.125997479234, 43876.34185487156, 44872.77563612292, 44874.551254487036, 36075.0, 36090.0, 36505.26989460249, 37054.258914822094, 37113.88658340254, 35496.290074198885, 35889.64110358863, 36218.4567231497, 36412.635873640924, 36781.0, 35144.12139696528, 35688.82155589206, 36016.0, 36815.44776828403, 37942.8102859495, 31469.0, 31663.040623249995, 32560.67439325671, 32874.17814554655, 33082.66917330796, 20459.0, 21597.676034859174, 23122.0, 24354.147604833746, 24890.377740556632], "unit": "score", "name": "ext.html", "value": 20445.06911891586}, {"lowerIsBetter": false, "replicates": [354.7481288285319, 361.2828535357316, 362.34596553221434, 364.4969941480756, 367.6103330469701, 19450.41648750538, 19693.31073412431, 20123.899380503095, 20541.0, 20572.279970201045, 19539.609207815836, 20283.898580507113, 20514.179432822708, 20811.895940520313, 20815.895920520416, 5181.455947125554, 5705.686187259699, 5754.597178197528, 5767.30792304924, 5773.740181691834, 4256.106217694288, 4395.142947125312, 6001.399860014008, 6390.169277993854, 6683.6658167091455, 6568.441682456997, 6586.077949087132, 6599.076129341896, 6607.041978913055, 6609.966950165242, 6268.999999999977, 6536.3463653634735, 6544.3782840630065, 6552.0, 6554.868902621968, 3767.472553842437, 5364.865878353034, 5579.9163012554845, 5612.0, 5645.604807663465, 25249.873750631312, 25686.48627027449, 25699.35751606206, 25909.61135582968, 25990.35024124393, 1969.812867777559, 2148.6239908016037, 2444.352246654638, 2619.89520419183, 2807.663080430341, 9973.950130249303, 11255.887441125566, 14127.152370857679, 14616.707665846623, 14638.780418293734, 1732.8527075198624, 1753.4739578126512, 1773.760542326795, 1800.468861685806, 1876.3339014649875, 103857.48071259595, 105044.0, 107439.38840917393, 108033.0, 108181.45909270483, 11072.723181920355, 11076.778464430827, 11170.385628790333, 11180.329180249211, 11317.83023254652, 13449.260290684106, 13541.39063742134, 13541.984351173702, 13543.458261669422, 13544.729105418033, 8633.266172375294, 8655.0, 8667.739967800977, 8679.17547832955, 8794.516301603346, 8840.33697472692, 8841.867371989425, 8861.291096712248, 8944.776380590538, 8967.551622418852, 4470.284754439274, 4488.3940668010055, 4491.573300536509, 4505.098980203972, 4566.109608626286, 1590.5466941921497, 1744.9127543622767, 1801.6306657135256, 1810.6650269700147, 1811.6286161336893, 879.8900137482815, 879.9604017819214, 900.7252787899622, 936.8688383626297, 986.6793292180071, 16592.83407165913, 17514.56213594645, 18122.365717200097, 19585.510362241057, 19701.802981969995, 954.708813811794, 968.2931460034074, 1004.598160735697, 1014.3761586624173, 1019.2966852871643, 10334.379937203641, 10580.941905809357, 10612.734681633021, 10618.840717389245, 10657.467126643793, 517293.0, 527778.3611081997, 528939.7106028968, 640357.0, 644489.0, 120538.97193144826, 128074.71925280814, 128148.0, 128268.35865820611, 134821.32589337186, 981.1464026297025, 1034.7102811212872, 1055.0662663542666, 1068.0294855990685, 1070.4433694478828, 15199.468018619295, 15872.523824284828, 18240.087995600432, 18362.449126526226, 18610.0, 51608.48391516187, 52191.0, 52354.47645523496, 52706.0, 53087.73456132694, 66558.3376664928, 75457.24542754501, 75914.24085759293, 77030.0, 77094.614526927, 7381.44639152055, 7807.0, 7818.413618978486, 7902.130765615662, 8117.147699491705, 10943.726406839893, 12236.75526489483, 12327.93836030814, 12363.567275145328, 12914.806277906027, 10873.401962892116, 10965.342079475256, 10967.83548246761, 11185.384803835866, 11234.101271898391, 10703.036726694634, 10730.248882578144, 10907.96374344436, 10928.071113955402, 10974.890251097706, 10869.456527173768, 11139.387333696724, 11167.162462815484, 11203.43982800873, 11433.485493152662, 7413.629318533944, 7820.765377038698, 7855.882161767464, 7924.881126783218, 7993.560354180576, 8185.0, 10512.57949682004, 10607.840882386925, 10970.286931349756, 11042.116630669367], "unit": "score", "name": "jquery.html", "value": 9454.190725049419}, {"lowerIsBetter": false, "replicates": [1413.6112569043519, 1566.5457017464935, 1573.409971260777, 1858.8419984301333, 2014.8186663200308, 7882.605869706514, 8599.871001934967, 8769.693060742875, 8779.561021948908, 8805.823883522342, 8279.296259817922, 8544.91455085449, 8547.829043419128, 8553.272971797405, 8555.95722021389, 2152.547964927367, 2402.627592723122, 2449.669294645218, 2455.238875948453, 2468.8518688878635, 2143.9249626263086, 2485.403503159247, 2501.6747822783104, 2502.4995000999784, 2505.649209110726, 2427.7329493755674, 2440.9389765255833, 2481.2060140754966, 2481.838680485772, 2494.787943024845, 2433.3429973907123, 2462.0, 2467.8272520923542, 2487.328421326232, 2492.962605560918, 2463.88912498938, 2469.580171370871, 2472.4807790364043, 2499.762522560354, 2501.46218563008, 8696.217340439327, 8764.386492945496, 8766.736997890073, 8774.254188393994, 8849.115088491164, 4797.232442809134, 5231.136862417697, 5492.066348720727, 5494.725263736797, 5494.972525137388, 3565.625609311037, 3651.361011822947, 3729.0863738384, 3751.8124093795473, 3757.8684746034032, 1033.3283365812208, 1054.741588310861, 1054.9050585447346, 1065.7388939709742, 1069.4171676436283, 10833.970772776574, 11120.944395278053, 11764.470598823074, 11852.34812085335, 11859.46632401544, 4803.927941080887, 4858.659893807399, 4937.506249375034, 4966.627502937295, 4967.776450059756, 10028.247881408923, 10069.79860402788, 10095.343802652804, 10105.191584673208, 10110.191184705205, 5483.972580137074, 5499.120140777536, 5500.779968801203, 5504.6421982571, 5509.834704958857, 4380.058287468146, 4538.0, 4855.708657480563, 4893.608511319086, 4957.256411538298, 3877.3602355611574, 3952.802359882052, 3967.444557761916, 3989.9601003989587, 4015.7791321477016, 1280.7822670146097, 1303.7327347893658, 1304.2956803326097, 1313.6584488032988, 1316.3747220070582, 1057.878343990451, 1082.832161015044, 1210.2617403383929, 1408.5140626483847, 1408.6830463145916, 8074.434789564674, 8368.916310836814, 8377.162283771697, 8381.371397145238, 8382.329413646894, 1181.6676970942033, 1183.1836033137108, 1196.2882085159317, 1204.1270079192516, 1215.8966487848454, 5274.709890955957, 6312.400321969406, 6359.077933699587, 6364.809055728336, 6380.298167201604, 10207.489625518694, 10630.09644180238, 10649.041586257274, 10656.307340022873, 10672.893271067345, 8385.874211886827, 10420.843687344695, 10447.84328235077, 10491.0, 10494.370337779757, 8103.432759706882, 8211.671533138608, 8239.958800206081, 8272.131426200403, 8300.335973122135, 7948.602569871599, 7975.880361794694, 8020.398470114881, 8055.073666528424, 8061.0, 9350.719478415658, 9481.383710058824, 9483.430994140097, 9568.712938611852, 9582.856257156009, 7902.130765615662, 9931.404115752788, 9975.002499749968, 10135.138513226459, 10350.378977261389, 6808.863822723617, 7011.509194356346, 7316.597587132759, 7562.962185189039, 7721.6911323548675, 7040.0847889774, 8337.95831020841, 8407.789805254917, 8413.70552030676, 8465.915340846514, 7348.485606007742, 7383.483156179016, 7405.185429602631, 7554.962225188839, 7557.130929943127, 7185.173705023989, 7198.280171982759, 7264.636768161465, 7284.0, 7316.158641756266, 7672.309492145734, 7871.567063811545, 7879.251471110236, 7899.170587088273, 7920.128785833438, 7046.541974771829, 7060.046893669289, 7095.148582170173, 7136.143662760502, 7143.428525718034, 7183.173934997333, 7207.6756545956605, 7251.202367739439, 7257.818554536178, 7261.201267860425], "unit": "score", "name": "mootools.html", "value": 4937.550654388956}, {"lowerIsBetter": false, "replicates": [320.855614973262, 321.7699344968347, 327.39268656641946, 331.60870173195633, 332.3419629134315, 6485.740570377186, 6502.80491585252, 6517.869642607145, 6555.180602424697, 6602.570832895858, 6472.223333200022, 6478.416942475176, 6480.351964803517, 6491.8377040574005, 6502.122213501176, 4619.099275641234, 4705.058988202356, 4727.716337019772, 4812.7352995585225, 4882.755862206894, 4786.21027530457, 4801.063792560452, 4806.110869489138, 4832.73419961902, 4838.983813399191, 4782.13921494131, 4790.1856684363565, 4796.208625576775, 4808.110499557593, 4820.156472617296, 4574.130915126132, 4672.579467847893, 4792.30511575823, 4801.68789028712, 4808.278758186265, 4090.9386359204336, 4108.4864391951005, 4116.115035267402, 4117.011917139895, 4125.566815484391, 6164.044573091178, 6166.0, 6226.159468471744, 6228.128062071313, 6255.343188965184, 5584.329880414336, 5586.441355864422, 5589.161625756169, 5589.245451864028, 5597.412271711493, 6813.693383797741, 6823.112995310627, 6828.829279268009, 6830.282820303896, 6860.5540639858245, 4260.936085958682, 4403.6256918162, 4411.404460397869, 4417.624501917341, 4422.248217802981, 5353.57171426285, 7143.92856071443, 7236.638168091575, 7250.45621578389, 7251.637418129072, 4506.684532082788, 4512.751798651106, 4513.255312873404, 4520.480144783326, 4528.41130653013, 4579.267317229294, 4584.816607335736, 4585.770711464414, 4602.516735742765, 4612.0, 5429.56563474921, 5434.592405569598, 5437.592180586472, 5440.455954404607, 5441.0, 5596.636218645856, 6602.316409315594, 6846.110005699227, 6870.7595234166565, 6910.0, 1570.89789163704, 1578.0, 1591.7851090102688, 1594.3463180096105, 1596.3933705191953, 946.2571881073325, 975.7755716185317, 1008.9495525223709, 1010.7523656704154, 1039.589362201926, 6289.591176573508, 6295.0, 6321.557490975588, 6360.459360954371, 6364.904526432108, 7163.820904477429, 7178.748743793943, 7188.0, 7194.460415468756, 7224.927750722531, 6494.740210391531, 6513.348665133449, 6525.575837570543, 6529.249136349381, 6539.803805885831, 3759.6240375962734, 3794.734368594227, 3798.3732684106812, 3806.809659517013, 3812.218495208476, 6930.757423490154, 7225.313595208447, 7558.58427786466, 7581.583012934231, 7587.203343648947, 6036.0, 7375.336219740142, 7442.8883566746545, 7448.366888814403, 7449.88825167623, 6117.296510901214, 7548.584827834522, 7550.395968322631, 7553.962230188814, 7559.092908850973, 6687.164104486939, 6714.496412768965, 6874.278200788845, 7168.319009694071, 7182.784516464514, 7006.229314775269, 7042.577445353295, 7066.611336376549, 7089.645517724196, 7108.0, 7479.88780168287, 7529.88705169412, 7534.585597792174, 7564.773056808304, 7575.924240757522, 4510.50384457716, 4555.521670224579, 4556.134334476439, 4559.475660299108, 4562.7946742397335, 7098.929010709827, 7132.643367831692, 7136.429085673238, 7137.179224389261, 7138.821529461805, 6552.6068435894, 6888.586684798727, 6894.482913781587, 6915.170179578483, 6948.374646281859, 6904.067950826574, 6915.204751453446, 6916.861662766616, 6917.066196063467, 6920.619365934922, 6750.189977202767, 6751.763688270887, 6760.290169532325, 6761.357671021246, 6764.830879228059, 5718.428157184248, 6625.469962403093, 6880.415164710856, 6893.655317234018, 6921.792346229621, 6474.482041436768, 6625.337466253336, 6660.333966603301, 6733.966330168318, 6796.830079248059], "unit": "score", "name": "prototype.html", "value": 5028.714808601314}, {"lowerIsBetter": false, "replicates": [657.868426314737, 728.4099879097931, 732.7252280394852, 742.1391186223974, 823.3166471828383, 15029.549113526584, 15199.0, 15200.315985780639, 15206.695866082699, 15217.847821521795, 14012.929935350334, 14153.363098660559, 14416.783748243784, 14438.5668429947, 14445.566633001, 733.7651951375562, 751.8796992481205, 907.5235501361789, 925.3291363761286, 936.4755736787421, 930.1628534319133, 949.278548303291, 949.8907625623038, 951.9666811661593, 954.7994921066585, 981.043482604462, 983.8622592837008, 984.099548912744, 985.6550207427415, 986.8865080515725, 787.7794217619075, 974.6832279509188, 978.8091322192175, 979.2704435195753, 996.1532697207316, 723.3562129704567, 723.7286017743346, 723.7683941138838, 724.4566575068699, 724.561640207672, 15236.847631523653, 15251.694966100727, 15257.847421525754, 15261.694766104616, 15268.31292591836, 12868.806967895489, 12892.484300627964, 13178.34108294591, 13186.142900711424, 13317.200967941955, 10048.849267260997, 10136.594536218543, 10153.187744980383, 10278.22913281507, 10944.002227381872, 3107.8135311881133, 3540.8760693375607, 3606.441001644749, 3676.852925882988, 3720.9069773255615, 85073.0, 85162.57418712928, 85529.0, 85670.28659426839, 85850.57074714648, 9543.570539325747, 9685.806283874424, 9711.514424278757, 9965.950170249102, 10599.205059620404, 21898.562028759654, 22158.88920555419, 22161.55676886453, 22186.223482178048, 22204.88897555502, 7652.311291983749, 7826.686932522749, 7885.526868387915, 8020.278174964281, 8078.838423231502, 4098.4876890388705, 4123.731957422758, 4154.709170358106, 4160.667146628323, 4199.328107502785, 3599.208174201671, 3651.8721844735837, 3655.1775850433974, 3657.104009517685, 3663.377225871608, 618.981430557084, 669.5915491550151, 673.7540797608838, 676.1851968378093, 686.0909295183901, 531.2429787552722, 565.0108162035564, 589.9026660600953, 599.2629066248538, 613.1691557939017, 7892.802679933047, 7901.249381308767, 8003.6798528058225, 8067.314278286294, 8287.668493260322, 584.4710536964054, 590.3918963467635, 593.8693487432757, 605.5065121925617, 624.4723208888482, 3567.839447224881, 3738.7569807962395, 3763.698904087721, 3878.96121038786, 3943.7042221832903, 64755.67622161859, 92020.53989730008, 97517.5372369415, 98224.52663210058, 98475.01524984802, 77266.22733772703, 78171.21828781639, 79661.60169199116, 80592.59703701444, 82149.58925205335, 58901.11648325279, 61782.69108654428, 62573.68713156405, 63462.68268658719, 64253.67873160604, 7927.960360198162, 8194.852720619, 8314.708985185489, 8328.3337333012, 8388.706395276136, 53474.73262633662, 53537.0, 53948.73025634847, 54052.0, 54491.0, 73952.0, 74463.0, 75130.0, 75856.0, 76018.0, 11090.889091108986, 11186.83219751688, 11196.440177991231, 11390.658280251606, 11896.048316134862, 10061.446620435654, 10635.096016838655, 11989.280643161439, 12128.696782580506, 12373.566925157937, 11454.255473394203, 11478.02436792882, 11711.0, 11870.52517899309, 12065.09511786602, 11533.308001519936, 11677.299362038304, 11685.474153662935, 11694.181407301407, 11711.707207319885, 9109.90890091117, 11350.0, 11753.529858805894, 12082.33547154915, 12200.023998080309, 8679.392442528962, 9173.0, 9298.814023719622, 9301.953490232776, 9380.0, 9108.954455227682, 9494.810103798023, 9546.665866694633, 9549.283803714889, 9565.569549370155], "unit": "score", "name": "yui.html", "value": 6993.993347325324}], "name": "dromaeo_css", "value": 7574.378486241609}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 111.0, 111.0, 113.0, 113.0, 117.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [173.0, 152.0, 167.0, 168.0, 121.0, 138.0, 141.0, 119.0, 161.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 185.0, 187.0, 186.0, 184.0, 186.0, 185.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 86.0, 97.0, 81.0, 84.0, 67.0, 81.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [91.0, 101.0, 130.0, 80.0, 76.0, 83.0, 119.0, 75.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 94.0, 91.0, 94.0, 91.0, 94.0, 88.0, 94.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.9}, {"lowerIsBetter": true, "replicates": [96.0, 147.0, 148.0, 105.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 107.1}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 84.0, 87.0, 86.0, 88.0, 87.0, 88.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 63.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 74.0, 79.0, 71.0, 67.0, 68.0, 69.0, 67.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 81.0, 81.0, 83.0, 82.0, 73.0, 82.0, 101.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [124.0, 123.0, 121.0, 121.0, 121.0, 123.0, 132.0, 118.0, 105.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [136.0, 125.0, 139.0, 138.0, 137.0, 127.0, 141.0, 137.0, 136.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.6}, {"lowerIsBetter": true, "replicates": [57.0, 63.0, 89.0, 72.0, 66.0, 67.0, 69.0, 90.0, 93.0, 56.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1436.3}]} 18:10:42 INFO - Return code: 0 18:10:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:10:42 ERROR - # TBPL SUCCESS # 18:10:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:42 INFO - 2016-03-16 18:10:42.523 screenresolution[1683:9886] starting screenresolution argv=screenresolution get 18:10:42 INFO - 2016-03-16 18:10:42.526 screenresolution[1683:9886] Display 0: 1600x1200x32@60 18:10:42 INFO - 2016-03-16 18:10:42.532 screenresolution[1684:9889] starting screenresolution argv=screenresolution list 18:10:42 INFO - Available Modes on Display 0 18:10:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:42 INFO - Intel Iris: 18:10:42 INFO - Chipset Model: Intel Iris 18:10:42 INFO - Type: GPU 18:10:42 INFO - Bus: Built-In 18:10:42 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:42 INFO - Vendor: Intel (0x8086) 18:10:42 INFO - Device ID: 0x0a2e 18:10:42 INFO - Revision ID: 0x0009 18:10:42 INFO - Displays: 18:10:42 INFO - Display: 18:10:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:42 INFO - Display Serial Number: 1600x1200 60 18:10:42 INFO - Main Display: Yes 18:10:42 INFO - Mirror: Off 18:10:42 INFO - Online: Yes 18:10:42 INFO - Rotation: Supported 18:10:42 INFO - Return code: 0 18:10:42 INFO - Running post-action listener: _resource_record_post_action 18:10:42 INFO - Running post-run listener: _resource_record_post_run 18:10:43 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 36738560; Write bytes: 703750656; Read time: 404; Write time: 2045 18:10:43 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 380967424; Write bytes: 375446528; Read time: 29343; Write time: 710 18:10:43 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 35804672; Write bytes: 299206144; Read time: 389; Write time: 1276 18:10:43 INFO - Running post-run listener: _upload_blobber_files 18:10:43 INFO - Blob upload gear active. 18:10:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:10:43 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 18:10:43 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'] 18:10:43 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 18:10:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:10:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:45 INFO - (blobuploader) - INFO - Done attempting. 18:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:46 INFO - (blobuploader) - INFO - Done attempting. 18:10:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:10:46 INFO - Return code: 0 18:10:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:10:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:10:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c642f4abdbe12234225104ab83d06b0796444778aef65f9a27ea246b397f6168fe5aafcf6035d54a167fe471468a1492924eca3b0aab8d4d24d93dccdc3816b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/040d5a4c6e4d0c2df76429dc976c1f7006610ead6e19cdbe8b08dda7fd0daf23f1c4b7b12e9c1db5613bba5aa76a8388a5285b6e4542446e634c519c5e8ecd57"} 18:10:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:10:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:10:46 INFO - Contents: 18:10:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c642f4abdbe12234225104ab83d06b0796444778aef65f9a27ea246b397f6168fe5aafcf6035d54a167fe471468a1492924eca3b0aab8d4d24d93dccdc3816b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/040d5a4c6e4d0c2df76429dc976c1f7006610ead6e19cdbe8b08dda7fd0daf23f1c4b7b12e9c1db5613bba5aa76a8388a5285b6e4542446e634c519c5e8ecd57"} 18:10:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:10:46 INFO - Copying logs to upload dir... 18:10:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:10:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.268695 ========= master_lag: 1.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-16 18:10:47.739741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-03-16 18:10:47.743697) ========= 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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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/c642f4abdbe12234225104ab83d06b0796444778aef65f9a27ea246b397f6168fe5aafcf6035d54a167fe471468a1492924eca3b0aab8d4d24d93dccdc3816b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/040d5a4c6e4d0c2df76429dc976c1f7006610ead6e19cdbe8b08dda7fd0daf23f1c4b7b12e9c1db5613bba5aa76a8388a5285b6e4542446e634c519c5e8ecd57"} build_url:https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010826 build_url: 'https://queue.taskcluster.net/v1/task/DR3lGnkcT_exMqeR9JJOJg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c642f4abdbe12234225104ab83d06b0796444778aef65f9a27ea246b397f6168fe5aafcf6035d54a167fe471468a1492924eca3b0aab8d4d24d93dccdc3816b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/040d5a4c6e4d0c2df76429dc976c1f7006610ead6e19cdbe8b08dda7fd0daf23f1c4b7b12e9c1db5613bba5aa76a8388a5285b6e4542446e634c519c5e8ecd57"}' ========= master_lag: 11.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-03-16 18:10:59.042055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 18:10:59.042359) ========= 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.dkiZcKZe3n/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.lsRIk3jgkp/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005275 ========= master_lag: 1.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 18:11:00.571125) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-03-16 18:11:00.571438) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-03-16 18:11:02.663366) ========= ========= Total master_lag: 14.37 =========