builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0083 starttime: 1459849804.02 results: success (0) buildid: 20160405005012 builduid: a8465b99cad74da68e5f43e279fb4cba revision: 3930bfe289c83593b4781f4a631444a5f1ca4afe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.016135) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.016513) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.016796) ========= 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.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005609 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.042112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.042411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.064017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.064359) ========= 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.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.113828) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.114138) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.114480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.114747) ========= 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.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-04-05 02:50:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.4M=0.001s 2016-04-05 02:50:04 (11.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.240327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.240635) ========= 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.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.026300 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:04.290433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 02:50:04.290760) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3930bfe289c83593b4781f4a631444a5f1ca4afe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3930bfe289c83593b4781f4a631444a5f1ca4afe --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-04-05 02:50:04,367 truncating revision to first 12 chars 2016-04-05 02:50:04,367 Setting DEBUG logging. 2016-04-05 02:50:04,367 attempt 1/10 2016-04-05 02:50:04,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3930bfe289c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 02:50:05,620 unpacking tar archive at: mozilla-central-3930bfe289c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.494914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 02:50:05.803195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:05.803546) ========= echo 3930bfe289c83593b4781f4a631444a5f1ca4afe in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3930bfe289c83593b4781f4a631444a5f1ca4afe'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 3930bfe289c83593b4781f4a631444a5f1ca4afe program finished with exit code 0 elapsedTime=0.005438 script_repo_revision: '3930bfe289c83593b4781f4a631444a5f1ca4afe' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:05.857327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:05.857630) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 02:50:05.877308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-05 02:50:05.877592) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:06 INFO - MultiFileLogger online at 20160405 02:50:06 in /builds/slave/test 02:50:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:50:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:50:06 INFO - {'append_to_log': False, 02:50:06 INFO - 'base_work_dir': '/builds/slave/test', 02:50:06 INFO - 'blob_upload_branch': 'Firefox', 02:50:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:50:06 INFO - 'branch': 'Firefox', 02:50:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:50:06 INFO - 'config_files': ('talos/mac_config.py',), 02:50:06 INFO - 'default_actions': ('clobber', 02:50:06 INFO - 'read-buildbot-config', 02:50:06 INFO - 'download-and-extract', 02:50:06 INFO - 'populate-webroot', 02:50:06 INFO - 'create-virtualenv', 02:50:06 INFO - 'install', 02:50:06 INFO - 'run-tests'), 02:50:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:50:06 INFO - 'download_minidump_stackwalk': True, 02:50:06 INFO - 'download_symbols': 'ondemand', 02:50:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:50:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:50:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:50:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:50:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:50:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:50:06 INFO - 'installer_path': 'installer.exe', 02:50:06 INFO - 'log_level': 'info', 02:50:06 INFO - 'log_name': 'talos', 02:50:06 INFO - 'log_to_console': True, 02:50:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:50:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:50:06 INFO - 'opt_config_files': (), 02:50:06 INFO - 'pip_index': False, 02:50:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:06 INFO - 'cmd': ('bash', 02:50:06 INFO - '-c', 02:50:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:06 INFO - 'enabled': True, 02:50:06 INFO - 'halt_on_failure': False, 02:50:06 INFO - 'name': 'check_screen_resolution'},), 02:50:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:50:06 INFO - 'cmd': ('bash', 02:50:06 INFO - '-c', 02:50:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:50:06 INFO - 'enabled': True, 02:50:06 INFO - 'halt_on_failure': False, 02:50:06 INFO - 'name': 'check_screen_resolution'},), 02:50:06 INFO - 'run_cmd_checks_enabled': True, 02:50:06 INFO - 'sps_profile': False, 02:50:06 INFO - 'sps_profile_interval': 0, 02:50:06 INFO - 'suite': 'dromaeojs', 02:50:06 INFO - 'system_bits': '32', 02:50:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:50:06 INFO - 'title': 't-yosemite-r7-0083', 02:50:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:50:06 INFO - 'use_talos_json': True, 02:50:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:50:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:50:06 INFO - 'work_dir': 'build'} 02:50:06 INFO - ##### 02:50:06 INFO - ##### Running clobber step. 02:50:06 INFO - ##### 02:50:06 INFO - Running pre-action listener: _resource_record_pre_action 02:50:06 INFO - Running main action method: clobber 02:50:06 INFO - rmtree: /builds/slave/test/build 02:50:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:50:07 INFO - Running post-action listener: _resource_record_post_action 02:50:07 INFO - ##### 02:50:07 INFO - ##### Running read-buildbot-config step. 02:50:07 INFO - ##### 02:50:07 INFO - Running pre-action listener: _resource_record_pre_action 02:50:07 INFO - Running main action method: read_buildbot_config 02:50:07 INFO - Using buildbot properties: 02:50:07 INFO - { 02:50:07 INFO - "project": "", 02:50:07 INFO - "product": "firefox", 02:50:07 INFO - "script_repo_revision": "production", 02:50:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:50:07 INFO - "repository": "", 02:50:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:50:07 INFO - "buildid": "20160405005012", 02:50:07 INFO - "pgo_build": "False", 02:50:07 INFO - "basedir": "/builds/slave/test", 02:50:07 INFO - "buildnumber": 202, 02:50:07 INFO - "slavename": "t-yosemite-r7-0083", 02:50:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:50:07 INFO - "platform": "yosemite_r7", 02:50:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:50:07 INFO - "branch": "mozilla-central", 02:50:07 INFO - "repo_path": "mozilla-central", 02:50:07 INFO - "revision": "3930bfe289c83593b4781f4a631444a5f1ca4afe", 02:50:07 INFO - "stage_platform": "macosx64", 02:50:07 INFO - "builduid": "a8465b99cad74da68e5f43e279fb4cba", 02:50:07 INFO - "slavebuilddir": "test" 02:50:07 INFO - } 02:50:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 02:50:07 INFO - Running post-action listener: _resource_record_post_action 02:50:07 INFO - ##### 02:50:07 INFO - ##### Running download-and-extract step. 02:50:07 INFO - ##### 02:50:07 INFO - Running pre-action listener: _resource_record_pre_action 02:50:07 INFO - Running main action method: download_and_extract 02:50:07 INFO - mkdir: /builds/slave/test/build/tests 02:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:07 INFO - https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:50:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:50:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:50:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:08 INFO - Downloaded 1199 bytes. 02:50:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:50:08 INFO - Using the following test package requirements: 02:50:08 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:50:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 02:50:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 02:50:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'jsshell-mac.zip'], 02:50:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 02:50:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:50:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 02:50:08 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 02:50:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 02:50:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:50:08 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 02:50:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02: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')]} 02:50:08 INFO - https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:09 INFO - Downloaded 17959956 bytes. 02:50:09 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'] 02:50:09 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 02:50:13 INFO - Return code: 0 02:50:13 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 02:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:13 INFO - https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:50:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:50:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:50:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:14 INFO - Downloaded 17959956 bytes. 02:50:14 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'] 02:50:14 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 02:50:17 INFO - Return code: 0 02:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:17 INFO - https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:18 INFO - Downloaded 10847584 bytes. 02:50:18 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'] 02:50:18 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 02:50:18 INFO - Return code: 0 02:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:18 INFO - https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 02:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/caOn9CHKQbaleqK8Ga9iFw/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 02:50:21 INFO - Downloaded 111355564 bytes. 02:50:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:50:21 INFO - mkdir: /builds/slave/test/properties 02:50:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:50:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:50:21 INFO - Contents: 02:50:21 INFO - build_url:https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:50:22 INFO - Running post-action listener: _resource_record_post_action 02:50:22 INFO - Running post-action listener: set_extra_try_arguments 02:50:22 INFO - ##### 02:50:22 INFO - ##### Running populate-webroot step. 02:50:22 INFO - ##### 02:50:22 INFO - Running pre-action listener: _resource_record_pre_action 02:50:22 INFO - Running main action method: populate_webroot 02:50:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:50:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:50:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:50:22 INFO - '--tppagecycles', 02:50:22 INFO - '7'], 02:50:22 INFO - 'tests': ['tsvgm']}}, 02:50:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:50:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:50:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:50:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:50:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:50:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'tests': ['damp', 'tps']}, 02:50:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['damp', 'tps']}, 02:50:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:50:22 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['dromaeo_dom']}, 02:50:22 INFO - 'other': {'tests': ['a11yr', 02:50:22 INFO - 'ts_paint', 02:50:22 INFO - 'tpaint', 02:50:22 INFO - 'sessionrestore', 02:50:22 INFO - 'sessionrestore_no_auto_restore', 02:50:22 INFO - 'tabpaint']}, 02:50:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['a11yr', 02:50:22 INFO - 'ts_paint', 02:50:22 INFO - 'tpaint', 02:50:22 INFO - 'sessionrestore', 02:50:22 INFO - 'sessionrestore_no_auto_restore', 02:50:22 INFO - 'tabpaint']}, 02:50:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['a11yr', 02:50:22 INFO - 'ts_paint', 02:50:22 INFO - 'tpaint', 02:50:22 INFO - 'sessionrestore', 02:50:22 INFO - 'sessionrestore_no_auto_restore', 02:50:22 INFO - 'tabpaint']}, 02:50:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['a11yr', 02:50:22 INFO - 'ts_paint', 02:50:22 INFO - 'tpaint', 02:50:22 INFO - 'sessionrestore', 02:50:22 INFO - 'sessionrestore_no_auto_restore', 02:50:22 INFO - 'tabpaint']}, 02:50:22 INFO - 'other_l64': {'tests': ['a11yr', 02:50:22 INFO - 'ts_paint', 02:50:22 INFO - 'tpaint', 02:50:22 INFO - 'sessionrestore', 02:50:22 INFO - 'sessionrestore_no_auto_restore', 02:50:22 INFO - 'tabpaint']}, 02:50:22 INFO - 'other_nol64': {'tests': ['a11yr', 02:50:22 INFO - 'ts_paint', 02:50:22 INFO - 'tpaint', 02:50:22 INFO - 'sessionrestore', 02:50:22 INFO - 'sessionrestore_no_auto_restore', 02:50:22 INFO - 'tabpaint']}, 02:50:22 INFO - 'svgr': {'tests': ['tsvgx', 02:50:22 INFO - 'tsvgr_opacity', 02:50:22 INFO - 'tart', 02:50:22 INFO - 'tscrollx', 02:50:22 INFO - 'cart']}, 02:50:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['tsvgx', 02:50:22 INFO - 'tsvgr_opacity', 02:50:22 INFO - 'tart', 02:50:22 INFO - 'tscrollx', 02:50:22 INFO - 'cart']}, 02:50:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'tests': ['tp5o']}, 02:50:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'talos_options': ['--e10s'], 02:50:22 INFO - 'tests': ['tp5o']}, 02:50:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'talos_options': ['--xperf_path', 02:50:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:22 INFO - 'tests': ['tp5n']}, 02:50:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:50:22 INFO - 'talos_options': ['--e10s', 02:50:22 INFO - '--xperf_path', 02:50:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:50:22 INFO - 'tests': ['tp5n']}}, 02:50:22 INFO - 'talos.zip': {'path': '', 02:50:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:50:22 INFO - Running post-action listener: _resource_record_post_action 02:50:22 INFO - ##### 02:50:22 INFO - ##### Running create-virtualenv step. 02:50:22 INFO - ##### 02:50:22 INFO - Running pre-action listener: _resource_record_pre_action 02:50:22 INFO - Running main action method: create_virtualenv 02:50:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:50:22 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 02:50:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:50:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:50:23 INFO - Using real prefix '/tools/python27' 02:50:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:50:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:50:26 INFO - Installing pip.................done. 02:50:26 INFO - Return code: 0 02:50:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02: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')]} 02:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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')]} 02:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02: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', 'pip>=1.5'] in /builds/slave/test/build 02: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 pip>=1.5 02:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:26 INFO - 'HOME': '/Users/cltbld', 02:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:26 INFO - 'LOGNAME': 'cltbld', 02:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:26 INFO - 'MOZ_NO_REMOTE': '1', 02:50:26 INFO - 'NO_EM_RESTART': '1', 02:50:26 INFO - 'PAGER': '/bin/cat', 02:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:26 INFO - 'PWD': '/builds/slave/test', 02:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:26 INFO - 'SHELL': '/bin/bash', 02:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:26 INFO - 'USER': 'cltbld', 02:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:26 INFO - 'XPC_FLAGS': '0x0', 02:50:26 INFO - 'XPC_SERVICE_NAME': '0', 02:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:26 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 02:50:26 INFO - Cleaning up... 02:50:26 INFO - Return code: 0 02:50:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02: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')]} 02:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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')]} 02:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02: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', '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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02: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', 'psutil>=0.7.1'] in /builds/slave/test/build 02: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 psutil>=0.7.1 02:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:26 INFO - 'HOME': '/Users/cltbld', 02:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:26 INFO - 'LOGNAME': 'cltbld', 02:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:26 INFO - 'MOZ_NO_REMOTE': '1', 02:50:26 INFO - 'NO_EM_RESTART': '1', 02:50:26 INFO - 'PAGER': '/bin/cat', 02:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:26 INFO - 'PWD': '/builds/slave/test', 02:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:26 INFO - 'SHELL': '/bin/bash', 02:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:26 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:26 INFO - 'USER': 'cltbld', 02:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:26 INFO - 'XPC_FLAGS': '0x0', 02:50:26 INFO - 'XPC_SERVICE_NAME': '0', 02:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:27 INFO - Downloading/unpacking psutil>=0.7.1 02:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:50:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:29 INFO - Installing collected packages: psutil 02:50:29 INFO - Running setup.py install for psutil 02:50:29 INFO - building 'psutil._psutil_osx' extension 02:50:29 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 02:50:30 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 02:50:30 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 02:50:30 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 02:50:30 INFO - building 'psutil._psutil_posix' extension 02:50:30 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 02:50:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:50:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:50:30 INFO - ^ 02:50:30 INFO - 1 warning generated. 02:50:30 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 02:50:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:30 INFO - Successfully installed psutil 02:50:30 INFO - Cleaning up... 02:50:30 INFO - Return code: 0 02:50:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:50:30 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')]} 02:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:31 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')]} 02:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:31 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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:31 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 02:50:31 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 02:50:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:31 INFO - 'HOME': '/Users/cltbld', 02:50:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:31 INFO - 'LOGNAME': 'cltbld', 02:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:31 INFO - 'MOZ_NO_REMOTE': '1', 02:50:31 INFO - 'NO_EM_RESTART': '1', 02:50:31 INFO - 'PAGER': '/bin/cat', 02:50:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:31 INFO - 'PWD': '/builds/slave/test', 02:50:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:31 INFO - 'SHELL': '/bin/bash', 02:50:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:31 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:31 INFO - 'USER': 'cltbld', 02:50:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:31 INFO - 'XPC_FLAGS': '0x0', 02:50:31 INFO - 'XPC_SERVICE_NAME': '0', 02:50:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:50:33 INFO - Installing collected packages: mozsystemmonitor 02:50:33 INFO - Running setup.py install for mozsystemmonitor 02:50:33 INFO - Successfully installed mozsystemmonitor 02:50:33 INFO - Cleaning up... 02:50:33 INFO - Return code: 0 02:50:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:33 INFO - 'HOME': '/Users/cltbld', 02:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:33 INFO - 'LOGNAME': 'cltbld', 02:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:33 INFO - 'MOZ_NO_REMOTE': '1', 02:50:33 INFO - 'NO_EM_RESTART': '1', 02:50:33 INFO - 'PAGER': '/bin/cat', 02:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:33 INFO - 'PWD': '/builds/slave/test', 02:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:33 INFO - 'SHELL': '/bin/bash', 02:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:33 INFO - 'USER': 'cltbld', 02:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:33 INFO - 'XPC_FLAGS': '0x0', 02:50:33 INFO - 'XPC_SERVICE_NAME': '0', 02:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:50:34 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 02:50:34 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 02:50:34 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 02:50:34 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 02:50:34 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 02:50:34 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 02:50:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:50:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:50:36 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 02:50:36 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 02:50:36 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 02:50:36 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 02:50:36 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 02:50:36 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 02:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:50:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:37 INFO - Downloading docopt-0.6.1.tar.gz 02:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:50:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:50:37 INFO - Running setup.py install for blobuploader 02:50:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:50:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:50:37 INFO - Running setup.py install for requests 02:50:38 INFO - Running setup.py install for docopt 02:50:38 INFO - Successfully installed blobuploader requests docopt 02:50:38 INFO - Cleaning up... 02:50:38 INFO - Return code: 0 02:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:38 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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:38 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 02:50:38 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 02:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:38 INFO - 'HOME': '/Users/cltbld', 02:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:38 INFO - 'LOGNAME': 'cltbld', 02:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:38 INFO - 'MOZ_NO_REMOTE': '1', 02:50:38 INFO - 'NO_EM_RESTART': '1', 02:50:38 INFO - 'PAGER': '/bin/cat', 02:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:38 INFO - 'PWD': '/builds/slave/test', 02:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:38 INFO - 'SHELL': '/bin/bash', 02:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:38 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:38 INFO - 'USER': 'cltbld', 02:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:38 INFO - 'XPC_FLAGS': '0x0', 02:50:38 INFO - 'XPC_SERVICE_NAME': '0', 02:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:38 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-0n3IxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-r8DZg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-6zdV1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Vtas4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-aTImp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-K2Ks05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AFNERi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EETAq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-2AJhAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Yo7RRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:39 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-DFbK95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AyemUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-yElOs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Iz4j3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-MK7VPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-WFo6kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:40 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-iN3EFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:50:40 INFO - Running setup.py install for manifestparser 02:50:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:50:40 INFO - Running setup.py install for mozcrash 02:50:41 INFO - Running setup.py install for mozdebug 02:50:41 INFO - Running setup.py install for mozdevice 02:50:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Running setup.py install for mozfile 02:50:41 INFO - Running setup.py install for mozhttpd 02:50:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Running setup.py install for mozinfo 02:50:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Running setup.py install for mozInstall 02:50:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:50:41 INFO - Running setup.py install for mozleak 02:50:42 INFO - Running setup.py install for mozlog 02:50:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:50:42 INFO - Running setup.py install for moznetwork 02:50:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:50:42 INFO - Running setup.py install for mozprocess 02:50:42 INFO - Running setup.py install for mozprofile 02:50:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:50:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:50:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:50:42 INFO - Running setup.py install for mozrunner 02:50:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:50:42 INFO - Running setup.py install for mozscreenshot 02:50:42 INFO - Running setup.py install for moztest 02:50:43 INFO - Running setup.py install for mozversion 02:50:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:50:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:50:43 INFO - Cleaning up... 02:50:43 INFO - Return code: 0 02:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50: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')]} 02:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:43 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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:43 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 02:50:43 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 02:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:43 INFO - 'HOME': '/Users/cltbld', 02:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:43 INFO - 'LOGNAME': 'cltbld', 02:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:43 INFO - 'MOZ_NO_REMOTE': '1', 02:50:43 INFO - 'NO_EM_RESTART': '1', 02:50:43 INFO - 'PAGER': '/bin/cat', 02:50:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:43 INFO - 'PWD': '/builds/slave/test', 02:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:43 INFO - 'SHELL': '/bin/bash', 02:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:43 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:43 INFO - 'USER': 'cltbld', 02:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:43 INFO - 'XPC_FLAGS': '0x0', 02:50:43 INFO - 'XPC_SERVICE_NAME': '0', 02:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-UqJAD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:43 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)) 02:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-c7IQ3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:43 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)) 02:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-eOV6Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:43 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)) 02:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-K6NJf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:43 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)) 02:50:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:43 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Bfbmdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-NqHxuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AlySl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-v2wJHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-IbvEJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-dgoTHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-voY1AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ciIFlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ES7pD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:44 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)) 02:50:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:44 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oCCLTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:45 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)) 02:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:45 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-FEJVDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:45 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)) 02:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:45 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QA8WHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:45 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)) 02:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:45 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-oiszqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:45 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)) 02:50:45 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)) 02:50:45 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)) 02:50:45 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)) 02:50:45 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)) 02:50:45 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)) 02:50:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:47 INFO - Downloading blessings-1.6.tar.gz 02:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:50:47 INFO - Installing collected packages: blessings 02:50:47 INFO - Running setup.py install for blessings 02:50:48 INFO - Successfully installed blessings 02:50:48 INFO - Cleaning up... 02:50:48 INFO - Return code: 0 02:50:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:48 INFO - Reading from file tmpfile_stdout 02:50:48 INFO - Current package versions: 02:50:48 INFO - blessings == 1.6 02:50:48 INFO - blobuploader == 1.2.4 02:50:48 INFO - docopt == 0.6.1 02:50:48 INFO - manifestparser == 1.1 02:50:48 INFO - mozInstall == 1.12 02:50:48 INFO - mozcrash == 0.17 02:50:48 INFO - mozdebug == 0.1 02:50:48 INFO - mozdevice == 0.48 02:50:48 INFO - mozfile == 1.2 02:50:48 INFO - mozhttpd == 0.7 02:50:48 INFO - mozinfo == 0.9 02:50:48 INFO - mozleak == 0.1 02:50:48 INFO - mozlog == 3.1 02:50:48 INFO - moznetwork == 0.27 02:50:48 INFO - mozprocess == 0.22 02:50:48 INFO - mozprofile == 0.28 02:50:48 INFO - mozrunner == 6.11 02:50:48 INFO - mozscreenshot == 0.1 02:50:48 INFO - mozsystemmonitor == 0.0 02:50:48 INFO - moztest == 0.7 02:50:48 INFO - mozversion == 1.4 02:50:48 INFO - psutil == 3.1.1 02:50:48 INFO - requests == 1.2.3 02:50:48 INFO - wsgiref == 0.1.2 02:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50:48 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')]} 02:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:48 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')]} 02:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:48 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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:48 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 02:50:48 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 02:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:48 INFO - 'HOME': '/Users/cltbld', 02:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:48 INFO - 'LOGNAME': 'cltbld', 02:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:48 INFO - 'MOZ_NO_REMOTE': '1', 02:50:48 INFO - 'NO_EM_RESTART': '1', 02:50:48 INFO - 'PAGER': '/bin/cat', 02:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:48 INFO - 'PWD': '/builds/slave/test', 02:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:48 INFO - 'SHELL': '/bin/bash', 02:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:48 INFO - 'USER': 'cltbld', 02:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:48 INFO - 'XPC_FLAGS': '0x0', 02:50:48 INFO - 'XPC_SERVICE_NAME': '0', 02:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 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)) 02:50:48 INFO - Cleaning up... 02:50:48 INFO - Return code: 0 02:50:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:50:48 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')]} 02:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:48 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')]} 02:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:48 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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:48 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 02:50:48 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 02:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:48 INFO - 'HOME': '/Users/cltbld', 02:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:48 INFO - 'LOGNAME': 'cltbld', 02:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:48 INFO - 'MOZ_NO_REMOTE': '1', 02:50:48 INFO - 'NO_EM_RESTART': '1', 02:50:48 INFO - 'PAGER': '/bin/cat', 02:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:48 INFO - 'PWD': '/builds/slave/test', 02:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:48 INFO - 'SHELL': '/bin/bash', 02:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:48 INFO - 'USER': 'cltbld', 02:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:48 INFO - 'XPC_FLAGS': '0x0', 02:50:48 INFO - 'XPC_SERVICE_NAME': '0', 02:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:48 INFO - Downloading/unpacking jsonschema 02:50:48 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 02:50:48 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 02:50:48 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 02:50:48 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 02:50:48 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 02:50:48 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 02:50:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:50:51 INFO - Downloading/unpacking functools32 (from jsonschema) 02:50:51 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 02:50:51 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 02:50:51 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 02:50:51 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 02:50:51 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 02:50:51 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 02:50:51 INFO - Downloading functools32-3.2.3-2.tar.gz 02:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:50:51 INFO - warning: no files found matching '*.txt' 02:50:51 INFO - no previously-included directories found matching 'build' 02:50:51 INFO - no previously-included directories found matching 'dist' 02:50:51 INFO - no previously-included directories found matching '.git*' 02:50:51 INFO - Installing collected packages: jsonschema, functools32 02:50:51 INFO - Running setup.py install for functools32 02:50:52 INFO - warning: no files found matching '*.txt' 02:50:52 INFO - no previously-included directories found matching 'build' 02:50:52 INFO - no previously-included directories found matching 'dist' 02:50:52 INFO - no previously-included directories found matching '.git*' 02:50:52 INFO - Successfully installed jsonschema functools32 02:50:52 INFO - Cleaning up... 02:50:52 INFO - Return code: 0 02:50:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:50:52 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 0x106804a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106814420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80cb4b2da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, '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.9d6UOIbVeO/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.SPsdxkX65S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 02:50:52 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 02:50:52 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 02:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:52 INFO - 'HOME': '/Users/cltbld', 02:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:52 INFO - 'LOGNAME': 'cltbld', 02:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:52 INFO - 'MOZ_NO_REMOTE': '1', 02:50:52 INFO - 'NO_EM_RESTART': '1', 02:50:52 INFO - 'PAGER': '/bin/cat', 02:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:52 INFO - 'PWD': '/builds/slave/test', 02:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:52 INFO - 'SHELL': '/bin/bash', 02:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:50:52 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:52 INFO - 'USER': 'cltbld', 02:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:52 INFO - 'XPC_FLAGS': '0x0', 02:50:52 INFO - 'XPC_SERVICE_NAME': '0', 02:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:52 INFO - Downloading/unpacking flake8 02:50:52 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 02:50:52 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 02:50:52 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 02:50:52 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 02:50:52 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 02:50:52 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 02:50:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:50:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:50:54 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 02:50:54 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 02:50:54 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 02:50:54 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 02:50:54 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 02:50:54 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 02:50:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:50:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 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 02:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:50:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:50:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:50:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:50:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:50:56 INFO - no previously-included directories found matching 'docs/_build' 02:50:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:50:56 INFO - Running setup.py install for pep8 02:50:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:50:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:50:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:50:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:50:56 INFO - no previously-included directories found matching 'docs/_build' 02:50:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:50:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:50:56 INFO - Cleaning up... 02:50:56 INFO - Return code: 0 02:50:56 INFO - Running post-action listener: _resource_record_post_action 02:50:56 INFO - Running post-action listener: _start_resource_monitoring 02:50:56 INFO - Starting resource monitoring. 02:50:56 INFO - ##### 02:50:56 INFO - ##### Running install step. 02:50:56 INFO - ##### 02:50:56 INFO - Running pre-action listener: _resource_record_pre_action 02:50:56 INFO - Running main action method: install 02:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:56 INFO - Reading from file tmpfile_stdout 02:50:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:50:56 INFO - Reading from file tmpfile_stdout 02:50:56 INFO - Output received: 02:50:56 INFO - Usage: mozinstall [options] installer 02:50:56 INFO - Options: 02:50:56 INFO - -h, --help show this help message and exit 02:50:56 INFO - -d DEST, --destination=DEST 02:50:56 INFO - Directory to install application into. [default: 02:50:56 INFO - "/builds/slave/test"] 02:50:56 INFO - --app=APP Application being installed. [default: firefox] 02:50:56 INFO - mkdir: /builds/slave/test/build/application 02:50:56 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'] 02:50:56 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 02:51:30 INFO - Reading from file tmpfile_stdout 02:51:30 INFO - Output received: 02:51:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:51:30 INFO - Running post-action listener: _resource_record_post_action 02:51:30 INFO - ##### 02:51:30 INFO - ##### Running run-tests step. 02:51:30 INFO - ##### 02:51:30 INFO - Running pre-action listener: _resource_record_pre_action 02:51:30 INFO - Running main action method: run_tests 02:51:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:51:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:51:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:51:30 INFO - 2016-04-05 02:51:30.782 screenresolution[1636:7502] starting screenresolution argv=screenresolution get 02:51:30 INFO - 2016-04-05 02:51:30.784 screenresolution[1636:7502] Display 0: 1600x1200x32@60 02:51:30 INFO - 2016-04-05 02:51:30.790 screenresolution[1637:7504] starting screenresolution argv=screenresolution list 02:51:30 INFO - Available Modes on Display 0 02:51:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:51:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:51:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:51:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:51:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:51:31 INFO - Intel Iris: 02:51:31 INFO - Chipset Model: Intel Iris 02:51:31 INFO - Type: GPU 02:51:31 INFO - Bus: Built-In 02:51:31 INFO - VRAM (Dynamic, Max): 1536 MB 02:51:31 INFO - Vendor: Intel (0x8086) 02:51:31 INFO - Device ID: 0x0a2e 02:51:31 INFO - Revision ID: 0x0009 02:51:31 INFO - Displays: 02:51:31 INFO - Display: 02:51:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:51:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:51:31 INFO - Display Serial Number: 1600x1200 60 02:51:31 INFO - Main Display: Yes 02:51:31 INFO - Mirror: Off 02:51:31 INFO - Online: Yes 02:51:31 INFO - Rotation: Supported 02:51:31 INFO - Return code: 0 02:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:51:31 INFO - Python 2.7.3 02:51:31 INFO - Return code: 0 02:51:31 INFO - grabbing minidump binary from tooltool 02:51:31 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')]} 02:51:31 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 0x1066a3e00>, '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 0x1064ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10669eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:51:31 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 02:51:31 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 02:51:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:51:31 INFO - Return code: 0 02:51:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:51:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:51:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:51:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:51:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:51:32 INFO - Return code: 0 02:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 02:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 02:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9d6UOIbVeO/Render', 02:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:51:32 INFO - 'HOME': '/Users/cltbld', 02:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:51:32 INFO - 'LOGNAME': 'cltbld', 02:51:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:51:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:32 INFO - 'MOZ_NO_REMOTE': '1', 02:51:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:51:32 INFO - 'NO_EM_RESTART': '1', 02:51:32 INFO - 'PAGER': '/bin/cat', 02:51:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:32 INFO - 'PWD': '/builds/slave/test', 02:51:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:51:32 INFO - 'SHELL': '/bin/bash', 02:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SPsdxkX65S/Listeners', 02:51:32 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 02:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:51:32 INFO - 'USER': 'cltbld', 02:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:32 INFO - 'XPC_FLAGS': '0x0', 02:51:32 INFO - 'XPC_SERVICE_NAME': '0', 02:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:51:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 02:51:32 INFO - mozversion application_buildid: 20160405005012 02:51:32 INFO - mozversion application_changeset: 3930bfe289c83593b4781f4a631444a5f1ca4afe 02:51:32 INFO - mozversion application_display_name: Nightly 02:51:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:51:32 INFO - mozversion application_name: Firefox 02:51:32 INFO - mozversion application_remotingname: firefox 02:51:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:51:32 INFO - mozversion application_vendor: Mozilla 02:51:32 INFO - mozversion application_version: 48.0a1 02:51:32 INFO - mozversion platform_buildid: 20160405005012 02:51:32 INFO - mozversion platform_changeset: 3930bfe289c83593b4781f4a631444a5f1ca4afe 02:51:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:51:32 INFO - mozversion platform_version: 48.0a1 02:51:32 INFO - using testdate: 1459849892 02:51:32 INFO - actual date: 1459849892 02:51:32 INFO - starting webserver on 'localhost:49269' 02:51:32 INFO - SUITE-START | Running 2 tests 02:51:32 INFO - TEST-START | dromaeo_css 02:51:32 INFO - operating with platform_type : mac_ 02:51:32 INFO - Initialising browser for dromaeo_css test... 02:51:32 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpjCfJYZ/profile http://localhost:49269/getInfo.html) 02:51:34 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 02:51:34 INFO - PROCESS | 1655 | colorDepth:24 02:51:34 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 02:51:34 INFO - PROCESS | 1655 | __metrics 02:51:34 INFO - PROCESS | 1655 | 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" 02:51:34 ERROR - PROCESS | 1655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:51:35 INFO - TEST-INFO | 1655: exit 0 02:51:35 INFO - Browser initialized. 02:51:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:51:35 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpjCfJYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:47 INFO - PROCESS | 1657 | RSS: Main: 236036096 02:51:47 INFO - PROCESS | 1657 | 02:52:38 INFO - PROCESS | 1657 | 1459849958690 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] 02:54:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 02:54:50 INFO - PROCESS | 1657 | RSS: Main: 336510976 02:54:50 INFO - PROCESS | 1657 | 02:57:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 02:57:53 INFO - PROCESS | 1657 | RSS: Main: 354828288 02:57:53 INFO - PROCESS | 1657 | 03:00:55 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 03:00:55 INFO - PROCESS | 1657 | RSS: Main: 363192320 03:00:55 INFO - PROCESS | 1657 | 03:03:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 03:03:58 INFO - PROCESS | 1657 | RSS: Main: 322375680 03:03:58 INFO - PROCESS | 1657 | 03:07:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 03:07:01 INFO - PROCESS | 1657 | RSS: Main: 323371008 03:07:01 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 03:10:04 INFO - PROCESS | 1657 | RSS: Main: 392704000 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | __start_tp_report 03:10:04 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 03:10:04 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 03:10:04 INFO - PROCESS | 1657 | |i|pagename|runs| 03:10:04 INFO - PROCESS | 1657 | |0;dojo.html;3439.449688049912;3494.930101397972;3525.8479416000387;3533.611302756696;3571.8928432147027;5633.267675202218;5689.544836413087;5736.426357364267;5742.741576629051;5752.309722833261;5693.089105743082;5774.913376299359;5787.942120578793;5791.913121303184;5858.88282234355;5198.194279886605;5255.290535777678;5258.36899572051;5259.710715910624;5265.710385928773;5175.404828444721;5296.682199068068;5300.01949639316;5389.676619402849;5403.972980135094;4403.867883963486;5287.788488460457;5303.443138470444;5338.225957236198;5393.2449457076045;4237.618614324726;5103.974480127613;5207.791688332462;5245.344331958505;5259.605529585258;5162.483751624845;5175.404828444739;5179.974100129513;5180.3265575475325;5202.4537423570355;5607.663540187602;5612.017896868073;5612.354579223401;5616.297962754656;5621.128725047624;6069.529489596456;6118.588722523122;6232.439080482733;6253.1558239637525;6271.996480563088;6230.7819226326865;6267;6283.403076707706;6285.4343109119945;6292.119103325538;5525.4474552544425;5603.80386686464;5818.418158184148;5819.73811178498;5882.147088672119;6148.9692551536955;6196.318404975449;6238.251409830849;6263.467605253604;6273.8745225095245;6084.452399283997;6116.235470566179;6147.139400483936;6147.415995480422;6154.5076393888385;6215.378462153749;6254.8123556293385;6255;6261.686915654199;6290.339514351019;6065.302490213682;6170.444659980623;6171.413715697002;6182.629042257479;6189.597676151036;6135.208480141525;6223.62658240498;6248.250209974832;6256.217972753406;6264.812055638338;4845.2732090186755;4861.222204447272;4863.1732605457155;4880.072786170687;4893.363862697826;4281.550437204111;4436.290193569078;4444.7110937789585;4482.618977386894;4493.98885250816;4793.760311984387;5610.242617246701;5621.4659607337235;5651.773929042874;5743.741531631086;6207.565470417027;6220.471259942865;6228.408301211378;6231.781887634002;6264.62412255257;5471.835844924659;5588;5673.177389278531;5678.375378708339;5710.71446427677;5333.5199832015305;5361.383440904346;5410.486003829708;5417.404085550586;5434.972825135849;6246.875062498724;6297.874042519215;6303.275123360872;6311.211098612765;6334.873302534015;6113.628337950474;6114.631938157225;6166;6183.783567575113;6211.844703882439;6214.347493513116;6221.191245138103;6230.00319948806;6255.655938923403;6261.530385221217;5126.589872810241;6123.142760013513;6125.234345706786;6128.50971922254;6135.07973803933;5152.330197074356;5180.352455943007;5296.576273898156;6097.695115244132;6189.226346706661;6064.3026052002815;6097.390260973867;6109.633421994695;6116.66358350295;6117.632942023492;6025.276966764016;6061.212042434456;6087.36082711309;6098.512119030378;6110.26676798787;4933.605311575137;5776.306843178845;5879.176915231786;5921.881562368814;5954.166416701579;6059.848503787441;6070.3929607038945;6079.179310792986;6083.574149809471;6105.358937311518;5504.788946431779;5914.497267732291;5928.229330187048;5928.436798504135;5945.910811337747 03:10:04 INFO - PROCESS | 1657 | |1;ext.html;518.9818356357529;574.7757276999987;580.7996241296751;634.7841733810503;636.8598908240187;30250;30549.236269093282;30655.38689226214;38240.617593824056;39027.41458878119;35925.461118083185;39499;42009.7899510502;42471;42515.14969700604;9052.637894484213;9604.471754053524;9605.66380176694;9611.855822162674;9612.567434465465;8105.635246413925;9445.149936505713;9620.230381569458;9623.1820295275;9642.325037247361;9594.952025239863;9649;9694.369865958726;9729.075737804897;9752.512374381287;9639;9722.465264410455;9727.027297270288;9727.90272097277;9733.707988760312;9578.281628877792;9582.568784404719;9728.221742260603;9752.658656946973;9772.462514561696;39968.400473992915;40274.79862600668;40314.59685403167;40413.59586404128;40439;3236.207129253348;3268.0686004488844;3308.4044871923043;3399.9660003399895;3802.8478860845535;28282;28936.710632893613;29269.97555085562;29501.11496655104;29679.25801854971;2749.628800111979;2755.0632784853246;2816.8732407041734;2881.236472334812;2888.9022171574666;501396.99999999633;504368;505294;506446;509157.45421272656;36828.44757328642;46190.07619847584;65844;66127.66936165384;66492;45251;45387.77306113448;45544.77227613841;45669.543304567196;45720.08559828785;15656.921715391578;15830.76253856193;15834.683306333809;15839.683206335809;15869.841301587066;12628.684282892817;12649.683757906127;12665.430055647517;12699.746005079847;12721.745565088646;14776.26118694061;14831.92584037073;14864.70270594582;14950.70098598022;15034.924825375803;6129.509639228851;6242.469390101892;6290.24517057956;6294.433500984934;6329.145565348711;917.3853518142861;923.7459698582809;942.6370847223868;985.3398223190479;1114.9275297105662;28941.276468088046;29024.129276121752;29126.854365728035;29438.705612943595;29530.55704164439;1015.7816069545083;1038.2472707287307;1076.278893141597;1112.0991996482874;1153.7404084081015;14740;14762.852371476363;14804.851951480563;15058.774118388234;15080.472183473526;484406;489736;489814;490586;491232;58351.41648583545;59018.70490647605;59020;59032.40967590355;59177;1258.704204511939;1326.5158217250635;1426.1229343953394;1462.7732701431296;1466.538040517255;25920.351991200372;27564.621768911875;28113.71886281193;28117.43765124727;28514.57228141538;35982.64017359898;43969.34045989249;44288.89277768081;44811.55188448204;44831.551684484046;290303;290417;290579;292201;292946.5352673223;28080.29799255035;28525.714742852306;32672.50991235086;33439;33580.160495987795;41143;41666.79166604148;41744;42009.369859452745;42874;34694.47958280678;34708.305833883685;34755.82622086874;35355.82322088373;35405.82297088601;34192.65807341895;34259;34538.96383108511;34606.480902785974;35005;36559.26881462409;36751.816240918626;36813.26373472462;38529;38716.6128338713;29529.704702953553;30963.380732385678;31980;32571;32615.836920815244;21325.36023919285;22887.427814304774;23911.402214944068;24154;24652.260432187064 03:10:04 INFO - PROCESS | 1657 | |2;jquery.html;358.74170597170036;361.67449295633924;364.1533434764173;369.26884768159044;372.1236488070592;19669.50826229343;20040;21300.57398852026;21471.57056858862;21481.892590537063;20347.18611255552;20790.792092079075;21082.262120825773;21123;21344;5795.391483894183;6018.518518518508;6043.516518678517;6045.6070355426755;6048.153258543807;5794.159846822229;5826.15520749491;5873.618214816044;5981.401859814027;5995.700214989255;5929.911051334234;5937.910931336012;5938.168656388109;5941.762329506836;5959.761609535613;5599.496045355917;5922.31893332268;5928.1404196391495;5934.28788545373;5955.166276721263;5100.591952643779;5101;5150.330457040561;5151.484851514856;5151.536361727425;24743.38141546476;24825;25293.873530632412;25367.873160634263;25391.746082539124;2266.5920134375806;2351.3651314145254;2394.0543485323374;2414.517096580691;2856.814307070034;12102.515899364014;14003.929980350134;14609.926950365287;14613.415463381452;15162.696746065018;1602.4952140075839;1616.658173715813;1740.1647209339462;1822.1253798176817;1885.632301701169;93032.44146323245;93554.73688907833;93966.53016734941;96245.0375496243;96788.51605741926;8973.910260897437;10455.84316235257;10683;10761.192910531741;10889.509972051277;13717.108387954751;13769.655758606115;13791.931040344734;13795.723705588465;13819.654508637364;7127.322904324081;8264.512387770259;8278.83442331162;8447.281981031558;8524.104968978292;7643.350315223268;7782.922170778333;8512.233898949124;8517.403781735218;8581.914180858237;3581.8567257309937;4357.257097161098;4389.604935555815;4415.403920470695;4442.888927776831;1733.3240036385819;1799.5411170151528;1811.447508509917;1855.7566430491604;1871.4759867236924;858.7080392666398;916.6012784438791;928.3223247029571;938.174406522256;939.3377668743519;18948.715769263472;19140.621095663304;19783.10976006083;20099.598008039757;20146;949.0556895888498;960.6061514779046;984.7538115471132;999.2655398282257;1078.471548941029;9464.668736594323;10943.398113103856;10963.287386319864;10987.39569323679;11036.337819730841;531078;564103.1794841;576433;591058;602459;117072.8292717062;119301.40349298372;121809;125101;127310;968.4237878462444;993.6621548673342;1036.9948150259352;1039.308859608352;1083.6911480227939;13743.969202309667;15081.396744130112;17898.821011789714;18188.272469101088;18210.544736381697;48788.512114878395;50332.4900252993;50969.23546146737;52786.94426111533;53037.734811325696;50089;70260;73366.53266934738;74494.62752686419;74650.25349746433;7564.886526701994;7690.961545192238;7755.534667919943;7790.493617914817;7926.960365198137;8659.393842431222;8886.73339799807;8903.332250081141;9111.681091161778;9170.95414522923;6219.595726277777;6270.435660790551;7804.180561041009;7884.763457096296;8150.83698326042;7534.065187302107;7985.840283194188;8209.876851847108;8251.216134467217;8297.792555186168;8003.279704826594;8118.188181181835;8280.213379728915;8324.25081742646;8382.83234335322;11280.210385272952;11547.307161570332;11608.30350178992;11753.647390578297;11768.411579420823;11609.839016098322;11630.825537616773;11640.876130672117;11649.41752912334;11826.58606948787 03:10:04 INFO - PROCESS | 1657 | |3;mootools.html;1436.1670231265866;1596.7844341013963;1827.2051657528975;1952.1995981647528;1995.8203761661448;8609.053004169544;8650.91349086509;8790.428622139565;8793.34049946255;8809.779755506115;7716.305532502074;7904.762857114281;8371.790705232372;8551.957240213791;8636.870446943301;2414.7343792182846;2448.8285819992607;2449.889754961031;2451.1053465485147;2466.272449627364;2147.5919575280723;2394.916177933773;2435.196385192891;2456.754324567538;2462.249014050714;2182.1707751054655;2223.9332820015425;2233.972372708556;2351.130081869702;2434.111549284516;2423.624338227569;2427.4416884116577;2428.307932239303;2432.2824766693866;2437.4150203950926;2376.65538496917;2410.4455975125643;2433.513297340539;2433.9391515212083;2434.6226334918115;8514.914850851535;8569.400141990063;8585.742427727117;8590.355723320776;8594.011688655759;5278.287431196778;5381.730913454312;5389.380221274525;5426.348838139448;5430.104032834578;3031.287647402881;3166.4617015107488;3496.0910163357457;3509.2455122148863;3621.9858439636946;1037.6420135053395;1037.709441356414;1049.6588608702202;1090.983635245472;1098.3025778630627;11666.416679166008;11705.414729263503;11710.063194944383;11725.765484690344;11745.177837551375;3891.5330160380367;4513.954860451419;4827.106985207678;4855.101806165871;4866.878328041827;9938.403695778277;9957.651482198089;9963.750906227402;9971.451570163566;9985.400875947467;5446.101393270145;5456.91814622781;5457.935702537967;5463.31708536433;5478.726063696799;4919.680220785637;4971.751412429437;4979.90040199194;4986.426560945465;4989.476105008922;3358.7984720916825;3825.158465137665;3846;3878.506774891687;3903.224033064949;1296.3453456004656;1310.0567591334225;1312.9934350328379;1319.5645437005765;1326.820879181298;1010.8231059564547;1037.7613148975777;1148.494662348564;1255.5793809074062;1332.3737843213673;7814.21857814214;7884.448088633855;7908.248716372051;7925.28672419485;7934.166912474107;1180.4982882274999;1191.3209470601846;1193.361551569906;1223.8959688426405;1230.2126638951079;6095.359987201368;6177.8455538611;6195.039768835838;6199.504039676815;6205.2553693557065;9866.753331166634;10422.530986105643;10465.058144767008;10537.262391632665;10604.098651614544;8313.625886835107;8833.911660883437;10219.233557483218;10435.634752783768;10437.2693911427;8087.716929907425;8198.975128108987;8242.546659933641;8252.895511644492;8262.793430164294;7573.545587264782;7685.846283074419;7704;7737.535747854921;7763.5730034846365;9203.86194207074;9310.95344523273;9426.858597121185;9547.904520954702;9579.23366130694;9538.380005299634;9732.805343893224;9851.507424628597;9868.654597089067;9902.504874756378;7239.457040722073;7266.982622432969;7300.45246606496;7310.890336645061;7316.670749816165;7838.686452541834;8039.598020099089;8103.31121854649;8115.959420202861;8128.227818357246;7298.927010729824;7309.159446663702;7353.227911069261;7369.410447164321;7460.962695186489;7197.208307086112;7223.133224013152;7293.635318234174;7313.341799238094;7417.92582074194;7555.848883022419;7575;7582.431317651088;7689.077310722749;7693.4614576979075;6861.622610756456;6913.1358580177475;6948.583085014915;6953.23514413404;6961.89557156633;6598.8350291243105;6981.581105133709;7007.614581198083;7047.647617618996;7088.574685518885 03:10:04 INFO - PROCESS | 1657 | |4;prototype.html;326.4417845484222;330.18444442227707;334.87609584453753;337.039437602832;341.44856057467183;6549.377809108133;6565.507586930981;6583.210014798219;6588.407043366096;6595.1096601958725;6512.869742605157;6531.771388001421;6532.150820393343;6548.246951600568;6565.113709649196;4637.8840528986875;4720.150372932871;4773.0931123086675;4843.128236917353;4925.950740492594;3865.690744740414;4842.588379987706;4843.104025755247;4851.417829860422;4853.272009198613;3871.5741268460447;4737.73942433166;4784.712917224961;4788.233882578788;4821.349117869077;4621.191291523986;4674.368960190382;4758.286257061434;4796.664233503656;4797.928031079537;4095.4471146395153;4105.4662893823615;4108.116754897711;4117;4129.855455059089;4977.253411988195;6095.512359011313;6178.443940045418;6215.533834962396;6223.751049957997;4595.862124136248;5696.6866822324755;5698.715064246771;5699.572532060112;5709.486146246858;6882.655867206619;6889.207741109786;6891.552049116792;6899;6902.723891044352;3659.2864391443677;4337.284348082562;4494.1910456117885;4500.819967201308;4549.977250113761;7078.115235595551;7255.891161632527;7260.128784545888;7261.963690181568;7269.781906542812;4140.923359926441;4304.870853874389;4598.517155698671;4600.5169457207185;4602.217623004098;4659.928216510154;4668.253079507263;4668.786115609898;4671.789769460383;4680.789364478606;5511.724413779295;5535.169724541351;5541;5553.389127196006;5565.109582466866;6691.464682825363;6905.102336696298;6940.167179938439;6961.40828029613;6965.895511567331;1597.5207437768856;1611.3393508661393;1624.7887774589228;1626.2763070433543;1633.1426001349148;832.8459235041537;972.1105188752354;1026.384169498295;1029.4389557690927;1053.3679792124665;6265.8746825063245;6267.5299352548745;6349.6507692077375;6510.283868774431;6543.476521878333;7260.782176534713;7267.909813528013;7270.854582908312;7281.2718728126765;7297.379722723522;6488.448481879093;6492;6496.512761542903;6504.121943537656;6518.5762925410645;3795.35478968576;3819.713521485844;3841.116543195025;3845.384738441892;3850.403187505941;6230.59501132425;7242;7480.513766605153;7612.80967975805;7620.771376858703;7488.887666685004;7528.397728181732;7533.4349923755935;7534.472586918863;7546.547207167588;7584.2036586158765;7586.24137586248;7594.8101297468;7598.582077985653;7604.163542010375;6977.9994602321485;7258.673359698721;7310.268973102648;7318.109346807874;7325.194228634739;7137.393321567725;7143.892841607484;7162.2121566628675;7169.3906017986965;7181.425485961215;7563.432742544222;7570.810729731801;7573.810654733676;7573.962130189314;7579.583122928292;4566.337881007302;4614.192516309699;4617.191991401424;4632.2819962905805;4634.582887540138;6989.440844732511;7240.05879235696;7250.347468727839;7251.456140789356;7272.127344718668;6979.825504362431;7006.2643422439905;7010.824729381806;7011.719531218694;7013.509054366145;5889.882202356014;6814.727410903707;6921.89617155733;7009.843375842929;7013.088298521159;6822.454203663794;6829.214640316229;6832.897506537306;6835.726570937107;6839.076724642109;6685.6322902240845;6987.847005244281;6991.161060672548;7005.194402643558;7019.403350715246;6527.314631963765;6686.832829179115;6780.220274668476;6852.486063545353;6873.931260687529 03:10:04 INFO - PROCESS | 1657 | |5;yui.html;590.4168520990951;667.076099602051;724.4349407462181;760.8288135169586;771.8456308738254;11649.883501164986;12434.626961191167;15155.696886062273;15159.848401515981;15209.619759506018;13370.398332075056;13610.251436171007;13612.387442565083;13614.183149011067;13695.520656777015;902.981940361194;922.4880191493718;923.6213152607432;925.1349987761431;927.4898805656895;729.4711334282629;899.4153800029967;905.2803021597846;907.2107266677999;909.0863681999581;916.2212119698237;942.0297093993198;954.2604481526803;955.784948386611;961.2166084640995;942.1661829281102;954.9092836180552;959.8656188133667;960.9759756006085;964.1997142371814;707.7098389660215;709.6983781892726;711.4415184080472;712.9144502659663;714.6176795414481;13331.733365332639;13667.794983075262;13695.178289302574;13730.51943181984;13736.93131534336;11191.048760855338;11339.092872570174;11396.145289103268;11473.756885495834;11498.482568284364;9318.394304370262;9467.90532094684;9481.241500679998;9741.366811157252;10185.643502477451;3393.7624366294367;3400.914977125567;3436.570428696413;3466.41071017925;3505;74347;74399.62800186018;75017.1245718856;77556.06109847242;77732.61133694295;7688.846223075507;9273.165415112537;9336.90663093374;9595.568199431042;9630.711078667651;20348.18607255693;20375.694364584542;20379.796202038087;20396.694049589267;20402.59194816125;6834.282400347991;6929;6982.162140543066;7005.859882802417;7094.893576596355;4043.534993475729;4109.473850826271;4111.814968326433;4124.1133156371525;4249.915001699948;3568.589612194579;3601.6218297078954;3612.710983121344;3613.6567026132475;3615.385384484644;639.7472998165791;642.5927219389522;651.947844172465;653.7646447278976;659.5185514574388;511.9948800512022;572.6342672725497;610.4627927423838;612.592625903769;614.1770028162284;6920.377166054978;8033.517988920684;8181.754547363588;8200.097989221182;8315.168483151636;588.4321629627431;598.8531115949284;615.1080932647678;620.7175735040546;628.3936001758234;3676.3015027144756;3696.2053158571034;3764.247150569897;3820.6370394812448;3927;75452.86820697694;79421;79619.8057029145;85496.71754923681;88563;59086.704566476896;72755.63622181855;73847.52304953871;74482.62758686172;74723;63043.36956630375;68530;68601.97097043449;69291.61416771637;70273.64863175651;8396.286315663237;8403.621837017472;8509.872351914602;8524.829503410021;8622.051574326944;47970.76014619905;50381.74809125931;50898.727531812;51134.74432627813;51804.48195517997;64166;65946.67026664836;68913;70577.94133087905;70867.29132708607;11111;11274.605388811353;11439.485223164811;11534.480948357177;11800.763984720086;10027;11795.587154449897;11944.761104777683;12080.75838483243;12770;10653.307535010199;11039.779204415707;11121.27711698737;12279.570215042431;12308.323042232405;11319.886801131883;11335.886641133484;11437.370944598128;11631.941840290745;11656.242344247597;10891.40908164332;11034.613788517363;11284.548618055185;11308.773824523629;11332.490037948148;9275.72172834816;9377.437353758523;9410.95294523523;9710.70867873965;10065.748356291151;6887.380135787803;8978.506182160045;9226.677066302917;9296.256299496159;9298.349115561845 03:10:04 INFO - PROCESS | 1657 | __end_tp_report 03:10:04 INFO - PROCESS | 1657 | __start_cc_report 03:10:04 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1005 03:10:04 INFO - PROCESS | 1657 | __end_cc_report 03:10:04 INFO - PROCESS | 1657 | __startTimestamp1459851004421__endTimestamp 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | ------- Summary: start ------- 03:10:04 INFO - PROCESS | 1657 | Number of tests: 6 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5688.61 Median:5882.15 stddev:633.82 (10.8%) stddev-sans-first:610.71 03:10:04 INFO - PROCESS | 1657 | Values: 3439.4 3494.9 3525.8 3533.6 3571.9 5633.3 5689.5 5736.4 5742.7 5752.3 5693.1 5774.9 5787.9 5791.9 5858.9 5198.2 5255.3 5258.4 5259.7 5265.7 5175.4 5296.7 5300.0 5389.7 5404.0 4403.9 5287.8 5303.4 5338.2 5393.2 4237.6 5104.0 5207.8 5245.3 5259.6 5162.5 5175.4 5180.0 5180.3 5202.5 5607.7 5612.0 5612.4 5616.3 5621.1 6069.5 6118.6 6232.4 6253.2 6272.0 6230.8 6267.0 6283.4 6285.4 6292.1 5525.4 5603.8 5818.4 5819.7 5882.1 6149.0 6196.3 6238.3 6263.5 6273.9 6084.5 6116.2 6147.1 6147.4 6154.5 6215.4 6254.8 6255.0 6261.7 6290.3 6065.3 6170.4 6171.4 6182.6 6189.6 6135.2 6223.6 6248.3 6256.2 6264.8 4845.3 4861.2 4863.2 4880.1 4893.4 4281.6 4436.3 4444.7 4482.6 4494.0 4793.8 5610.2 5621.5 5651.8 5743.7 6207.6 6220.5 6228.4 6231.8 6264.6 5471.8 5588.0 5673.2 5678.4 5710.7 5333.5 5361.4 5410.5 5417.4 5435.0 6246.9 6297.9 6303.3 6311.2 6334.9 6113.6 6114.6 6166.0 6183.8 6211.8 6214.3 6221.2 6230.0 6255.7 6261.5 5126.6 6123.1 6125.2 6128.5 6135.1 5152.3 5180.4 5296.6 6097.7 6189.2 6064.3 6097.4 6109.6 6116.7 6117.6 6025.3 6061.2 6087.4 6098.5 6110.3 4933.6 5776.3 5879.2 5921.9 5954.2 6059.8 6070.4 6079.2 6083.6 6105.4 5504.8 5914.5 5928.2 5928.4 5945.9 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:56874.03 Median:36655.54 stddev:117007.18 (319.2%) stddev-sans-first:117258.91 03:10:04 INFO - PROCESS | 1657 | Values: 519.0 574.8 580.8 634.8 636.9 30250.0 30549.2 30655.4 38240.6 39027.4 35925.5 39499.0 42009.8 42471.0 42515.1 9052.6 9604.5 9605.7 9611.9 9612.6 8105.6 9445.1 9620.2 9623.2 9642.3 9595.0 9649.0 9694.4 9729.1 9752.5 9639.0 9722.5 9727.0 9727.9 9733.7 9578.3 9582.6 9728.2 9752.7 9772.5 39968.4 40274.8 40314.6 40413.6 40439.0 3236.2 3268.1 3308.4 3400.0 3802.8 28282.0 28936.7 29270.0 29501.1 29679.3 2749.6 2755.1 2816.9 2881.2 2888.9 501397.0 504368.0 505294.0 506446.0 509157.5 36828.4 46190.1 65844.0 66127.7 66492.0 45251.0 45387.8 45544.8 45669.5 45720.1 15656.9 15830.8 15834.7 15839.7 15869.8 12628.7 12649.7 12665.4 12699.7 12721.7 14776.3 14831.9 14864.7 14950.7 15034.9 6129.5 6242.5 6290.2 6294.4 6329.1 917.4 923.7 942.6 985.3 1114.9 28941.3 29024.1 29126.9 29438.7 29530.6 1015.8 1038.2 1076.3 1112.1 1153.7 14740.0 14762.9 14804.9 15058.8 15080.5 484406.0 489736.0 489814.0 490586.0 491232.0 58351.4 59018.7 59020.0 59032.4 59177.0 1258.7 1326.5 1426.1 1462.8 1466.5 25920.4 27564.6 28113.7 28117.4 28514.6 35982.6 43969.3 44288.9 44811.6 44831.6 290303.0 290417.0 290579.0 292201.0 292946.5 28080.3 28525.7 32672.5 33439.0 33580.2 41143.0 41666.8 41744.0 42009.4 42874.0 34694.5 34708.3 34755.8 35355.8 35405.8 34192.7 34259.0 34539.0 34606.5 35005.0 36559.3 36751.8 36813.3 38529.0 38716.6 29529.7 30963.4 31980.0 32571.0 32615.8 21325.4 22887.4 23911.4 24154.0 24652.3 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:32884.19 Median:28034.91 stddev:95288.68 (339.9%) stddev-sans-first:95524.69 03:10:04 INFO - PROCESS | 1657 | Values: 358.7 361.7 364.2 369.3 372.1 19669.5 20040.0 21300.6 21471.6 21481.9 20347.2 20790.8 21082.3 21123.0 21344.0 5795.4 6018.5 6043.5 6045.6 6048.2 5794.2 5826.2 5873.6 5981.4 5995.7 5929.9 5937.9 5938.2 5941.8 5959.8 5599.5 5922.3 5928.1 5934.3 5955.2 5100.6 5101.0 5150.3 5151.5 5151.5 24743.4 24825.0 25293.9 25367.9 25391.7 2266.6 2351.4 2394.1 2414.5 2856.8 12102.5 14003.9 14609.9 14613.4 15162.7 1602.5 1616.7 1740.2 1822.1 1885.6 93032.4 93554.7 93966.5 96245.0 96788.5 8973.9 10455.8 10683.0 10761.2 10889.5 13717.1 13769.7 13791.9 13795.7 13819.7 7127.3 8264.5 8278.8 8447.3 8524.1 7643.4 7782.9 8512.2 8517.4 8581.9 3581.9 4357.3 4389.6 4415.4 4442.9 1733.3 1799.5 1811.4 1855.8 1871.5 858.7 916.6 928.3 938.2 939.3 18948.7 19140.6 19783.1 20099.6 20146.0 949.1 960.6 984.8 999.3 1078.5 9464.7 10943.4 10963.3 10987.4 11036.3 531078.0 564103.2 576433.0 591058.0 602459.0 117072.8 119301.4 121809.0 125101.0 127310.0 968.4 993.7 1037.0 1039.3 1083.7 13744.0 15081.4 17898.8 18188.3 18210.5 48788.5 50332.5 50969.2 52786.9 53037.7 50089.0 70260.0 73366.5 74494.6 74650.3 7564.9 7691.0 7755.5 7790.5 7927.0 8659.4 8886.7 8903.3 9111.7 9171.0 6219.6 6270.4 7804.2 7884.8 8150.8 7534.1 7985.8 8209.9 8251.2 8297.8 8003.3 8118.2 8280.2 8324.3 8382.8 11280.2 11547.3 11608.3 11753.6 11768.4 11609.8 11630.8 11640.9 11649.4 11826.6 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5940.52 Median:5471.02 stddev:3098.71 (56.6%) stddev-sans-first:3088.90 03:10:04 INFO - PROCESS | 1657 | Values: 1436.2 1596.8 1827.2 1952.2 1995.8 8609.1 8650.9 8790.4 8793.3 8809.8 7716.3 7904.8 8371.8 8552.0 8636.9 2414.7 2448.8 2449.9 2451.1 2466.3 2147.6 2394.9 2435.2 2456.8 2462.2 2182.2 2223.9 2234.0 2351.1 2434.1 2423.6 2427.4 2428.3 2432.3 2437.4 2376.7 2410.4 2433.5 2433.9 2434.6 8514.9 8569.4 8585.7 8590.4 8594.0 5278.3 5381.7 5389.4 5426.3 5430.1 3031.3 3166.5 3496.1 3509.2 3622.0 1037.6 1037.7 1049.7 1091.0 1098.3 11666.4 11705.4 11710.1 11725.8 11745.2 3891.5 4514.0 4827.1 4855.1 4866.9 9938.4 9957.7 9963.8 9971.5 9985.4 5446.1 5456.9 5457.9 5463.3 5478.7 4919.7 4971.8 4979.9 4986.4 4989.5 3358.8 3825.2 3846.0 3878.5 3903.2 1296.3 1310.1 1313.0 1319.6 1326.8 1010.8 1037.8 1148.5 1255.6 1332.4 7814.2 7884.4 7908.2 7925.3 7934.2 1180.5 1191.3 1193.4 1223.9 1230.2 6095.4 6177.8 6195.0 6199.5 6205.3 9866.8 10422.5 10465.1 10537.3 10604.1 8313.6 8833.9 10219.2 10435.6 10437.3 8087.7 8199.0 8242.5 8252.9 8262.8 7573.5 7685.8 7704.0 7737.5 7763.6 9203.9 9311.0 9426.9 9547.9 9579.2 9538.4 9732.8 9851.5 9868.7 9902.5 7239.5 7267.0 7300.5 7310.9 7316.7 7838.7 8039.6 8103.3 8116.0 8128.2 7298.9 7309.2 7353.2 7369.4 7461.0 7197.2 7223.1 7293.6 7313.3 7417.9 7555.8 7575.0 7582.4 7689.1 7693.5 6861.6 6913.1 6948.6 6953.2 6961.9 6598.8 6981.6 7007.6 7047.6 7088.6 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:5686.18 Median:6529.54 stddev:1842.69 (28.2%) stddev-sans-first:1803.41 03:10:04 INFO - PROCESS | 1657 | Values: 326.4 330.2 334.9 337.0 341.4 6549.4 6565.5 6583.2 6588.4 6595.1 6512.9 6531.8 6532.2 6548.2 6565.1 4637.9 4720.2 4773.1 4843.1 4926.0 3865.7 4842.6 4843.1 4851.4 4853.3 3871.6 4737.7 4784.7 4788.2 4821.3 4621.2 4674.4 4758.3 4796.7 4797.9 4095.4 4105.5 4108.1 4117.0 4129.9 4977.3 6095.5 6178.4 6215.5 6223.8 4595.9 5696.7 5698.7 5699.6 5709.5 6882.7 6889.2 6891.6 6899.0 6902.7 3659.3 4337.3 4494.2 4500.8 4550.0 7078.1 7255.9 7260.1 7262.0 7269.8 4140.9 4304.9 4598.5 4600.5 4602.2 4659.9 4668.3 4668.8 4671.8 4680.8 5511.7 5535.2 5541.0 5553.4 5565.1 6691.5 6905.1 6940.2 6961.4 6965.9 1597.5 1611.3 1624.8 1626.3 1633.1 832.8 972.1 1026.4 1029.4 1053.4 6265.9 6267.5 6349.7 6510.3 6543.5 7260.8 7267.9 7270.9 7281.3 7297.4 6488.4 6492.0 6496.5 6504.1 6518.6 3795.4 3819.7 3841.1 3845.4 3850.4 6230.6 7242.0 7480.5 7612.8 7620.8 7488.9 7528.4 7533.4 7534.5 7546.5 7584.2 7586.2 7594.8 7598.6 7604.2 6978.0 7258.7 7310.3 7318.1 7325.2 7137.4 7143.9 7162.2 7169.4 7181.4 7563.4 7570.8 7573.8 7574.0 7579.6 4566.3 4614.2 4617.2 4632.3 4634.6 6989.4 7240.1 7250.3 7251.5 7272.1 6979.8 7006.3 7010.8 7011.7 7013.5 5889.9 6814.7 6921.9 7009.8 7013.1 6822.5 6829.2 6832.9 6835.7 6839.1 6685.6 6987.8 6991.2 7005.2 7019.4 6527.3 6686.8 6780.2 6852.5 6873.9 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:17430.49 Median:32402.87 stddev:24079.31 (74.3%) stddev-sans-first:24113.65 03:10:04 INFO - PROCESS | 1657 | Values: 590.4 667.1 724.4 760.8 771.8 11649.9 12434.6 15155.7 15159.8 15209.6 13370.4 13610.3 13612.4 13614.2 13695.5 903.0 922.5 923.6 925.1 927.5 729.5 899.4 905.3 907.2 909.1 916.2 942.0 954.3 955.8 961.2 942.2 954.9 959.9 961.0 964.2 707.7 709.7 711.4 712.9 714.6 13331.7 13667.8 13695.2 13730.5 13736.9 11191.0 11339.1 11396.1 11473.8 11498.5 9318.4 9467.9 9481.2 9741.4 10185.6 3393.8 3400.9 3436.6 3466.4 3505.0 74347.0 74399.6 75017.1 77556.1 77732.6 7688.8 9273.2 9336.9 9595.6 9630.7 20348.2 20375.7 20379.8 20396.7 20402.6 6834.3 6929.0 6982.2 7005.9 7094.9 4043.5 4109.5 4111.8 4124.1 4249.9 3568.6 3601.6 3612.7 3613.7 3615.4 639.7 642.6 651.9 653.8 659.5 512.0 572.6 610.5 612.6 614.2 6920.4 8033.5 8181.8 8200.1 8315.2 588.4 598.9 615.1 620.7 628.4 3676.3 3696.2 3764.2 3820.6 3927.0 75452.9 79421.0 79619.8 85496.7 88563.0 59086.7 72755.6 73847.5 74482.6 74723.0 63043.4 68530.0 68602.0 69291.6 70273.6 8396.3 8403.6 8509.9 8524.8 8622.1 47970.8 50381.7 50898.7 51134.7 51804.5 64166.0 65946.7 68913.0 70577.9 70867.3 11111.0 11274.6 11439.5 11534.5 11800.8 10027.0 11795.6 11944.8 12080.8 12770.0 10653.3 11039.8 11121.3 12279.6 12308.3 11319.9 11335.9 11437.4 11631.9 11656.2 10891.4 11034.6 11284.5 11308.8 11332.5 9275.7 9377.4 9411.0 9710.7 10065.7 6887.4 8978.5 9226.7 9296.3 9298.3 03:10:04 INFO - PROCESS | 1657 | -------- Summary: end -------- 03:10:04 INFO - PROCESS | 1657 | 03:10:04 INFO - TEST-INFO | 1657: exit 0 03:10:04 INFO - TEST-OK | dromaeo_css | took 1112343ms 03:10:04 INFO - TEST-START | kraken 03:10:04 INFO - operating with platform_type : mac_ 03:10:04 INFO - Initialising browser for kraken test... 03:10:04 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpCiVd9g/profile http://localhost:49269/getInfo.html) 03:10:07 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 03:10:07 INFO - PROCESS | 1667 | colorDepth:24 03:10:07 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 03:10:07 INFO - PROCESS | 1667 | __metrics 03:10:07 INFO - PROCESS | 1667 | 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" 03:10:07 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:10:07 INFO - TEST-INFO | 1667: exit 0 03:10:07 INFO - Browser initialized. 03:10:07 INFO - Running cycle 1/1 for kraken test... 03:10:07 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpCiVd9g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:19 INFO - PROCESS | 1669 | RSS: Main: 235974656 03:10:19 INFO - PROCESS | 1669 | 03:10:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 03:10:22 INFO - PROCESS | 1669 | RSS: Main: 282157056 03:10:22 INFO - PROCESS | 1669 | 03:10:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 03:10:25 INFO - PROCESS | 1669 | RSS: Main: 292683776 03:10:25 INFO - PROCESS | 1669 | 03:10:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 03:10:29 INFO - PROCESS | 1669 | RSS: Main: 278904832 03:10:29 INFO - PROCESS | 1669 | 03:10:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 03:10:32 INFO - PROCESS | 1669 | RSS: Main: 281841664 03:10:32 INFO - PROCESS | 1669 | 03:10:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:10:35 INFO - PROCESS | 1669 | RSS: Main: 281939968 03:10:35 INFO - PROCESS | 1669 | 03:10:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 03:10:38 INFO - PROCESS | 1669 | RSS: Main: 282288128 03:10:38 INFO - PROCESS | 1669 | 03:10:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 03:10:41 INFO - PROCESS | 1669 | RSS: Main: 282165248 03:10:41 INFO - PROCESS | 1669 | 03:10:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 03:10:45 INFO - PROCESS | 1669 | RSS: Main: 282628096 03:10:45 INFO - PROCESS | 1669 | 03:10:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:10:47 INFO - PROCESS | 1669 | RSS: Main: 314945536 03:10:47 INFO - PROCESS | 1669 | 03:10:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:10:49 INFO - PROCESS | 1669 | RSS: Main: 315756544 03:10:49 INFO - PROCESS | 1669 | 03:10:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:10:52 INFO - PROCESS | 1669 | RSS: Main: 322904064 03:10:52 INFO - PROCESS | 1669 | 03:10:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:10:55 INFO - PROCESS | 1669 | RSS: Main: 324227072 03:10:55 INFO - PROCESS | 1669 | 03:10:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:10:58 INFO - PROCESS | 1669 | RSS: Main: 324034560 03:10:58 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 03:11:00 INFO - PROCESS | 1669 | RSS: Main: 387051520 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | __start_tp_report 03:11:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 03:11:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 03:11:00 INFO - PROCESS | 1669 | |i|pagename|runs| 03:11:00 INFO - PROCESS | 1669 | |0;ai-astar;111;108;112;110;110;111;116;110;112;111 03:11:00 INFO - PROCESS | 1669 | |1;audio-beat-detection;156;121;144;158;118;143;143;114;162;123 03:11:00 INFO - PROCESS | 1669 | |2;audio-dft;186;185;187;184;184;185;183;183;181;183 03:11:00 INFO - PROCESS | 1669 | |3;audio-fft;91;72;82;83;59;58;52;81;105;82 03:11:00 INFO - PROCESS | 1669 | |4;audio-oscillator;95;91;131;77;79;79;118;79;79;120 03:11:00 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;86;83;86;84;87;83;87;83;86;84 03:11:00 INFO - PROCESS | 1669 | |6;imaging-darkroom;92;94;93;93;93;93;92;92;93;92 03:11:00 INFO - PROCESS | 1669 | |7;imaging-desaturate;95;97;96;93;96;96;94;92;93;93 03:11:00 INFO - PROCESS | 1669 | |8;json-parse-financial;57;53;53;54;55;54;53;63;54;53 03:11:00 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;63;63;65;78;69;67;65;68;92;100 03:11:00 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;83;84;83;84;83;82;81;83;85;83 03:11:00 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;120;131;119;145;120;143;101;135;119;106 03:11:00 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;132;128;141;142;139;128;139;140;136;136 03:11:00 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;67;66;65;67;66;67;66;65;65;67 03:11:00 INFO - PROCESS | 1669 | __end_tp_report 03:11:00 INFO - PROCESS | 1669 | __start_cc_report 03:11:00 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1303 03:11:00 INFO - PROCESS | 1669 | __end_cc_report 03:11:00 INFO - PROCESS | 1669 | __startTimestamp1459851060694__endTimestamp 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | ------- Summary: start ------- 03:11:00 INFO - PROCESS | 1669 | Number of tests: 14 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.08 (1.9%) stddev-sans-first:2.20 03:11:00 INFO - PROCESS | 1669 | Values: 111.0 108.0 112.0 110.0 110.0 111.0 116.0 110.0 112.0 111.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:143.50 stddev:17.87 (12.5%) stddev-sans-first:17.76 03:11:00 INFO - PROCESS | 1669 | Values: 156.0 121.0 144.0 158.0 118.0 143.0 143.0 114.0 162.0 123.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.73 (0.9%) stddev-sans-first:1.69 03:11:00 INFO - PROCESS | 1669 | Values: 186.0 185.0 187.0 184.0 184.0 185.0 183.0 183.0 181.0 183.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:76.50 Median:81.50 stddev:16.38 (20.1%) stddev-sans-first:16.51 03:11:00 INFO - PROCESS | 1669 | Values: 91.0 72.0 82.0 83.0 59.0 58.0 52.0 81.0 105.0 82.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:20.58 (26.1%) stddev-sans-first:21.83 03:11:00 INFO - PROCESS | 1669 | Values: 95.0 91.0 131.0 77.0 79.0 79.0 118.0 79.0 79.0 120.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.72 03:11:00 INFO - PROCESS | 1669 | Values: 86.0 83.0 86.0 84.0 87.0 83.0 87.0 83.0 86.0 84.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:11:00 INFO - PROCESS | 1669 | Values: 92.0 94.0 93.0 93.0 93.0 93.0 92.0 92.0 93.0 92.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.50 stddev:1.72 (1.8%) stddev-sans-first:1.81 03:11:00 INFO - PROCESS | 1669 | Values: 95.0 97.0 96.0 93.0 96.0 96.0 94.0 92.0 93.0 93.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:3.11 (5.8%) stddev-sans-first:3.20 03:11:00 INFO - PROCESS | 1669 | Values: 57.0 53.0 53.0 54.0 55.0 54.0 53.0 63.0 54.0 53.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:67.50 stddev:13.00 (19.3%) stddev-sans-first:13.27 03:11:00 INFO - PROCESS | 1669 | Values: 63.0 63.0 65.0 78.0 69.0 67.0 65.0 68.0 92.0 100.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:1.17 03:11:00 INFO - PROCESS | 1669 | Values: 83.0 84.0 83.0 84.0 83.0 82.0 81.0 83.0 85.0 83.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:125.50 stddev:14.56 (11.6%) stddev-sans-first:15.37 03:11:00 INFO - PROCESS | 1669 | Values: 120.0 131.0 119.0 145.0 120.0 143.0 101.0 135.0 119.0 106.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:139.00 stddev:5.15 (3.7%) stddev-sans-first:5.25 03:11:00 INFO - PROCESS | 1669 | Values: 132.0 128.0 141.0 142.0 139.0 128.0 139.0 140.0 136.0 136.0 03:11:00 INFO - PROCESS | 1669 | 03:11:00 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 03:11:00 INFO - PROCESS | 1669 | Values: 67.0 66.0 65.0 67.0 66.0 67.0 66.0 65.0 65.0 67.0 03:11:00 INFO - PROCESS | 1669 | -------- Summary: end -------- 03:11:00 INFO - PROCESS | 1669 | 03:11:01 INFO - TEST-INFO | 1669: exit 0 03:11:01 INFO - TEST-OK | kraken | took 56370ms 03:11:01 INFO - SUITE-END | took 1168s 03:11:01 INFO - Completed test suite (00:19:28) 03:11:01 INFO - javascript benchmark 03:11:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3439.449688049912, 3494.930101397972, 3525.8479416000387, 3533.611302756696, 3571.8928432147027, 5633.267675202218, 5689.544836413087, 5736.426357364267, 5742.741576629051, 5752.309722833261, 5693.089105743082, 5774.913376299359, 5787.942120578793, 5791.913121303184, 5858.88282234355, 5198.194279886605, 5255.290535777678, 5258.36899572051, 5259.710715910624, 5265.710385928773, 5175.404828444721, 5296.682199068068, 5300.01949639316, 5389.676619402849, 5403.972980135094, 4403.867883963486, 5287.788488460457, 5303.443138470444, 5338.225957236198, 5393.2449457076045, 4237.618614324726, 5103.974480127613, 5207.791688332462, 5245.344331958505, 5259.605529585258, 5162.483751624845, 5175.404828444739, 5179.974100129513, 5180.3265575475325, 5202.4537423570355, 5607.663540187602, 5612.017896868073, 5612.354579223401, 5616.297962754656, 5621.128725047624, 6069.529489596456, 6118.588722523122, 6232.439080482733, 6253.1558239637525, 6271.996480563088, 6230.7819226326865, 6267.0, 6283.403076707706, 6285.4343109119945, 6292.119103325538, 5525.4474552544425, 5603.80386686464, 5818.418158184148, 5819.73811178498, 5882.147088672119, 6148.9692551536955, 6196.318404975449, 6238.251409830849, 6263.467605253604, 6273.8745225095245, 6084.452399283997, 6116.235470566179, 6147.139400483936, 6147.415995480422, 6154.5076393888385, 6215.378462153749, 6254.8123556293385, 6255.0, 6261.686915654199, 6290.339514351019, 6065.302490213682, 6170.444659980623, 6171.413715697002, 6182.629042257479, 6189.597676151036, 6135.208480141525, 6223.62658240498, 6248.250209974832, 6256.217972753406, 6264.812055638338, 4845.2732090186755, 4861.222204447272, 4863.1732605457155, 4880.072786170687, 4893.363862697826, 4281.550437204111, 4436.290193569078, 4444.7110937789585, 4482.618977386894, 4493.98885250816, 4793.760311984387, 5610.242617246701, 5621.4659607337235, 5651.773929042874, 5743.741531631086, 6207.565470417027, 6220.471259942865, 6228.408301211378, 6231.781887634002, 6264.62412255257, 5471.835844924659, 5588.0, 5673.177389278531, 5678.375378708339, 5710.71446427677, 5333.5199832015305, 5361.383440904346, 5410.486003829708, 5417.404085550586, 5434.972825135849, 6246.875062498724, 6297.874042519215, 6303.275123360872, 6311.211098612765, 6334.873302534015, 6113.628337950474, 6114.631938157225, 6166.0, 6183.783567575113, 6211.844703882439, 6214.347493513116, 6221.191245138103, 6230.00319948806, 6255.655938923403, 6261.530385221217, 5126.589872810241, 6123.142760013513, 6125.234345706786, 6128.50971922254, 6135.07973803933, 5152.330197074356, 5180.352455943007, 5296.576273898156, 6097.695115244132, 6189.226346706661, 6064.3026052002815, 6097.390260973867, 6109.633421994695, 6116.66358350295, 6117.632942023492, 6025.276966764016, 6061.212042434456, 6087.36082711309, 6098.512119030378, 6110.26676798787, 4933.605311575137, 5776.306843178845, 5879.176915231786, 5921.881562368814, 5954.166416701579, 6059.848503787441, 6070.3929607038945, 6079.179310792986, 6083.574149809471, 6105.358937311518, 5504.788946431779, 5914.497267732291, 5928.229330187048, 5928.436798504135, 5945.910811337747], "unit": "score", "name": "dojo.html", "value": 5651.177049261886}, {"lowerIsBetter": false, "replicates": [518.9818356357529, 574.7757276999987, 580.7996241296751, 634.7841733810503, 636.8598908240187, 30250.0, 30549.236269093282, 30655.38689226214, 38240.617593824056, 39027.41458878119, 35925.461118083185, 39499.0, 42009.7899510502, 42471.0, 42515.14969700604, 9052.637894484213, 9604.471754053524, 9605.66380176694, 9611.855822162674, 9612.567434465465, 8105.635246413925, 9445.149936505713, 9620.230381569458, 9623.1820295275, 9642.325037247361, 9594.952025239863, 9649.0, 9694.369865958726, 9729.075737804897, 9752.512374381287, 9639.0, 9722.465264410455, 9727.027297270288, 9727.90272097277, 9733.707988760312, 9578.281628877792, 9582.568784404719, 9728.221742260603, 9752.658656946973, 9772.462514561696, 39968.400473992915, 40274.79862600668, 40314.59685403167, 40413.59586404128, 40439.0, 3236.207129253348, 3268.0686004488844, 3308.4044871923043, 3399.9660003399895, 3802.8478860845535, 28282.0, 28936.710632893613, 29269.97555085562, 29501.11496655104, 29679.25801854971, 2749.628800111979, 2755.0632784853246, 2816.8732407041734, 2881.236472334812, 2888.9022171574666, 501396.99999999633, 504368.0, 505294.0, 506446.0, 509157.45421272656, 36828.44757328642, 46190.07619847584, 65844.0, 66127.66936165384, 66492.0, 45251.0, 45387.77306113448, 45544.77227613841, 45669.543304567196, 45720.08559828785, 15656.921715391578, 15830.76253856193, 15834.683306333809, 15839.683206335809, 15869.841301587066, 12628.684282892817, 12649.683757906127, 12665.430055647517, 12699.746005079847, 12721.745565088646, 14776.26118694061, 14831.92584037073, 14864.70270594582, 14950.70098598022, 15034.924825375803, 6129.509639228851, 6242.469390101892, 6290.24517057956, 6294.433500984934, 6329.145565348711, 917.3853518142861, 923.7459698582809, 942.6370847223868, 985.3398223190479, 1114.9275297105662, 28941.276468088046, 29024.129276121752, 29126.854365728035, 29438.705612943595, 29530.55704164439, 1015.7816069545083, 1038.2472707287307, 1076.278893141597, 1112.0991996482874, 1153.7404084081015, 14740.0, 14762.852371476363, 14804.851951480563, 15058.774118388234, 15080.472183473526, 484406.0, 489736.0, 489814.0, 490586.0, 491232.0, 58351.41648583545, 59018.70490647605, 59020.0, 59032.40967590355, 59177.0, 1258.704204511939, 1326.5158217250635, 1426.1229343953394, 1462.7732701431296, 1466.538040517255, 25920.351991200372, 27564.621768911875, 28113.71886281193, 28117.43765124727, 28514.57228141538, 35982.64017359898, 43969.34045989249, 44288.89277768081, 44811.55188448204, 44831.551684484046, 290303.0, 290417.0, 290579.0, 292201.0, 292946.5352673223, 28080.29799255035, 28525.714742852306, 32672.50991235086, 33439.0, 33580.160495987795, 41143.0, 41666.79166604148, 41744.0, 42009.369859452745, 42874.0, 34694.47958280678, 34708.305833883685, 34755.82622086874, 35355.82322088373, 35405.82297088601, 34192.65807341895, 34259.0, 34538.96383108511, 34606.480902785974, 35005.0, 36559.26881462409, 36751.816240918626, 36813.26373472462, 38529.0, 38716.6128338713, 29529.704702953553, 30963.380732385678, 31980.0, 32571.0, 32615.836920815244, 21325.36023919285, 22887.427814304774, 23911.402214944068, 24154.0, 24652.260432187064], "unit": "score", "name": "ext.html", "value": 18583.108898880942}, {"lowerIsBetter": false, "replicates": [358.74170597170036, 361.67449295633924, 364.1533434764173, 369.26884768159044, 372.1236488070592, 19669.50826229343, 20040.0, 21300.57398852026, 21471.57056858862, 21481.892590537063, 20347.18611255552, 20790.792092079075, 21082.262120825773, 21123.0, 21344.0, 5795.391483894183, 6018.518518518508, 6043.516518678517, 6045.6070355426755, 6048.153258543807, 5794.159846822229, 5826.15520749491, 5873.618214816044, 5981.401859814027, 5995.700214989255, 5929.911051334234, 5937.910931336012, 5938.168656388109, 5941.762329506836, 5959.761609535613, 5599.496045355917, 5922.31893332268, 5928.1404196391495, 5934.28788545373, 5955.166276721263, 5100.591952643779, 5101.0, 5150.330457040561, 5151.484851514856, 5151.536361727425, 24743.38141546476, 24825.0, 25293.873530632412, 25367.873160634263, 25391.746082539124, 2266.5920134375806, 2351.3651314145254, 2394.0543485323374, 2414.517096580691, 2856.814307070034, 12102.515899364014, 14003.929980350134, 14609.926950365287, 14613.415463381452, 15162.696746065018, 1602.4952140075839, 1616.658173715813, 1740.1647209339462, 1822.1253798176817, 1885.632301701169, 93032.44146323245, 93554.73688907833, 93966.53016734941, 96245.0375496243, 96788.51605741926, 8973.910260897437, 10455.84316235257, 10683.0, 10761.192910531741, 10889.509972051277, 13717.108387954751, 13769.655758606115, 13791.931040344734, 13795.723705588465, 13819.654508637364, 7127.322904324081, 8264.512387770259, 8278.83442331162, 8447.281981031558, 8524.104968978292, 7643.350315223268, 7782.922170778333, 8512.233898949124, 8517.403781735218, 8581.914180858237, 3581.8567257309937, 4357.257097161098, 4389.604935555815, 4415.403920470695, 4442.888927776831, 1733.3240036385819, 1799.5411170151528, 1811.447508509917, 1855.7566430491604, 1871.4759867236924, 858.7080392666398, 916.6012784438791, 928.3223247029571, 938.174406522256, 939.3377668743519, 18948.715769263472, 19140.621095663304, 19783.10976006083, 20099.598008039757, 20146.0, 949.0556895888498, 960.6061514779046, 984.7538115471132, 999.2655398282257, 1078.471548941029, 9464.668736594323, 10943.398113103856, 10963.287386319864, 10987.39569323679, 11036.337819730841, 531078.0, 564103.1794841, 576433.0, 591058.0, 602459.0, 117072.8292717062, 119301.40349298372, 121809.0, 125101.0, 127310.0, 968.4237878462444, 993.6621548673342, 1036.9948150259352, 1039.308859608352, 1083.6911480227939, 13743.969202309667, 15081.396744130112, 17898.821011789714, 18188.272469101088, 18210.544736381697, 48788.512114878395, 50332.4900252993, 50969.23546146737, 52786.94426111533, 53037.734811325696, 50089.0, 70260.0, 73366.53266934738, 74494.62752686419, 74650.25349746433, 7564.886526701994, 7690.961545192238, 7755.534667919943, 7790.493617914817, 7926.960365198137, 8659.393842431222, 8886.73339799807, 8903.332250081141, 9111.681091161778, 9170.95414522923, 6219.595726277777, 6270.435660790551, 7804.180561041009, 7884.763457096296, 8150.83698326042, 7534.065187302107, 7985.840283194188, 8209.876851847108, 8251.216134467217, 8297.792555186168, 8003.279704826594, 8118.188181181835, 8280.213379728915, 8324.25081742646, 8382.83234335322, 11280.210385272952, 11547.307161570332, 11608.30350178992, 11753.647390578297, 11768.411579420823, 11609.839016098322, 11630.825537616773, 11640.876130672117, 11649.41752912334, 11826.58606948787], "unit": "score", "name": "jquery.html", "value": 9132.031253181887}, {"lowerIsBetter": false, "replicates": [1436.1670231265866, 1596.7844341013963, 1827.2051657528975, 1952.1995981647528, 1995.8203761661448, 8609.053004169544, 8650.91349086509, 8790.428622139565, 8793.34049946255, 8809.779755506115, 7716.305532502074, 7904.762857114281, 8371.790705232372, 8551.957240213791, 8636.870446943301, 2414.7343792182846, 2448.8285819992607, 2449.889754961031, 2451.1053465485147, 2466.272449627364, 2147.5919575280723, 2394.916177933773, 2435.196385192891, 2456.754324567538, 2462.249014050714, 2182.1707751054655, 2223.9332820015425, 2233.972372708556, 2351.130081869702, 2434.111549284516, 2423.624338227569, 2427.4416884116577, 2428.307932239303, 2432.2824766693866, 2437.4150203950926, 2376.65538496917, 2410.4455975125643, 2433.513297340539, 2433.9391515212083, 2434.6226334918115, 8514.914850851535, 8569.400141990063, 8585.742427727117, 8590.355723320776, 8594.011688655759, 5278.287431196778, 5381.730913454312, 5389.380221274525, 5426.348838139448, 5430.104032834578, 3031.287647402881, 3166.4617015107488, 3496.0910163357457, 3509.2455122148863, 3621.9858439636946, 1037.6420135053395, 1037.709441356414, 1049.6588608702202, 1090.983635245472, 1098.3025778630627, 11666.416679166008, 11705.414729263503, 11710.063194944383, 11725.765484690344, 11745.177837551375, 3891.5330160380367, 4513.954860451419, 4827.106985207678, 4855.101806165871, 4866.878328041827, 9938.403695778277, 9957.651482198089, 9963.750906227402, 9971.451570163566, 9985.400875947467, 5446.101393270145, 5456.91814622781, 5457.935702537967, 5463.31708536433, 5478.726063696799, 4919.680220785637, 4971.751412429437, 4979.90040199194, 4986.426560945465, 4989.476105008922, 3358.7984720916825, 3825.158465137665, 3846.0, 3878.506774891687, 3903.224033064949, 1296.3453456004656, 1310.0567591334225, 1312.9934350328379, 1319.5645437005765, 1326.820879181298, 1010.8231059564547, 1037.7613148975777, 1148.494662348564, 1255.5793809074062, 1332.3737843213673, 7814.21857814214, 7884.448088633855, 7908.248716372051, 7925.28672419485, 7934.166912474107, 1180.4982882274999, 1191.3209470601846, 1193.361551569906, 1223.8959688426405, 1230.2126638951079, 6095.359987201368, 6177.8455538611, 6195.039768835838, 6199.504039676815, 6205.2553693557065, 9866.753331166634, 10422.530986105643, 10465.058144767008, 10537.262391632665, 10604.098651614544, 8313.625886835107, 8833.911660883437, 10219.233557483218, 10435.634752783768, 10437.2693911427, 8087.716929907425, 8198.975128108987, 8242.546659933641, 8252.895511644492, 8262.793430164294, 7573.545587264782, 7685.846283074419, 7704.0, 7737.535747854921, 7763.5730034846365, 9203.86194207074, 9310.95344523273, 9426.858597121185, 9547.904520954702, 9579.23366130694, 9538.380005299634, 9732.805343893224, 9851.507424628597, 9868.654597089067, 9902.504874756378, 7239.457040722073, 7266.982622432969, 7300.45246606496, 7310.890336645061, 7316.670749816165, 7838.686452541834, 8039.598020099089, 8103.31121854649, 8115.959420202861, 8128.227818357246, 7298.927010729824, 7309.159446663702, 7353.227911069261, 7369.410447164321, 7460.962695186489, 7197.208307086112, 7223.133224013152, 7293.635318234174, 7313.341799238094, 7417.92582074194, 7555.848883022419, 7575.0, 7582.431317651088, 7689.077310722749, 7693.4614576979075, 6861.622610756456, 6913.1358580177475, 6948.583085014915, 6953.23514413404, 6961.89557156633, 6598.8350291243105, 6981.581105133709, 7007.614581198083, 7047.647617618996, 7088.574685518885], "unit": "score", "name": "mootools.html", "value": 4863.032317557385}, {"lowerIsBetter": false, "replicates": [326.4417845484222, 330.18444442227707, 334.87609584453753, 337.039437602832, 341.44856057467183, 6549.377809108133, 6565.507586930981, 6583.210014798219, 6588.407043366096, 6595.1096601958725, 6512.869742605157, 6531.771388001421, 6532.150820393343, 6548.246951600568, 6565.113709649196, 4637.8840528986875, 4720.150372932871, 4773.0931123086675, 4843.128236917353, 4925.950740492594, 3865.690744740414, 4842.588379987706, 4843.104025755247, 4851.417829860422, 4853.272009198613, 3871.5741268460447, 4737.73942433166, 4784.712917224961, 4788.233882578788, 4821.349117869077, 4621.191291523986, 4674.368960190382, 4758.286257061434, 4796.664233503656, 4797.928031079537, 4095.4471146395153, 4105.4662893823615, 4108.116754897711, 4117.0, 4129.855455059089, 4977.253411988195, 6095.512359011313, 6178.443940045418, 6215.533834962396, 6223.751049957997, 4595.862124136248, 5696.6866822324755, 5698.715064246771, 5699.572532060112, 5709.486146246858, 6882.655867206619, 6889.207741109786, 6891.552049116792, 6899.0, 6902.723891044352, 3659.2864391443677, 4337.284348082562, 4494.1910456117885, 4500.819967201308, 4549.977250113761, 7078.115235595551, 7255.891161632527, 7260.128784545888, 7261.963690181568, 7269.781906542812, 4140.923359926441, 4304.870853874389, 4598.517155698671, 4600.5169457207185, 4602.217623004098, 4659.928216510154, 4668.253079507263, 4668.786115609898, 4671.789769460383, 4680.789364478606, 5511.724413779295, 5535.169724541351, 5541.0, 5553.389127196006, 5565.109582466866, 6691.464682825363, 6905.102336696298, 6940.167179938439, 6961.40828029613, 6965.895511567331, 1597.5207437768856, 1611.3393508661393, 1624.7887774589228, 1626.2763070433543, 1633.1426001349148, 832.8459235041537, 972.1105188752354, 1026.384169498295, 1029.4389557690927, 1053.3679792124665, 6265.8746825063245, 6267.5299352548745, 6349.6507692077375, 6510.283868774431, 6543.476521878333, 7260.782176534713, 7267.909813528013, 7270.854582908312, 7281.2718728126765, 7297.379722723522, 6488.448481879093, 6492.0, 6496.512761542903, 6504.121943537656, 6518.5762925410645, 3795.35478968576, 3819.713521485844, 3841.116543195025, 3845.384738441892, 3850.403187505941, 6230.59501132425, 7242.0, 7480.513766605153, 7612.80967975805, 7620.771376858703, 7488.887666685004, 7528.397728181732, 7533.4349923755935, 7534.472586918863, 7546.547207167588, 7584.2036586158765, 7586.24137586248, 7594.8101297468, 7598.582077985653, 7604.163542010375, 6977.9994602321485, 7258.673359698721, 7310.268973102648, 7318.109346807874, 7325.194228634739, 7137.393321567725, 7143.892841607484, 7162.2121566628675, 7169.3906017986965, 7181.425485961215, 7563.432742544222, 7570.810729731801, 7573.810654733676, 7573.962130189314, 7579.583122928292, 4566.337881007302, 4614.192516309699, 4617.191991401424, 4632.2819962905805, 4634.582887540138, 6989.440844732511, 7240.05879235696, 7250.347468727839, 7251.456140789356, 7272.127344718668, 6979.825504362431, 7006.2643422439905, 7010.824729381806, 7011.719531218694, 7013.509054366145, 5889.882202356014, 6814.727410903707, 6921.89617155733, 7009.843375842929, 7013.088298521159, 6822.454203663794, 6829.214640316229, 6832.897506537306, 6835.726570937107, 6839.076724642109, 6685.6322902240845, 6987.847005244281, 6991.161060672548, 7005.194402643558, 7019.403350715246, 6527.314631963765, 6686.832829179115, 6780.220274668476, 6852.486063545353, 6873.931260687529], "unit": "score", "name": "prototype.html", "value": 5068.441358324948}, {"lowerIsBetter": false, "replicates": [590.4168520990951, 667.076099602051, 724.4349407462181, 760.8288135169586, 771.8456308738254, 11649.883501164986, 12434.626961191167, 15155.696886062273, 15159.848401515981, 15209.619759506018, 13370.398332075056, 13610.251436171007, 13612.387442565083, 13614.183149011067, 13695.520656777015, 902.981940361194, 922.4880191493718, 923.6213152607432, 925.1349987761431, 927.4898805656895, 729.4711334282629, 899.4153800029967, 905.2803021597846, 907.2107266677999, 909.0863681999581, 916.2212119698237, 942.0297093993198, 954.2604481526803, 955.784948386611, 961.2166084640995, 942.1661829281102, 954.9092836180552, 959.8656188133667, 960.9759756006085, 964.1997142371814, 707.7098389660215, 709.6983781892726, 711.4415184080472, 712.9144502659663, 714.6176795414481, 13331.733365332639, 13667.794983075262, 13695.178289302574, 13730.51943181984, 13736.93131534336, 11191.048760855338, 11339.092872570174, 11396.145289103268, 11473.756885495834, 11498.482568284364, 9318.394304370262, 9467.90532094684, 9481.241500679998, 9741.366811157252, 10185.643502477451, 3393.7624366294367, 3400.914977125567, 3436.570428696413, 3466.41071017925, 3505.0, 74347.0, 74399.62800186018, 75017.1245718856, 77556.06109847242, 77732.61133694295, 7688.846223075507, 9273.165415112537, 9336.90663093374, 9595.568199431042, 9630.711078667651, 20348.18607255693, 20375.694364584542, 20379.796202038087, 20396.694049589267, 20402.59194816125, 6834.282400347991, 6929.0, 6982.162140543066, 7005.859882802417, 7094.893576596355, 4043.534993475729, 4109.473850826271, 4111.814968326433, 4124.1133156371525, 4249.915001699948, 3568.589612194579, 3601.6218297078954, 3612.710983121344, 3613.6567026132475, 3615.385384484644, 639.7472998165791, 642.5927219389522, 651.947844172465, 653.7646447278976, 659.5185514574388, 511.9948800512022, 572.6342672725497, 610.4627927423838, 612.592625903769, 614.1770028162284, 6920.377166054978, 8033.517988920684, 8181.754547363588, 8200.097989221182, 8315.168483151636, 588.4321629627431, 598.8531115949284, 615.1080932647678, 620.7175735040546, 628.3936001758234, 3676.3015027144756, 3696.2053158571034, 3764.247150569897, 3820.6370394812448, 3927.0, 75452.86820697694, 79421.0, 79619.8057029145, 85496.71754923681, 88563.0, 59086.704566476896, 72755.63622181855, 73847.52304953871, 74482.62758686172, 74723.0, 63043.36956630375, 68530.0, 68601.97097043449, 69291.61416771637, 70273.64863175651, 8396.286315663237, 8403.621837017472, 8509.872351914602, 8524.829503410021, 8622.051574326944, 47970.76014619905, 50381.74809125931, 50898.727531812, 51134.74432627813, 51804.48195517997, 64166.0, 65946.67026664836, 68913.0, 70577.94133087905, 70867.29132708607, 11111.0, 11274.605388811353, 11439.485223164811, 11534.480948357177, 11800.763984720086, 10027.0, 11795.587154449897, 11944.761104777683, 12080.75838483243, 12770.0, 10653.307535010199, 11039.779204415707, 11121.27711698737, 12279.570215042431, 12308.323042232405, 11319.886801131883, 11335.886641133484, 11437.370944598128, 11631.941840290745, 11656.242344247597, 10891.40908164332, 11034.613788517363, 11284.548618055185, 11308.773824523629, 11332.490037948148, 9275.72172834816, 9377.437353758523, 9410.95294523523, 9710.70867873965, 10065.748356291151, 6887.380135787803, 8978.506182160045, 9226.677066302917, 9296.256299496159, 9298.349115561845], "unit": "score", "name": "yui.html", "value": 6740.822283485402}], "name": "dromaeo_css", "value": 7363.066749654931}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 110.0, 110.0, 111.0, 116.0, 110.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 144.0, 158.0, 118.0, 143.0, 143.0, 114.0, 162.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 138.2}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 187.0, 184.0, 184.0, 185.0, 183.0, 183.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.1}, {"lowerIsBetter": true, "replicates": [91.0, 72.0, 82.0, 83.0, 59.0, 58.0, 52.0, 81.0, 105.0, 82.0], "unit": "score", "name": "audio-fft", "value": 76.5}, {"lowerIsBetter": true, "replicates": [95.0, 91.0, 131.0, 77.0, 79.0, 79.0, 118.0, 79.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 94.8}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 86.0, 84.0, 87.0, 83.0, 87.0, 83.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.9}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 93.0, 93.0, 93.0, 93.0, 92.0, 92.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.7}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 93.0, 96.0, 96.0, 94.0, 92.0, 93.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 94.5}, {"lowerIsBetter": true, "replicates": [57.0, 53.0, 53.0, 54.0, 55.0, 54.0, 53.0, 63.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 78.0, 69.0, 67.0, 65.0, 68.0, 92.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.0}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 84.0, 83.0, 82.0, 81.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [120.0, 131.0, 119.0, 145.0, 120.0, 143.0, 101.0, 135.0, 119.0, 106.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [132.0, 128.0, 141.0, 142.0, 139.0, 128.0, 139.0, 140.0, 136.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 65.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1413.8999999999999}]} 03:11:01 INFO - Return code: 0 03:11:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:11:01 ERROR - # TBPL SUCCESS # 03:11:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:11:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:11:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:11:01 INFO - 2016-04-05 03:11:01.520 screenresolution[1673:9931] starting screenresolution argv=screenresolution get 03:11:01 INFO - 2016-04-05 03:11:01.522 screenresolution[1673:9931] Display 0: 1600x1200x32@60 03:11:01 INFO - 2016-04-05 03:11:01.529 screenresolution[1674:9934] starting screenresolution argv=screenresolution list 03:11:01 INFO - Available Modes on Display 0 03:11:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:11:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:11:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:11:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:11:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:11:01 INFO - Intel Iris: 03:11:01 INFO - Chipset Model: Intel Iris 03:11:01 INFO - Type: GPU 03:11:01 INFO - Bus: Built-In 03:11:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:11:01 INFO - Vendor: Intel (0x8086) 03:11:01 INFO - Device ID: 0x0a2e 03:11:01 INFO - Revision ID: 0x0009 03:11:01 INFO - Displays: 03:11:01 INFO - Display: 03:11:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:11:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:11:01 INFO - Display Serial Number: 1600x1200 60 03:11:01 INFO - Main Display: Yes 03:11:01 INFO - Mirror: Off 03:11:01 INFO - Online: Yes 03:11:01 INFO - Rotation: Supported 03:11:01 INFO - Return code: 0 03:11:01 INFO - Running post-action listener: _resource_record_post_action 03:11:01 INFO - Running post-run listener: _resource_record_post_run 03:11:02 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37680640; Write bytes: 700621824; Read time: 397; Write time: 2046 03:11:02 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 396911104; Write bytes: 388970496; Read time: 30038; Write time: 803 03:11:02 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35833344; Write bytes: 296295424; Read time: 373; Write time: 1173 03:11:02 INFO - Running post-run listener: _upload_blobber_files 03:11:02 INFO - Blob upload gear active. 03:11:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:02 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 03:11:02 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:11:02 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:11:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:04 INFO - (blobuploader) - INFO - Done attempting. 03:11:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:11:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:11:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:05 INFO - (blobuploader) - INFO - Done attempting. 03:11:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:05 INFO - Return code: 0 03:11:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b2bef3fbba5d57761b4aa67c739470804e49d41f9ed51feb7f26bca08d068129a034c5c79416353403ff7e68095dfadecb18cab8f099e5fdcfa6ae498ac7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4a9e8e160c56b193bc5517c604039dd63d46d690497cbdca55bd29ea03b032bc67763b833b80ff00b59358771a7583c51f04ee4ee691a8444dc90b673fb080"} 03:11:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:05 INFO - Contents: 03:11:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b2bef3fbba5d57761b4aa67c739470804e49d41f9ed51feb7f26bca08d068129a034c5c79416353403ff7e68095dfadecb18cab8f099e5fdcfa6ae498ac7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4a9e8e160c56b193bc5517c604039dd63d46d690497cbdca55bd29ea03b032bc67763b833b80ff00b59358771a7583c51f04ee4ee691a8444dc90b673fb080"} 03:11:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:05 INFO - Copying logs to upload dir... 03:11:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.526515 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-04-05 03:11:05.487859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 03:11:05.491052) ========= 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.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/Firefox/sha512/a4b2bef3fbba5d57761b4aa67c739470804e49d41f9ed51feb7f26bca08d068129a034c5c79416353403ff7e68095dfadecb18cab8f099e5fdcfa6ae498ac7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4a9e8e160c56b193bc5517c604039dd63d46d690497cbdca55bd29ea03b032bc67763b833b80ff00b59358771a7583c51f04ee4ee691a8444dc90b673fb080"} build_url:https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/caOn9CHKQbaleqK8Ga9iFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4b2bef3fbba5d57761b4aa67c739470804e49d41f9ed51feb7f26bca08d068129a034c5c79416353403ff7e68095dfadecb18cab8f099e5fdcfa6ae498ac7a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c4a9e8e160c56b193bc5517c604039dd63d46d690497cbdca55bd29ea03b032bc67763b833b80ff00b59358771a7583c51f04ee4ee691a8444dc90b673fb080"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 03:11:05.531135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-05 03:11:05.531480) ========= 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.9d6UOIbVeO/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.SPsdxkX65S/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005148 ========= master_lag: 4.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-05 03:11:09.684496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 03:11:09.684885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 03:11:09.694955) ========= ========= Total master_lag: 4.44 =========