builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1460162254.46 results: success (0) buildid: 20160408152746 builduid: b62e47a29d5b4f1d93dbc3aa09ba0fe8 revision: 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:34.461090) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:34.462117) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:34.462881) ========= 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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005660 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:34.773814) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:34.774177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:35.518897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:35.519312) ========= 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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005263 ========= master_lag: 0.32 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:35.848785) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:35.849473) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:35.850286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:35.850981) ========= 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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-08 17:37:35-- 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% 152M=0s 2016-04-08 17:37:36 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.709618 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:36.713743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:36.714133) ========= 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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.020129 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:37.037200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-04-08 17:37:37.037997) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae --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 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-08 17:37:37,190 truncating revision to first 12 chars 2016-04-08 17:37:37,190 Setting DEBUG logging. 2016-04-08 17:37:37,191 attempt 1/10 2016-04-08 17:37:37,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/705c5fb32d49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 17:37:40,307 unpacking tar archive at: mozilla-central-705c5fb32d49/testing/mozharness/ program finished with exit code 0 elapsedTime=5.187240 ========= master_lag: 4.64 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-04-08 17:37:46.861924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:46.862321) ========= echo 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'705c5fb32d49de2c09b564aa5ff8e8edf1be85ae'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae program finished with exit code 0 elapsedTime=0.004970 script_repo_revision: '705c5fb32d49de2c09b564aa5ff8e8edf1be85ae' ========= master_lag: 0.30 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:47.166764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:47.167571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 17:37:47.738366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-04-08 17:37:47.738784) ========= /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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:37:47 INFO - MultiFileLogger online at 20160408 17:37:47 in /builds/slave/test 17:37:47 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 17:37:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:47 INFO - {'append_to_log': False, 17:37:47 INFO - 'base_work_dir': '/builds/slave/test', 17:37:47 INFO - 'blob_upload_branch': 'Firefox', 17:37:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:47 INFO - 'branch': 'Firefox', 17:37:47 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:47 INFO - 'config_files': ('talos/mac_config.py',), 17:37:47 INFO - 'default_actions': ('clobber', 17:37:47 INFO - 'read-buildbot-config', 17:37:47 INFO - 'download-and-extract', 17:37:47 INFO - 'populate-webroot', 17:37:47 INFO - 'create-virtualenv', 17:37:47 INFO - 'install', 17:37:47 INFO - 'run-tests'), 17:37:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:47 INFO - 'download_minidump_stackwalk': True, 17:37:47 INFO - 'download_symbols': 'ondemand', 17:37:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:47 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:47 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:47 INFO - 'installer_path': 'installer.exe', 17:37:47 INFO - 'log_level': 'info', 17:37:47 INFO - 'log_name': 'talos', 17:37:47 INFO - 'log_to_console': True, 17:37:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:37:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:37:47 INFO - 'opt_config_files': (), 17:37:47 INFO - 'pip_index': False, 17:37:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:47 INFO - 'cmd': ('bash', 17:37:47 INFO - '-c', 17:37:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:47 INFO - 'enabled': True, 17:37:47 INFO - 'halt_on_failure': False, 17:37:47 INFO - 'name': 'check_screen_resolution'},), 17:37:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:47 INFO - 'cmd': ('bash', 17:37:47 INFO - '-c', 17:37:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:47 INFO - 'enabled': True, 17:37:47 INFO - 'halt_on_failure': False, 17:37:47 INFO - 'name': 'check_screen_resolution'},), 17:37:47 INFO - 'run_cmd_checks_enabled': True, 17:37:47 INFO - 'sps_profile': False, 17:37:47 INFO - 'sps_profile_interval': 0, 17:37:47 INFO - 'suite': 'dromaeojs', 17:37:47 INFO - 'system_bits': '32', 17:37:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:47 INFO - 'title': 't-yosemite-r7-0066', 17:37:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:47 INFO - 'use_talos_json': True, 17:37:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:47 INFO - 'work_dir': 'build'} 17:37:47 INFO - ##### 17:37:47 INFO - ##### Running clobber step. 17:37:47 INFO - ##### 17:37:47 INFO - Running pre-action listener: _resource_record_pre_action 17:37:47 INFO - Running main action method: clobber 17:37:47 INFO - rmtree: /builds/slave/test/build 17:37:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:49 INFO - Running post-action listener: _resource_record_post_action 17:37:49 INFO - ##### 17:37:49 INFO - ##### Running read-buildbot-config step. 17:37:49 INFO - ##### 17:37:49 INFO - Running pre-action listener: _resource_record_pre_action 17:37:49 INFO - Running main action method: read_buildbot_config 17:37:49 INFO - Using buildbot properties: 17:37:49 INFO - { 17:37:49 INFO - "project": "", 17:37:49 INFO - "product": "firefox", 17:37:49 INFO - "script_repo_revision": "production", 17:37:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:37:49 INFO - "repository": "", 17:37:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:37:49 INFO - "buildid": "20160408152746", 17:37:49 INFO - "pgo_build": "False", 17:37:49 INFO - "basedir": "/builds/slave/test", 17:37:49 INFO - "buildnumber": 213, 17:37:49 INFO - "slavename": "t-yosemite-r7-0066", 17:37:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:37:49 INFO - "platform": "yosemite_r7", 17:37:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:37:49 INFO - "branch": "mozilla-central", 17:37:49 INFO - "repo_path": "mozilla-central", 17:37:49 INFO - "revision": "705c5fb32d49de2c09b564aa5ff8e8edf1be85ae", 17:37:49 INFO - "stage_platform": "macosx64", 17:37:49 INFO - "builduid": "b62e47a29d5b4f1d93dbc3aa09ba0fe8", 17:37:49 INFO - "slavebuilddir": "test" 17:37:49 INFO - } 17:37:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:37:49 INFO - Running post-action listener: _resource_record_post_action 17:37:49 INFO - ##### 17:37:49 INFO - ##### Running download-and-extract step. 17:37:49 INFO - ##### 17:37:49 INFO - Running pre-action listener: _resource_record_pre_action 17:37:49 INFO - Running main action method: download_and_extract 17:37:49 INFO - mkdir: /builds/slave/test/build/tests 17:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:49 INFO - https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 17:37:51 INFO - Downloaded 1199 bytes. 17:37:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:37:51 INFO - Using the following test package requirements: 17:37:51 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:37:51 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:37:51 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:37:51 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'jsshell-mac.zip'], 17:37:51 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:37:51 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:37:51 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:37:51 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:37:51 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:37:51 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:37:51 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:37:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:51 INFO - https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:37:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:37:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:37:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:37:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:37:53 INFO - Downloaded 18014450 bytes. 17:37:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:37:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:37:56 INFO - Return code: 0 17:37:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:37:56 INFO - https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:37:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:37:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:37:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:37:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:38:09 INFO - Downloaded 18014450 bytes. 17:38: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'] 17:38: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 17:38:12 INFO - Return code: 0 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:12 INFO - https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:38:14 INFO - Downloaded 10841097 bytes. 17:38:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:38:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:38:14 INFO - Return code: 0 17:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:14 INFO - https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 17:38:34 INFO - Downloaded 108759815 bytes. 17:38:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:38:34 INFO - mkdir: /builds/slave/test/properties 17:38:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:34 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:34 INFO - Contents: 17:38:34 INFO - build_url:https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:38:35 INFO - Running post-action listener: _resource_record_post_action 17:38:35 INFO - Running post-action listener: set_extra_try_arguments 17:38:35 INFO - ##### 17:38:35 INFO - ##### Running populate-webroot step. 17:38:35 INFO - ##### 17:38:35 INFO - Running pre-action listener: _resource_record_pre_action 17:38:35 INFO - Running main action method: populate_webroot 17:38:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:35 INFO - '--tppagecycles', 17:38:35 INFO - '7'], 17:38:35 INFO - 'tests': ['tsvgm']}}, 17:38:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['damp', 'tps']}, 17:38:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'tests': ['damp', 'tps']}, 17:38:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['dromaeo_dom']}, 17:38:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['a11yr', 17:38:35 INFO - 'ts_paint', 17:38:35 INFO - 'tpaint', 17:38:35 INFO - 'sessionrestore', 17:38:35 INFO - 'sessionrestore_no_auto_restore', 17:38:35 INFO - 'tabpaint']}, 17:38:35 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:35 INFO - 'ts_paint', 17:38:35 INFO - 'tpaint', 17:38:35 INFO - 'sessionrestore', 17:38:35 INFO - 'sessionrestore_no_auto_restore', 17:38:35 INFO - 'tabpaint']}, 17:38:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:38:35 INFO - 'ts_paint', 17:38:35 INFO - 'tpaint', 17:38:35 INFO - 'sessionrestore', 17:38:35 INFO - 'sessionrestore_no_auto_restore', 17:38:35 INFO - 'tabpaint']}, 17:38:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:38:35 INFO - 'ts_paint', 17:38:35 INFO - 'tpaint', 17:38:35 INFO - 'sessionrestore', 17:38:35 INFO - 'sessionrestore_no_auto_restore', 17:38:35 INFO - 'tabpaint']}, 17:38:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['a11yr', 17:38:35 INFO - 'ts_paint', 17:38:35 INFO - 'tpaint', 17:38:35 INFO - 'sessionrestore', 17:38:35 INFO - 'sessionrestore_no_auto_restore', 17:38:35 INFO - 'tabpaint']}, 17:38:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['a11yr', 17:38:35 INFO - 'ts_paint', 17:38:35 INFO - 'tpaint', 17:38:35 INFO - 'sessionrestore', 17:38:35 INFO - 'sessionrestore_no_auto_restore', 17:38:35 INFO - 'tabpaint']}, 17:38:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['tsvgx', 17:38:35 INFO - 'tsvgr_opacity', 17:38:35 INFO - 'tart', 17:38:35 INFO - 'tscrollx', 17:38:35 INFO - 'cart']}, 17:38:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:35 INFO - 'tsvgr_opacity', 17:38:35 INFO - 'tart', 17:38:35 INFO - 'tscrollx', 17:38:35 INFO - 'cart']}, 17:38:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'talos_options': ['--disable-e10s'], 17:38:35 INFO - 'tests': ['tp5o']}, 17:38:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'tests': ['tp5o']}, 17:38:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'talos_options': ['--disable-e10s', 17:38:35 INFO - '--xperf_path', 17:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:35 INFO - 'tests': ['tp5n']}, 17:38:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:35 INFO - 'talos_options': ['--xperf_path', 17:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:35 INFO - 'tests': ['tp5n']}}, 17:38:35 INFO - 'talos.zip': {'path': '', 17:38:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:35 INFO - Running post-action listener: _resource_record_post_action 17:38:35 INFO - ##### 17:38:35 INFO - ##### Running create-virtualenv step. 17:38:35 INFO - ##### 17:38:35 INFO - Running pre-action listener: _resource_record_pre_action 17:38:35 INFO - Running main action method: create_virtualenv 17:38:35 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:38:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:35 INFO - Using real prefix '/tools/python27' 17:38:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:39 INFO - Installing pip.................done. 17:38:39 INFO - Return code: 0 17:38:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:39 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:38:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:38:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:39 INFO - 'HOME': '/Users/cltbld', 17:38:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:39 INFO - 'LOGNAME': 'cltbld', 17:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:39 INFO - 'MOZ_NO_REMOTE': '1', 17:38:39 INFO - 'NO_EM_RESTART': '1', 17:38:39 INFO - 'PAGER': '/bin/cat', 17:38:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:39 INFO - 'PWD': '/builds/slave/test', 17:38:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:39 INFO - 'SHELL': '/bin/bash', 17:38:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:38:39 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:38:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:39 INFO - 'USER': 'cltbld', 17:38:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:39 INFO - 'XPC_FLAGS': '0x0', 17:38:39 INFO - 'XPC_SERVICE_NAME': '0', 17:38:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:38:39 INFO - Cleaning up... 17:38:39 INFO - Return code: 0 17:38:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:39 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:38:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:38:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:39 INFO - 'HOME': '/Users/cltbld', 17:38:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:39 INFO - 'LOGNAME': 'cltbld', 17:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:39 INFO - 'MOZ_NO_REMOTE': '1', 17:38:39 INFO - 'NO_EM_RESTART': '1', 17:38:39 INFO - 'PAGER': '/bin/cat', 17:38:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:39 INFO - 'PWD': '/builds/slave/test', 17:38:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:39 INFO - 'SHELL': '/bin/bash', 17:38:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:38:39 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:38:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:39 INFO - 'USER': 'cltbld', 17:38:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:39 INFO - 'XPC_FLAGS': '0x0', 17:38:39 INFO - 'XPC_SERVICE_NAME': '0', 17:38:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:39 INFO - Downloading/unpacking psutil>=0.7.1 17:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:46 INFO - Installing collected packages: psutil 17:38:46 INFO - Running setup.py install for psutil 17:38:46 INFO - building 'psutil._psutil_osx' extension 17:38:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:38:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:38:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:38:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:38:46 INFO - building 'psutil._psutil_posix' extension 17:38:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:38:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:38:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:38:46 INFO - ^ 17:38:46 INFO - 1 warning generated. 17:38:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:38:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:47 INFO - Successfully installed psutil 17:38:47 INFO - Cleaning up... 17:38:47 INFO - Return code: 0 17:38:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:47 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:38:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:38:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:47 INFO - 'HOME': '/Users/cltbld', 17:38:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:47 INFO - 'LOGNAME': 'cltbld', 17:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:47 INFO - 'MOZ_NO_REMOTE': '1', 17:38:47 INFO - 'NO_EM_RESTART': '1', 17:38:47 INFO - 'PAGER': '/bin/cat', 17:38:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:47 INFO - 'PWD': '/builds/slave/test', 17:38:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:47 INFO - 'SHELL': '/bin/bash', 17:38:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:38:47 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:38:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:47 INFO - 'USER': 'cltbld', 17:38:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:47 INFO - 'XPC_FLAGS': '0x0', 17:38:47 INFO - 'XPC_SERVICE_NAME': '0', 17:38:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:38:51 INFO - Installing collected packages: mozsystemmonitor 17:38:51 INFO - Running setup.py install for mozsystemmonitor 17:38:52 INFO - Successfully installed mozsystemmonitor 17:38:52 INFO - Cleaning up... 17:38:52 INFO - Return code: 0 17:38:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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')]} 17:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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', '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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:38: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 blobuploader==1.2.4 17:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:52 INFO - 'HOME': '/Users/cltbld', 17:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:52 INFO - 'LOGNAME': 'cltbld', 17:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:52 INFO - 'MOZ_NO_REMOTE': '1', 17:38:52 INFO - 'NO_EM_RESTART': '1', 17:38:52 INFO - 'PAGER': '/bin/cat', 17:38:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:52 INFO - 'PWD': '/builds/slave/test', 17:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:52 INFO - 'SHELL': '/bin/bash', 17:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:38:52 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:52 INFO - 'USER': 'cltbld', 17:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:52 INFO - 'XPC_FLAGS': '0x0', 17:38:52 INFO - 'XPC_SERVICE_NAME': '0', 17:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38: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 17:38:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:57 INFO - Downloading docopt-0.6.1.tar.gz 17:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:57 INFO - Running setup.py install for blobuploader 17:38:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:58 INFO - Running setup.py install for requests 17:38:58 INFO - Running setup.py install for docopt 17:38:58 INFO - Successfully installed blobuploader requests docopt 17:38:58 INFO - Cleaning up... 17:38:58 INFO - Return code: 0 17:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:58 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:58 INFO - 'HOME': '/Users/cltbld', 17:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:58 INFO - 'LOGNAME': 'cltbld', 17:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:58 INFO - 'MOZ_NO_REMOTE': '1', 17:38:58 INFO - 'NO_EM_RESTART': '1', 17:38:58 INFO - 'PAGER': '/bin/cat', 17:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:58 INFO - 'PWD': '/builds/slave/test', 17:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:58 INFO - 'SHELL': '/bin/bash', 17:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:38:58 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:58 INFO - 'USER': 'cltbld', 17:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:58 INFO - 'XPC_FLAGS': '0x0', 17:38:58 INFO - 'XPC_SERVICE_NAME': '0', 17:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-d0ie3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-dZqcrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ocq30q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-zDNETG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Gb4UCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-iDrXkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ch2Pvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PuCBxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-AlopNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-yqT55T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-XDomUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-A6Zrsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-1jVeA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Ke82tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-JvAL9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-HZw00M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:00 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-rVve0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:00 INFO - Running setup.py install for manifestparser 17:39:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:00 INFO - Running setup.py install for mozcrash 17:39:01 INFO - Running setup.py install for mozdebug 17:39:01 INFO - Running setup.py install for mozdevice 17:39:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Running setup.py install for mozfile 17:39:01 INFO - Running setup.py install for mozhttpd 17:39:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Running setup.py install for mozinfo 17:39:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Running setup.py install for mozInstall 17:39:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:01 INFO - Running setup.py install for mozleak 17:39:02 INFO - Running setup.py install for mozlog 17:39:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:02 INFO - Running setup.py install for moznetwork 17:39:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:02 INFO - Running setup.py install for mozprocess 17:39:02 INFO - Running setup.py install for mozprofile 17:39:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:02 INFO - Running setup.py install for mozrunner 17:39:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:02 INFO - Running setup.py install for mozscreenshot 17:39:03 INFO - Running setup.py install for moztest 17:39:03 INFO - Running setup.py install for mozversion 17:39:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:03 INFO - Cleaning up... 17:39:03 INFO - Return code: 0 17:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:03 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:03 INFO - 'HOME': '/Users/cltbld', 17:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:03 INFO - 'LOGNAME': 'cltbld', 17:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:03 INFO - 'MOZ_NO_REMOTE': '1', 17:39:03 INFO - 'NO_EM_RESTART': '1', 17:39:03 INFO - 'PAGER': '/bin/cat', 17:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:03 INFO - 'PWD': '/builds/slave/test', 17:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:03 INFO - 'SHELL': '/bin/bash', 17:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:39:03 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:03 INFO - 'USER': 'cltbld', 17:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:03 INFO - 'XPC_FLAGS': '0x0', 17:39:03 INFO - 'XPC_SERVICE_NAME': '0', 17:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-1axN0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-KX7TiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jddeSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-oov6ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Sgzqdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-54ALQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-l3KWn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-mI_pK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-t2iq_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-QU9Q3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-RC127l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-1AjRCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:04 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-yWuIVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:05 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-4V9vEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:05 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-siiEBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:05 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-0PrFpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:05 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BfQJ9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:09 INFO - Downloading blessings-1.6.tar.gz 17:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:10 INFO - Installing collected packages: blessings 17:39:10 INFO - Running setup.py install for blessings 17:39:10 INFO - Successfully installed blessings 17:39:10 INFO - Cleaning up... 17:39:10 INFO - Return code: 0 17:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:10 INFO - Reading from file tmpfile_stdout 17:39:10 INFO - Current package versions: 17:39:10 INFO - blessings == 1.6 17:39:10 INFO - blobuploader == 1.2.4 17:39:10 INFO - docopt == 0.6.1 17:39:10 INFO - manifestparser == 1.1 17:39:10 INFO - mozInstall == 1.12 17:39:10 INFO - mozcrash == 0.17 17:39:10 INFO - mozdebug == 0.1 17:39:10 INFO - mozdevice == 0.48 17:39:10 INFO - mozfile == 1.2 17:39:10 INFO - mozhttpd == 0.7 17:39:10 INFO - mozinfo == 0.9 17:39:10 INFO - mozleak == 0.1 17:39:10 INFO - mozlog == 3.1 17:39:10 INFO - moznetwork == 0.27 17:39:10 INFO - mozprocess == 0.22 17:39:10 INFO - mozprofile == 0.28 17:39:10 INFO - mozrunner == 6.11 17:39:10 INFO - mozscreenshot == 0.1 17:39:10 INFO - mozsystemmonitor == 0.0 17:39:10 INFO - moztest == 0.7 17:39:10 INFO - mozversion == 1.4 17:39:10 INFO - psutil == 3.1.1 17:39:10 INFO - requests == 1.2.3 17:39:10 INFO - wsgiref == 0.1.2 17:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:10 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:10 INFO - 'HOME': '/Users/cltbld', 17:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:10 INFO - 'LOGNAME': 'cltbld', 17:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:10 INFO - 'MOZ_NO_REMOTE': '1', 17:39:10 INFO - 'NO_EM_RESTART': '1', 17:39:10 INFO - 'PAGER': '/bin/cat', 17:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:10 INFO - 'PWD': '/builds/slave/test', 17:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:10 INFO - 'SHELL': '/bin/bash', 17:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:39:10 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:10 INFO - 'USER': 'cltbld', 17:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:10 INFO - 'XPC_FLAGS': '0x0', 17:39:10 INFO - 'XPC_SERVICE_NAME': '0', 17:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:39:10 INFO - Cleaning up... 17:39:10 INFO - Return code: 0 17:39:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:10 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:10 INFO - 'HOME': '/Users/cltbld', 17:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:10 INFO - 'LOGNAME': 'cltbld', 17:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:10 INFO - 'MOZ_NO_REMOTE': '1', 17:39:10 INFO - 'NO_EM_RESTART': '1', 17:39:10 INFO - 'PAGER': '/bin/cat', 17:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:10 INFO - 'PWD': '/builds/slave/test', 17:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:10 INFO - 'SHELL': '/bin/bash', 17:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:39:10 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:10 INFO - 'USER': 'cltbld', 17:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:10 INFO - 'XPC_FLAGS': '0x0', 17:39:10 INFO - 'XPC_SERVICE_NAME': '0', 17:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:11 INFO - Downloading/unpacking jsonschema 17:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:39:14 INFO - Downloading/unpacking functools32 (from jsonschema) 17:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:39:15 INFO - warning: no files found matching '*.txt' 17:39:15 INFO - no previously-included directories found matching 'build' 17:39:15 INFO - no previously-included directories found matching 'dist' 17:39:15 INFO - no previously-included directories found matching '.git*' 17:39:15 INFO - Installing collected packages: jsonschema, functools32 17:39:15 INFO - Running setup.py install for functools32 17:39:15 INFO - warning: no files found matching '*.txt' 17:39:15 INFO - no previously-included directories found matching 'build' 17:39:15 INFO - no previously-included directories found matching 'dist' 17:39:15 INFO - no previously-included directories found matching '.git*' 17:39:15 INFO - Successfully installed jsonschema functools32 17:39:15 INFO - Cleaning up... 17:39:15 INFO - Return code: 0 17:39:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:15 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 0x10a19aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1aa420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89285a2a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, '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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:39:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:39:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:15 INFO - 'HOME': '/Users/cltbld', 17:39:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:15 INFO - 'LOGNAME': 'cltbld', 17:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:15 INFO - 'MOZ_NO_REMOTE': '1', 17:39:15 INFO - 'NO_EM_RESTART': '1', 17:39:15 INFO - 'PAGER': '/bin/cat', 17:39:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:15 INFO - 'PWD': '/builds/slave/test', 17:39:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:15 INFO - 'SHELL': '/bin/bash', 17:39:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:39:15 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:39:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:15 INFO - 'USER': 'cltbld', 17:39:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:15 INFO - 'XPC_FLAGS': '0x0', 17:39:15 INFO - 'XPC_SERVICE_NAME': '0', 17:39:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:15 INFO - Downloading/unpacking flake8 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:39:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:39:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:22 INFO - no previously-included directories found matching 'docs/_build' 17:39:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:39:22 INFO - Running setup.py install for pep8 17:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:22 INFO - no previously-included directories found matching 'docs/_build' 17:39:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:39:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:39:22 INFO - Cleaning up... 17:39:22 INFO - Return code: 0 17:39:22 INFO - Running post-action listener: _resource_record_post_action 17:39:22 INFO - Running post-action listener: _start_resource_monitoring 17:39:22 INFO - Starting resource monitoring. 17:39:22 INFO - ##### 17:39:22 INFO - ##### Running install step. 17:39:22 INFO - ##### 17:39:22 INFO - Running pre-action listener: _resource_record_pre_action 17:39:22 INFO - Running main action method: install 17:39:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:22 INFO - Reading from file tmpfile_stdout 17:39:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:23 INFO - Reading from file tmpfile_stdout 17:39:23 INFO - Output received: 17:39:23 INFO - Usage: mozinstall [options] installer 17:39:23 INFO - Options: 17:39:23 INFO - -h, --help show this help message and exit 17:39:23 INFO - -d DEST, --destination=DEST 17:39:23 INFO - Directory to install application into. [default: 17:39:23 INFO - "/builds/slave/test"] 17:39:23 INFO - --app=APP Application being installed. [default: firefox] 17:39:23 INFO - mkdir: /builds/slave/test/build/application 17:39:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:39:56 INFO - Reading from file tmpfile_stdout 17:39:56 INFO - Output received: 17:39:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:39:56 INFO - Running post-action listener: _resource_record_post_action 17:39:56 INFO - ##### 17:39:56 INFO - ##### Running run-tests step. 17:39:56 INFO - ##### 17:39:56 INFO - Running pre-action listener: _resource_record_pre_action 17:39:56 INFO - Running main action method: run_tests 17:39:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:56 INFO - 2016-04-08 17:39:56.472 screenresolution[1998:14089] starting screenresolution argv=screenresolution get 17:39:56 INFO - 2016-04-08 17:39:56.474 screenresolution[1998:14089] Display 0: 1600x1200x32@60 17:39:56 INFO - 2016-04-08 17:39:56.481 screenresolution[1999:14091] starting screenresolution argv=screenresolution list 17:39:56 INFO - Available Modes on Display 0 17:39:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:56 INFO - Intel Iris: 17:39:56 INFO - Chipset Model: Intel Iris 17:39:56 INFO - Type: GPU 17:39:56 INFO - Bus: Built-In 17:39:56 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:56 INFO - Vendor: Intel (0x8086) 17:39:56 INFO - Device ID: 0x0a2e 17:39:56 INFO - Revision ID: 0x0009 17:39:56 INFO - Displays: 17:39:56 INFO - Display: 17:39:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:56 INFO - Display Serial Number: 1600x1200 60 17:39:56 INFO - Main Display: Yes 17:39:56 INFO - Mirror: Off 17:39:56 INFO - Online: Yes 17:39:56 INFO - Rotation: Supported 17:39:56 INFO - Return code: 0 17:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:56 INFO - Python 2.7.3 17:39:56 INFO - Return code: 0 17:39:56 INFO - grabbing minidump binary from tooltool 17:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:56 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 0x10a039e00>, '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 0x109e62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a034b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:39:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:39:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:56 INFO - Return code: 0 17:39:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:39:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:39:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:39:58 INFO - Return code: 0 17:39:58 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/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:39:58 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/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:39:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FbKxckMvg8/Render', 17:39:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:58 INFO - 'HOME': '/Users/cltbld', 17:39:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:58 INFO - 'LOGNAME': 'cltbld', 17:39:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:58 INFO - 'MOZ_NO_REMOTE': '1', 17:39:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:58 INFO - 'NO_EM_RESTART': '1', 17:39:58 INFO - 'PAGER': '/bin/cat', 17:39:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:58 INFO - 'PWD': '/builds/slave/test', 17:39:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:58 INFO - 'SHELL': '/bin/bash', 17:39:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HdMX1ax5Dc/Listeners', 17:39:58 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 17:39:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:58 INFO - 'USER': 'cltbld', 17:39:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:58 INFO - 'XPC_FLAGS': '0x0', 17:39:58 INFO - 'XPC_SERVICE_NAME': '0', 17:39:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:58 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/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:39:58 INFO - mozversion application_buildid: 20160408152746 17:39:58 INFO - mozversion application_changeset: 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae 17:39:58 INFO - mozversion application_display_name: Nightly 17:39:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:58 INFO - mozversion application_name: Firefox 17:39:58 INFO - mozversion application_remotingname: firefox 17:39:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:39:58 INFO - mozversion application_vendor: Mozilla 17:39:58 INFO - mozversion application_version: 48.0a1 17:39:58 INFO - mozversion platform_buildid: 20160408152746 17:39:58 INFO - mozversion platform_changeset: 705c5fb32d49de2c09b564aa5ff8e8edf1be85ae 17:39:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:39:58 INFO - mozversion platform_version: 48.0a1 17:39:58 INFO - using testdate: 1460162398 17:39:58 INFO - actual date: 1460162398 17:39:58 INFO - starting webserver on 'localhost:51349' 17:39:58 INFO - SUITE-START | Running 2 tests 17:39:58 INFO - TEST-START | dromaeo_css 17:39:58 INFO - operating with platform_type : mac_ 17:39:58 INFO - Initialising browser for dromaeo_css test... 17:39:58 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpGmXvTO/profile http://localhost:51349/getInfo.html) 17:40:00 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 17:40:00 INFO - PROCESS | 2017 | colorDepth:24 17:40:00 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 17:40:00 INFO - PROCESS | 2017 | __metrics 17:40:00 INFO - PROCESS | 2017 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:40:00 ERROR - PROCESS | 2017 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:40:01 INFO - TEST-INFO | 2017: exit 0 17:40:01 INFO - Browser initialized. 17:40:01 INFO - Running cycle 1/1 for dromaeo_css test... 17:40:01 INFO - TEST-INFO | started process 2019 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpGmXvTO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:13 INFO - PROCESS | 2019 | RSS: Main: 237604864 17:40:13 INFO - PROCESS | 2019 | 17:41:04 INFO - PROCESS | 2019 | 1460162464397 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:43:14 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51349/tests/dromaeo/cssquery-ext.html) 17:43:15 INFO - PROCESS | 2019 | RSS: Main: 326963200 17:43:15 INFO - PROCESS | 2019 | 17:46:18 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-ext.html (next: http://localhost:51349/tests/dromaeo/cssquery-jquery.html) 17:46:18 INFO - PROCESS | 2019 | RSS: Main: 375439360 17:46:18 INFO - PROCESS | 2019 | 17:49:20 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51349/tests/dromaeo/cssquery-mootools.html) 17:49:21 INFO - PROCESS | 2019 | RSS: Main: 381079552 17:49:21 INFO - PROCESS | 2019 | 17:52:23 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51349/tests/dromaeo/cssquery-prototype.html) 17:52:24 INFO - PROCESS | 2019 | RSS: Main: 334589952 17:52:24 INFO - PROCESS | 2019 | 17:55:27 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51349/tests/dromaeo/cssquery-yui.html) 17:55:27 INFO - PROCESS | 2019 | RSS: Main: 337399808 17:55:27 INFO - PROCESS | 2019 | 17:58:30 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-yui.html (next: http://localhost:51349/tests/dromaeo/cssquery-dojo.html) 17:58:31 INFO - PROCESS | 2019 | RSS: Main: 411873280 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | __start_tp_report 17:58:31 INFO - PROCESS | 2019 | _x_x_mozilla_page_load 17:58:31 INFO - PROCESS | 2019 | _x_x_mozilla_page_load_details 17:58:31 INFO - PROCESS | 2019 | |i|pagename|runs| 17:58:31 INFO - PROCESS | 2019 | |0;dojo.html;2874.2526942994823;3340.4989251612255;3368.326334733053;3372.460406334987;3397.2356219850535;5412.756425960832;5515.117581187011;5520.144377621465;5529.944700552994;5540.750666220019;5420.295361602996;5512.80705175318;5518.889622207554;5528.861778455541;5529.944700552994;4974.577160941315;5007;5010.123228435027;5069.9493005070035;5082.822101226458;5011.423686276088;5065.797368105272;5082.898342033157;5085.160948443502;5086.389633244016;5043.974780126113;5080.466551012146;5110.8466745997675;5111.386633603955;5165.560927321163;5087.923681144767;5114.386273647149;5126.5642420394315;5136.614753893473;5164.406093299281;4923.286123512071;4945.307656928033;5047.192449208146;5052.747362631891;5074.771635276422;5394.163904594794;5431.266778984826;5452.754626041838;5484.149956756709;5534.944650553483;6063.242094738158;6077.118817771443;6079.969600151971;6090.512758979316;6117.418845209698;5869.589128760988;5982;6115.179495343464;6121.908171377433;6122.020476723747;5625.493705566437;5651.858703532444;5660.915086273709;5675.063614503602;5679.204911312419;6160.815175544741;6202.658853763086;6235.438810507076;6236.968815155895;6247.3440288769025;5761;5909.054551271776;5990.161377407167;6007.279126504847;6034.879302413927;6103.511719062464;6103.6032657877095;6111.663858487826;6117.510599152146;6118.847028824315;6002.6098303611;6031.185789918392;6045;6045.848853778691;6046.5767396281835;5864.736086876101;6034.547408944347;6104.156010547632;6113.719560719409;6134.436587033474;4798.832040878552;4803.1114243864995;4812.51874812523;4828.275758636232;4860.4896485869185;4185.393117997874;4315.482142142901;4315.892102697395;4326.697131200849;4379.5182529921685;5456.454354564591;5483.040467918098;5527.585431092684;5598.86002849932;5613.045782217033;6103.023516237381;6105.877882442415;6110.725017374229;6117.143599896018;6135.355787642323;5407.810726624628;5495;5542.418046105101;5551.2228288039705;5561.694106824082;5201.895962080813;5239.371275446971;5333.573314134937;5345.919811202835;5358;6235.688215589203;6248.062790581449;6248.31268560458;6250.968745156245;6255.749770009331;6135;6140.478059364826;6146.108814222002;6160.507159427146;6162.7534898605345;5207.192885102815;6112.716259964451;6168.0439531872635;6199.969000155151;6245.5628106033955;6011.458968692838;6030.125631783455;6035.668038257938;6038;6068.939310606837;6045.486133678511;6108.51131909455;6140.508759299335;6149.077638354103;6152.107944348134;5118.795248190031;5727.11229759388;5838.708064596838;5970.731317090655;6025.728842202199;5920.4671579556325;5931.7627294907725;5941.613795103477;5944.464998150187;5947.9405205949115;5616.943830561642;5745.8563535911935;5801.071828507418;5803.564732644984;5817.272840894888;4847.345608342828;5984.581079324405;5987.101934709828;6000.51995840323;6020.819375418744;5772.134179873053;5783.537317014713;5793.073108302651;5803.7678492861505;5847.678377689268 17:58:31 INFO - PROCESS | 2019 | |1;ext.html;485.4417419967035;488.29441457094515;498.91269027920106;504.4148787406609;518.1010946008674;28987.420251594955;29523.11430657081;36475.81762091193;37642.24715505688;37686.811565942204;41938.790306048504;42715.786421067925;42759.35860962088;42788.35817462741;42927.92680182997;9381.859272110923;9638.277129215301;9639.325247232697;9641.75895602612;9656.420614763138;9464.81070378592;9631.181349585293;9634.75913102171;9638.855417168748;9641.855372169422;9615.086566776145;9676.467794271312;9681;9692.854607180898;9697.07877751616;8131.878021829677;9645.588602849288;9656.951715241448;9665.806683866283;9672.56473458696;7724.961375193145;8755;8765.693200738007;9438.339316247866;9491.335606507548;33880.49179262313;38705.64530241428;38891.44434222628;39425.21149576992;39454.802725986185;3318.4026875162463;3331.6335203127637;3336.432806422914;3435.3301106284284;3714.147879583621;27054.32364190891;28024;28376.574351384745;28474.430511389655;28554.71445285562;2728.836269823817;2731.153342463823;2751.269186678369;2755.655543057118;2816.2959260184953;448118.75940620416;451455;451974;452914;453110;34864;35598.46602300968;35698.643013569534;57861;57905;34601.82699086539;34676.65323346785;34815.82592087074;34887;34891;14566;14751.262436878113;14760.188189649672;14765.187914664797;14770.26148692561;10324.638637647646;12440.81338779919;12493.812592811115;12509.624711258495;12536.686582835502;7962.562059086806;7999.920000800034;8031.598420078973;8060;8076.192380761877;3284.8521816518314;3317.867285308609;3322.0532148337606;3323.916902077419;3354.2452948086484;931.8741969833985;988.5008070924281;1004.2919741582167;1034.8344264917578;1176.4764679717443;28730.569041464394;29065.854670726934;29109.272268193043;29270.414591708046;29558.556621650692;1085.7285678580356;1089.5478376473834;1101.7851518953887;1131.7170707323169;1156.410230782307;14828.184449855145;14856.925715371353;14917.552473425598;15319.693606128038;15415.46045888411;618246;730528;743722;745605;747896;54870.17694734582;55466.72266638641;55851;55964.720176398856;55981.720091399286;1191.3030876936916;1275.005495713345;1438.7266419380285;1458.8614081662438;1568.858802707739;28269.71730282671;28821.135365939055;29065;29520.671569779843;29573.852130739207;50510.74744626253;51501;51512.48487515077;51599.71000724862;51802.70493237548;457544;474407;474521;474770;475032.2496774988;22850.428739280986;25760.484790303715;25951.351216219744;26162.084327048462;26525.469490610467;39963.00369962981;40253.39619905762;41675.95810104772;41880;41996.58003420049;32866;34428.48357274593;34940.65059349374;35149.47275790916;35522.28955420929;33433.66566334403;33854.492182617774;33976.490352645225;34605.82697086498;34628.30743385169;28259.57610635801;34321;34496.48255276123;35107.824460877535;35197.120071998404;28460.57309140406;28816.71183288224;30241.09276721702;30414.032508777098;30564.235894102825;22456.88771556197;22665.333666583356;22687.77265362084;23289.883550582137;23606.173783917482 17:58:31 INFO - PROCESS | 2019 | |2;jquery.html;356.69146188546904;396.9761814291142;397.59643961379226;401.56502358826316;405.7382987972758;19520.31678891239;20320.780753154802;20434.386968390954;20512.794872051276;21351.893240533813;20410.89794551029;20562.588748225066;21129.788702112975;21144;21192.576148477023;5778.24882765241;6068.908966365508;6070.301915279733;6074.422929821682;6075.149479072933;5745.482906538411;5886.941130588703;5998.6400815950965;6012.819615411545;6013.248343957005;5791.594588378815;5914.704264786765;5914.9408505915035;5945.227120474332;5954.434328738763;5901.645901245939;5930.7924222652;5930.822075337746;7212.675429605681;7696.268854458817;7136.2506936771415;7431.591262480561;7448.068991376078;7449.925500745032;7456.701731930716;22319.99560019803;28039.719602803914;28539.85730071357;28943.855280723674;29007;2065.6901464780403;2157.482204270964;2257.796798288162;2276.829237807171;3003.189138932476;13574.710402511746;15300.923495382563;15659.686806263811;15855.92072039644;16287.429939952044;1840.530664680498;1840.723891416285;1873.4473330367575;1900.3918746001284;1981.8909959952198;112246;113753.4312328433;116396;117009.41495292554;117815.4109229457;16980.575485612957;20368.287109951376;20821.835632873484;20865;21014.369568912956;35327;35384.46923296153;35384.64615353814;35447.4682879757;35488.29023419517;9825.705228843146;10211.387316761018;10240.948795255976;10251.436171010517;10418.218633602359;7099.964500177466;7959.681612735426;8230.21812927771;8250.21487537227;8320.209580089882;9367.62529498826;9409.623615055458;9545.425004874118;9549.331546791796;9602.375845570155;3718.665320121202;3736.5702944161226;3761.9435708464393;3765.5669597996034;3775.0169775895556;863.4085651328734;909.9863502047475;936.541094863512;939.3565407695751;1000.2398177385239;19449.4165175045;20050.498737531678;20141.295054673017;20240.797592024184;20578.897105514377;957.4590356448584;960.351762560269;976.9560369783377;997.4115271989416;1075.47839297942;10112.646057387956;10392.116670083127;10429.478526073666;10472.266941314036;10492.861626134561;621731.261499079;622691;627540;660411;660506;120256;127637;128615;131235;135464;992.8532544910496;1002.3534820041178;1010.6210171185805;1026.3790406803926;1030.5053574284386;14233.217173055582;14706.705865882837;17147.314107435563;17689.646207076043;17889.73165402494;47756.52243477521;47813.28280075871;48778.512214877395;49005;49127.99999999857;69636;70812;71096;72423;73406.22859514115;7900.881486777588;8038.11580726108;8131.186881311822;8267.958660206901;8451.112633173429;10224.98564187092;12122.030237580795;12125.636230913087;12205.084618653815;12342.44458999365;10344.896551034695;10492.895071049497;10656.520456579628;10755.516001779783;10761.46192690378;9487.857682134636;9746.561404736662;10288.331258468175;10300.896991030293;10684.626038088629;10427.68716938493;10636.734081648021;10861.837072444077;10931.070858976758;11189.160812938899;7296.124465064227;7517.774466766005;8019.077806052145;8154.877676834733;8372;9734.951325243328;10671.893281067401;10982.670519884416;10993.670189894316;10997.34015959045 17:58:31 INFO - PROCESS | 2019 | |3;mootools.html;1390.6106290238736;1390.6175801654545;1576.5506830553293;1722.7071397862362;1961.1076959983218;7512.887306690397;7628.931949527064;8731.476111433303;8751.868721969175;8757.781055473617;8395.748127556168;8602.182792634705;8604.182602652754;8612.354073444485;8626.568671566429;2137.10241698487;2386.868722220277;2439.5608790417764;2470.3824043989002;2472.2830379190013;2479.7148327942245;2501.374656335916;2504.9248522544353;2506.9247922562354;2513.0324824942345;2416.7462416446283;2468.90124395024;2476.8018558515278;2479.665245191903;2481.4788894332214;2067.183462532299;2425.696787901521;2436.8294219404647;2456.6437866509436;2461.2739241923678;2429.6355546667965;2448.375664205634;2456.7666071723156;2460.3480077779404;2463.1255904154127;8605.526696031715;8682.30541556674;8689.131086891324;8699.478031318142;8705;5208.765605547722;5389.245505629215;5392.892142157135;5404.567634589223;5416.052190866582;3226.370857682753;3256.6580509046444;3355.6141043780035;3435.4675025371107;3462.3594634992355;845.382870504529;939.1125386509751;952.6951375559754;954.2413781044087;982.6609819612222;11102.722431939186;11197.272177308449;11197.552097916074;11201.271917325348;11211.215214935039;4681.368015317957;4846.273059041101;4925.064237794808;4963.528464795839;5014.423341315795;9820.607175713034;9879.06148915852;9891.010898910052;9893.15908147801;9900.950495247622;5401.891962160814;5409;5427.267318911975;5433.782648694008;5440.966216418868;4379.956200438019;4552.0668263006;4768.61851051915;4871.244957031666;4890.682105663192;3912.667423268997;3970.1265721541213;4010.6791456683977;4055.3105971984833;4088.9386659200136;1334.9532766353325;1356.5658989123385;1361.6868120332379;1368.637311112556;1372.8695773901463;1172.1384782185087;1318.103689491136;1356.3557310277736;1364.208758919824;1373.6359864635879;7955;7989.360851131895;8011.1588283230585;8022.839543209103;8047.476914000571;507.36832643359253;513.7431284357821;522.4148953172471;524.2346174585149;526.7471613625481;6149.446549810538;6212.192414986023;6351.269603995507;6362.9045564316575;6367.363263673688;10083.394996300245;10439.217058720626;10471.371717696962;10561.63034293796;10567.471626418803;9034.14175653312;9848.113669769755;10045.497725113715;10412.167026637851;10420;7769.961150194326;7930.286274235231;7945.841083178304;8010.239027292398;8043.276105150565;7760.68957241704;8081.515109093473;8083.949086618702;8089.069756978023;8100.554469504234;9479.194268487256;9494.95252523733;9500.619975200914;9615.56729947168;9673.854892176763;9734.513274336396;9779.462129582942;10022.799544009225;10027.197824174194;10167.186625070124;6494.6103233806125;6749.190097188369;6954.3393377629045;7384.667689953858;7547.433942454228;8102.4328297021;8200.343972482306;8200.835983280182;8207.261346478846;8208.958955205186;7128.6792094356915;7208.243134471015;7228.710851565878;7327.450441217036;7388.298111679382;7099.43204543625;7106.857862842611;7144.249853765487;7228.89156662661;7290.270972902667;7461.067366579177;7604.315611594983;7652.61736913141;7658.770236892902;7659.731909383145;6899.241083480913;6962.7911162665205;6966.825829354307;6968.198657154492;6984.860302794017;5872.412758724094;7015.6842942066705;7040.542364746275;7058.5764854106865;7076.433885289268 17:58:31 INFO - PROCESS | 2019 | |4;prototype.html;304.8932873494277;320.2633941933552;325.5734987166811;330.4448526475522;332.2839281348694;5171.560417364529;5408.378036525796;5903.664429597275;5933.732982015809;5939.940600594004;5783.2481777368985;5798.681072541009;5825.854353641161;5839.883202335951;5846.678432686201;3582.480540321652;3870.8838734838;3915.4533959086143;4299.742015479065;4351.26028575143;3581.982090089546;4347.3261644445165;4380.934285985712;4386.078923426085;4390.473143222818;4135.834566617332;4369.366441865944;4382.5398333175035;4403.634873189306;4416.160929423415;4152.131540806634;4200.836569166881;4404.801783919731;4432.689711720181;4455.242608756519;3783.451399547078;3794.677452416548;3798.810059497014;3811.904702382463;3819.2743378757946;5549.528290095347;5564.86087847803;5608.383077861432;5615.017371959891;5640.492355687967;3949.4273330366937;4727.22000869856;5035.949640503584;5049.343585333883;5112.006317536164;5085.898282034339;6126.663033533154;6138.048602466625;6169.29053158888;6183.381661833826;3600.387934051191;4118.961114248466;4128.566500517462;4135.193637240739;4137.97931010343;5278.868028299285;5939.67331796751;6112.196901913946;6398.752243312556;6504.154459920227;4098.52866920302;4099.200655872076;4110.917781644351;4111.568285330057;4123.9175216495505;3465.636108208602;4165.083681590046;4305.268104422193;4308.095299986975;4319.373690814814;4754.477007529169;5033.79864805411;5039.622028347889;5056.292119103328;5067;6197.25632924052;6264.436200741864;6264.686765661699;6280.7487700491465;6285.371462853769;1159.6984783956232;1471.4555614422732;1471.5732437593192;1471.6026672798284;1478.77079052747;925.2921515040999;951.6811868024151;966.6278482784179;978.5058545434653;978.5107446276861;5151.072806894795;5735.799247026334;5779;5793.913091303634;5816.47651711348;6189.102580125857;6397.392247736458;6426.967865160645;6448.451881590024;6467.482601391877;5497.230387745719;5786.826395208151;5838.970805146032;5843.766249349978;5853.268341457318;2819.0407666671467;2939.720726530976;3357.1942733743726;3391.796492210475;3417.8803741868915;6448.9355106449275;6765.729370825112;6767.492438067066;6791.966040169767;6889.827754306082;5582.358028826737;5969.701514924236;6714.261431242559;6751.662416879235;6761.357671021246;6504.7718982661645;6813.150569927975;6813.2846051163915;6839.965800170868;6841.555298905555;6472.805815825533;6491.48068154537;6499.870002600016;6519.869602608016;6552.6068435894;5285.62147033844;6378.553501255054;6394.1687580614225;6411.358864113551;6419.6790160490855;6127.632342059491;6383.457406120346;6648.9002664961035;6764.526483146133;6782.28785977485;3494;3707.3326801174967;4190.790460477025;4247.214265360918;4258.254805409103;6129.601575897553;6497.122888410004;6507.219133703986;6521.706523206372;6535.052417399545;5227.712475813867;6274.839154756384;6277.466415354746;6287.245530536365;6304.684765761602;6247.562670613195;6273.215848018997;6285.622862628257;6294.8111556653375;6311.368863113652;5137.559659161868;5702.97346477638;5833.562482813721;5924.318703348998;6155;5440;6274.215723034621;6279.246490421178;6316.684165791784;6320.178376810985;5867.501262392744;6142.832861756252;6164.568480206342;6179.5056395489155;6224.533160012927 17:58:31 INFO - PROCESS | 2019 | |5;yui.html;586.7183751799137;622.6730966242721;635.9618422894627;654.708654648681;726.415235735233;12529;12650.367481625904;15006.699866002687;15539.844601553996;15546.766798498018;15504.069755814658;16217;16228.269727862245;16234.51296461108;16279.755803662954;723.1033518437126;741.2032065529551;754.5057987018512;904.9185573298402;932.3986029011284;766.6205228411944;909.2771246858763;934.2619330728717;934.3179478980314;934.6261495401826;974.8440249560072;980.3333733061515;982.4694664880956;983.6311383231289;985.8816941966974;751.3538357012965;770.857391382596;771.6141929035482;973.3964941736134;975.9853602195973;567.6480582039121;704.6723273677713;724.022569531134;730.5397599512273;730.8099894027538;15528.378864845392;15598.844011559966;15617.98483098595;15647.295871685801;15679.764803527956;12135.393230338535;12172.634820955385;12204.877951220464;12409.317487538181;12493.18794278369;9855.753606159831;9977.201823854075;10024.54889529973;10410.843837342445;10645.254832161752;3448.2413868948793;3465.861365545375;3560.6439356064448;3564.1446052947367;3576.588692300367;73793;76114;78922.60538697327;79057.99999999942;79365.60317198434;9122.680706175252;9182.954085229665;9281.396709214014;9318.813623727487;9600.471974041495;20920.895395522926;20930.581388372146;21007.369778906657;21031.894840526005;21060.684089738665;7272.309130632581;7272.854542909112;7332.5967071811565;7400.148982866932;7449.106107267163;3679.5768486623847;3923.862664806718;3936.9212615747524;3938.0548668319398;3997.9005773412546;3376.7129793967297;3492.1269682579355;3494.965050349515;3502.176988407722;3506.6668666476644;572.9885402291931;611.9388061193845;641.4836056974087;642.24215425798;649.5518092516148;523.3275241314892;557.3479029535454;563.6477201748907;588.2294194605081;589.9616524925866;7880.369570434352;7944.642491087915;7983.321417679563;8084;8129.3090087343235;527.0302643136647;559.9524040456607;570.2131059138362;573.9684317362585;586.906095024794;3183.9204019899225;3799.8290076946605;3821.636944490269;3846.8461261549223;4019.537753158366;82387.7641835361;91338.54330728303;92851;93668;93952.53023734837;69973.65013175004;74550;74806.5038699223;75250;78087.60956195183;64264;67875.66062169657;68344;69441;69626.9555956661;7503.7748867534065;7521.135069467081;7717;7725.961370193113;7911.723089691834;42633.36049959191;44173;44189.77905110583;45265.32102018406;45362.092758145314;60854.39145608487;62563.68718156562;62565.06152407808;62805;62940.685296573225;9741.561629726537;9850.802983940424;9859.950700246452;9895.851562226428;10206.877243503357;9733.637290779438;9896.257780666334;10420.739481512719;11174.776504469703;11616.535338586362;10164.898351016394;10426.27016108865;10459.424731639832;10461.843072353768;10651.414172220293;10262.640807571997;10353.9482302588;10357;10794.406307653155;11338.263012904135;10104.797904042025;10176.491175441346;10204.642837500653;10334.948325258325;10855.185861060294;8791.164839340252;8875.050602482092;8946.597403117006;8967.686130985385;9727.80544389094;7219;7396.482246242711;8820.470771753715;8930.106989301017;8972.28221742272 17:58:31 INFO - PROCESS | 2019 | __end_tp_report 17:58:31 INFO - PROCESS | 2019 | __start_cc_report 17:58:31 INFO - PROCESS | 2019 | _x_x_mozilla_cycle_collect,1076 17:58:31 INFO - PROCESS | 2019 | __end_cc_report 17:58:31 INFO - PROCESS | 2019 | __startTimestamp1460163511120__endTimestamp 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | ------- Summary: start ------- 17:58:31 INFO - PROCESS | 2019 | Number of tests: 6 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | [#0] dojo.html Cycles:165 Average:5585.70 Median:5772.13 stddev:636.00 (11.0%) stddev-sans-first:601.33 17:58:31 INFO - PROCESS | 2019 | Values: 2874.3 3340.5 3368.3 3372.5 3397.2 5412.8 5515.1 5520.1 5529.9 5540.8 5420.3 5512.8 5518.9 5528.9 5529.9 4974.6 5007.0 5010.1 5069.9 5082.8 5011.4 5065.8 5082.9 5085.2 5086.4 5044.0 5080.5 5110.8 5111.4 5165.6 5087.9 5114.4 5126.6 5136.6 5164.4 4923.3 4945.3 5047.2 5052.7 5074.8 5394.2 5431.3 5452.8 5484.1 5534.9 6063.2 6077.1 6080.0 6090.5 6117.4 5869.6 5982.0 6115.2 6121.9 6122.0 5625.5 5651.9 5660.9 5675.1 5679.2 6160.8 6202.7 6235.4 6237.0 6247.3 5761.0 5909.1 5990.2 6007.3 6034.9 6103.5 6103.6 6111.7 6117.5 6118.8 6002.6 6031.2 6045.0 6045.8 6046.6 5864.7 6034.5 6104.2 6113.7 6134.4 4798.8 4803.1 4812.5 4828.3 4860.5 4185.4 4315.5 4315.9 4326.7 4379.5 5456.5 5483.0 5527.6 5598.9 5613.0 6103.0 6105.9 6110.7 6117.1 6135.4 5407.8 5495.0 5542.4 5551.2 5561.7 5201.9 5239.4 5333.6 5345.9 5358.0 6235.7 6248.1 6248.3 6251.0 6255.7 6135.0 6140.5 6146.1 6160.5 6162.8 5207.2 6112.7 6168.0 6200.0 6245.6 6011.5 6030.1 6035.7 6038.0 6068.9 6045.5 6108.5 6140.5 6149.1 6152.1 5118.8 5727.1 5838.7 5970.7 6025.7 5920.5 5931.8 5941.6 5944.5 5947.9 5616.9 5745.9 5801.1 5803.6 5817.3 4847.3 5984.6 5987.1 6000.5 6020.8 5772.1 5783.5 5793.1 5803.8 5847.7 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | [#1] ext.html Cycles:180 Average:65529.46 Median:34915.83 stddev:150660.42 (431.5%) stddev-sans-first:151003.91 17:58:31 INFO - PROCESS | 2019 | Values: 485.4 488.3 498.9 504.4 518.1 28987.4 29523.1 36475.8 37642.2 37686.8 41938.8 42715.8 42759.4 42788.4 42927.9 9381.9 9638.3 9639.3 9641.8 9656.4 9464.8 9631.2 9634.8 9638.9 9641.9 9615.1 9676.5 9681.0 9692.9 9697.1 8131.9 9645.6 9657.0 9665.8 9672.6 7725.0 8755.0 8765.7 9438.3 9491.3 33880.5 38705.6 38891.4 39425.2 39454.8 3318.4 3331.6 3336.4 3435.3 3714.1 27054.3 28024.0 28376.6 28474.4 28554.7 2728.8 2731.2 2751.3 2755.7 2816.3 448118.8 451455.0 451974.0 452914.0 453110.0 34864.0 35598.5 35698.6 57861.0 57905.0 34601.8 34676.7 34815.8 34887.0 34891.0 14566.0 14751.3 14760.2 14765.2 14770.3 10324.6 12440.8 12493.8 12509.6 12536.7 7962.6 7999.9 8031.6 8060.0 8076.2 3284.9 3317.9 3322.1 3323.9 3354.2 931.9 988.5 1004.3 1034.8 1176.5 28730.6 29065.9 29109.3 29270.4 29558.6 1085.7 1089.5 1101.8 1131.7 1156.4 14828.2 14856.9 14917.6 15319.7 15415.5 618246.0 730528.0 743722.0 745605.0 747896.0 54870.2 55466.7 55851.0 55964.7 55981.7 1191.3 1275.0 1438.7 1458.9 1568.9 28269.7 28821.1 29065.0 29520.7 29573.9 50510.7 51501.0 51512.5 51599.7 51802.7 457544.0 474407.0 474521.0 474770.0 475032.2 22850.4 25760.5 25951.4 26162.1 26525.5 39963.0 40253.4 41676.0 41880.0 41996.6 32866.0 34428.5 34940.7 35149.5 35522.3 33433.7 33854.5 33976.5 34605.8 34628.3 28259.6 34321.0 34496.5 35107.8 35197.1 28460.6 28816.7 30241.1 30414.0 30564.2 22456.9 22665.3 22687.8 23289.9 23606.2 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | [#2] jquery.html Cycles:180 Average:36934.51 Median:16005.09 stddev:105946.90 (662.0%) stddev-sans-first:106208.51 17:58:31 INFO - PROCESS | 2019 | Values: 356.7 397.0 397.6 401.6 405.7 19520.3 20320.8 20434.4 20512.8 21351.9 20410.9 20562.6 21129.8 21144.0 21192.6 5778.2 6068.9 6070.3 6074.4 6075.1 5745.5 5886.9 5998.6 6012.8 6013.2 5791.6 5914.7 5914.9 5945.2 5954.4 5901.6 5930.8 5930.8 7212.7 7696.3 7136.3 7431.6 7448.1 7449.9 7456.7 22320.0 28039.7 28539.9 28943.9 29007.0 2065.7 2157.5 2257.8 2276.8 3003.2 13574.7 15300.9 15659.7 15855.9 16287.4 1840.5 1840.7 1873.4 1900.4 1981.9 112246.0 113753.4 116396.0 117009.4 117815.4 16980.6 20368.3 20821.8 20865.0 21014.4 35327.0 35384.5 35384.6 35447.5 35488.3 9825.7 10211.4 10240.9 10251.4 10418.2 7100.0 7959.7 8230.2 8250.2 8320.2 9367.6 9409.6 9545.4 9549.3 9602.4 3718.7 3736.6 3761.9 3765.6 3775.0 863.4 910.0 936.5 939.4 1000.2 19449.4 20050.5 20141.3 20240.8 20578.9 957.5 960.4 977.0 997.4 1075.5 10112.6 10392.1 10429.5 10472.3 10492.9 621731.3 622691.0 627540.0 660411.0 660506.0 120256.0 127637.0 128615.0 131235.0 135464.0 992.9 1002.4 1010.6 1026.4 1030.5 14233.2 14706.7 17147.3 17689.6 17889.7 47756.5 47813.3 48778.5 49005.0 49128.0 69636.0 70812.0 71096.0 72423.0 73406.2 7900.9 8038.1 8131.2 8268.0 8451.1 10225.0 12122.0 12125.6 12205.1 12342.4 10344.9 10492.9 10656.5 10755.5 10761.5 9487.9 9746.6 10288.3 10300.9 10684.6 10427.7 10636.7 10861.8 10931.1 11189.2 7296.1 7517.8 8019.1 8154.9 8372.0 9735.0 10671.9 10982.7 10993.7 10997.3 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | [#3] mootools.html Cycles:180 Average:5926.49 Median:5656.69 stddev:3113.07 (55.0%) stddev-sans-first:3103.13 17:58:31 INFO - PROCESS | 2019 | Values: 1390.6 1390.6 1576.6 1722.7 1961.1 7512.9 7628.9 8731.5 8751.9 8757.8 8395.7 8602.2 8604.2 8612.4 8626.6 2137.1 2386.9 2439.6 2470.4 2472.3 2479.7 2501.4 2504.9 2506.9 2513.0 2416.7 2468.9 2476.8 2479.7 2481.5 2067.2 2425.7 2436.8 2456.6 2461.3 2429.6 2448.4 2456.8 2460.3 2463.1 8605.5 8682.3 8689.1 8699.5 8705.0 5208.8 5389.2 5392.9 5404.6 5416.1 3226.4 3256.7 3355.6 3435.5 3462.4 845.4 939.1 952.7 954.2 982.7 11102.7 11197.3 11197.6 11201.3 11211.2 4681.4 4846.3 4925.1 4963.5 5014.4 9820.6 9879.1 9891.0 9893.2 9901.0 5401.9 5409.0 5427.3 5433.8 5441.0 4380.0 4552.1 4768.6 4871.2 4890.7 3912.7 3970.1 4010.7 4055.3 4088.9 1335.0 1356.6 1361.7 1368.6 1372.9 1172.1 1318.1 1356.4 1364.2 1373.6 7955.0 7989.4 8011.2 8022.8 8047.5 507.4 513.7 522.4 524.2 526.7 6149.4 6212.2 6351.3 6362.9 6367.4 10083.4 10439.2 10471.4 10561.6 10567.5 9034.1 9848.1 10045.5 10412.2 10420.0 7770.0 7930.3 7945.8 8010.2 8043.3 7760.7 8081.5 8083.9 8089.1 8100.6 9479.2 9495.0 9500.6 9615.6 9673.9 9734.5 9779.5 10022.8 10027.2 10167.2 6494.6 6749.2 6954.3 7384.7 7547.4 8102.4 8200.3 8200.8 8207.3 8209.0 7128.7 7208.2 7228.7 7327.5 7388.3 7099.4 7106.9 7144.2 7228.9 7290.3 7461.1 7604.3 7652.6 7658.8 7659.7 6899.2 6962.8 6966.8 6968.2 6984.9 5872.4 7015.7 7040.5 7058.6 7076.4 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | [#4] prototype.html Cycles:180 Average:5043.47 Median:5790.37 stddev:1621.00 (28.0%) stddev-sans-first:1586.05 17:58:31 INFO - PROCESS | 2019 | Values: 304.9 320.3 325.6 330.4 332.3 5171.6 5408.4 5903.7 5933.7 5939.9 5783.2 5798.7 5825.9 5839.9 5846.7 3582.5 3870.9 3915.5 4299.7 4351.3 3582.0 4347.3 4380.9 4386.1 4390.5 4135.8 4369.4 4382.5 4403.6 4416.2 4152.1 4200.8 4404.8 4432.7 4455.2 3783.5 3794.7 3798.8 3811.9 3819.3 5549.5 5564.9 5608.4 5615.0 5640.5 3949.4 4727.2 5035.9 5049.3 5112.0 5085.9 6126.7 6138.0 6169.3 6183.4 3600.4 4119.0 4128.6 4135.2 4138.0 5278.9 5939.7 6112.2 6398.8 6504.2 4098.5 4099.2 4110.9 4111.6 4123.9 3465.6 4165.1 4305.3 4308.1 4319.4 4754.5 5033.8 5039.6 5056.3 5067.0 6197.3 6264.4 6264.7 6280.7 6285.4 1159.7 1471.5 1471.6 1471.6 1478.8 925.3 951.7 966.6 978.5 978.5 5151.1 5735.8 5779.0 5793.9 5816.5 6189.1 6397.4 6427.0 6448.5 6467.5 5497.2 5786.8 5839.0 5843.8 5853.3 2819.0 2939.7 3357.2 3391.8 3417.9 6448.9 6765.7 6767.5 6792.0 6889.8 5582.4 5969.7 6714.3 6751.7 6761.4 6504.8 6813.2 6813.3 6840.0 6841.6 6472.8 6491.5 6499.9 6519.9 6552.6 5285.6 6378.6 6394.2 6411.4 6419.7 6127.6 6383.5 6648.9 6764.5 6782.3 3494.0 3707.3 4190.8 4247.2 4258.3 6129.6 6497.1 6507.2 6521.7 6535.1 5227.7 6274.8 6277.5 6287.2 6304.7 6247.6 6273.2 6285.6 6294.8 6311.4 5137.6 5703.0 5833.6 5924.3 6155.0 5440.0 6274.2 6279.2 6316.7 6320.2 5867.5 6142.8 6164.6 6179.5 6224.5 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - PROCESS | 2019 | [#5] yui.html Cycles:180 Average:17488.89 Median:62872.84 stddev:24625.47 (39.2%) stddev-sans-first:24661.84 17:58:31 INFO - PROCESS | 2019 | Values: 586.7 622.7 636.0 654.7 726.4 12529.0 12650.4 15006.7 15539.8 15546.8 15504.1 16217.0 16228.3 16234.5 16279.8 723.1 741.2 754.5 904.9 932.4 766.6 909.3 934.3 934.3 934.6 974.8 980.3 982.5 983.6 985.9 751.4 770.9 771.6 973.4 976.0 567.6 704.7 724.0 730.5 730.8 15528.4 15598.8 15618.0 15647.3 15679.8 12135.4 12172.6 12204.9 12409.3 12493.2 9855.8 9977.2 10024.5 10410.8 10645.3 3448.2 3465.9 3560.6 3564.1 3576.6 73793.0 76114.0 78922.6 79058.0 79365.6 9122.7 9183.0 9281.4 9318.8 9600.5 20920.9 20930.6 21007.4 21031.9 21060.7 7272.3 7272.9 7332.6 7400.1 7449.1 3679.6 3923.9 3936.9 3938.1 3997.9 3376.7 3492.1 3495.0 3502.2 3506.7 573.0 611.9 641.5 642.2 649.6 523.3 557.3 563.6 588.2 590.0 7880.4 7944.6 7983.3 8084.0 8129.3 527.0 560.0 570.2 574.0 586.9 3183.9 3799.8 3821.6 3846.8 4019.5 82387.8 91338.5 92851.0 93668.0 93952.5 69973.7 74550.0 74806.5 75250.0 78087.6 64264.0 67875.7 68344.0 69441.0 69627.0 7503.8 7521.1 7717.0 7726.0 7911.7 42633.4 44173.0 44189.8 45265.3 45362.1 60854.4 62563.7 62565.1 62805.0 62940.7 9741.6 9850.8 9860.0 9895.9 10206.9 9733.6 9896.3 10420.7 11174.8 11616.5 10164.9 10426.3 10459.4 10461.8 10651.4 10262.6 10353.9 10357.0 10794.4 11338.3 10104.8 10176.5 10204.6 10334.9 10855.2 8791.2 8875.1 8946.6 8967.7 9727.8 7219.0 7396.5 8820.5 8930.1 8972.3 17:58:31 INFO - PROCESS | 2019 | -------- Summary: end -------- 17:58:31 INFO - PROCESS | 2019 | 17:58:31 INFO - TEST-INFO | 2019: exit 0 17:58:31 INFO - TEST-OK | dromaeo_css | took 1113553ms 17:58:31 INFO - TEST-START | kraken 17:58:31 INFO - operating with platform_type : mac_ 17:58:31 INFO - Initialising browser for kraken test... 17:58:31 INFO - TEST-INFO | started process 2023 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmp4THCHt/profile http://localhost:51349/getInfo.html) 17:58:34 INFO - PROCESS | 2023 | __metrics Screen width/height:1600/1200 17:58:34 INFO - PROCESS | 2023 | colorDepth:24 17:58:34 INFO - PROCESS | 2023 | Browser inner width/height: 1024/689 17:58:34 INFO - PROCESS | 2023 | __metrics 17:58:34 INFO - PROCESS | 2023 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:58:34 ERROR - PROCESS | 2023 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:58:34 INFO - TEST-INFO | 2023: exit 0 17:58:34 INFO - Browser initialized. 17:58:34 INFO - Running cycle 1/1 for kraken test... 17:58:34 INFO - TEST-INFO | started process 2025 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmp4THCHt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:46 INFO - PROCESS | 2025 | RSS: Main: 237432832 17:58:46 INFO - PROCESS | 2025 | 17:58:49 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:49 INFO - PROCESS | 2025 | RSS: Main: 283205632 17:58:49 INFO - PROCESS | 2025 | 17:58:52 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-dft) 17:58:53 INFO - PROCESS | 2025 | RSS: Main: 295542784 17:58:53 INFO - PROCESS | 2025 | 17:58:56 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-fft) 17:58:57 INFO - PROCESS | 2025 | RSS: Main: 281165824 17:58:57 INFO - PROCESS | 2025 | 17:58:59 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-oscillator) 17:58:59 INFO - PROCESS | 2025 | RSS: Main: 283398144 17:58:59 INFO - PROCESS | 2025 | 17:59:01 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:59:02 INFO - PROCESS | 2025 | RSS: Main: 284471296 17:59:02 INFO - PROCESS | 2025 | 17:59:05 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51349/tests/kraken/driver.html?testName=imaging-darkroom) 17:59:05 INFO - PROCESS | 2025 | RSS: Main: 284315648 17:59:05 INFO - PROCESS | 2025 | 17:59:08 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51349/tests/kraken/driver.html?testName=imaging-desaturate) 17:59:09 INFO - PROCESS | 2025 | RSS: Main: 284741632 17:59:09 INFO - PROCESS | 2025 | 17:59:12 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51349/tests/kraken/driver.html?testName=json-parse-financial) 17:59:12 INFO - PROCESS | 2025 | RSS: Main: 284954624 17:59:12 INFO - PROCESS | 2025 | 17:59:14 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:59:14 INFO - PROCESS | 2025 | RSS: Main: 318423040 17:59:14 INFO - PROCESS | 2025 | 17:59:16 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:59:17 INFO - PROCESS | 2025 | RSS: Main: 318365696 17:59:17 INFO - PROCESS | 2025 | 17:59:19 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:59:20 INFO - PROCESS | 2025 | RSS: Main: 323813376 17:59:20 INFO - PROCESS | 2025 | 17:59:22 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:59:23 INFO - PROCESS | 2025 | RSS: Main: 325619712 17:59:23 INFO - PROCESS | 2025 | 17:59:26 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:27 INFO - PROCESS | 2025 | RSS: Main: 325664768 17:59:27 INFO - PROCESS | 2025 | 17:59:28 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51349/tests/kraken/driver.html?testName=ai-astar) 17:59:29 INFO - PROCESS | 2025 | RSS: Main: 389644288 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | __start_tp_report 17:59:29 INFO - PROCESS | 2025 | _x_x_mozilla_page_load 17:59:29 INFO - PROCESS | 2025 | _x_x_mozilla_page_load_details 17:59:29 INFO - PROCESS | 2025 | |i|pagename|runs| 17:59:29 INFO - PROCESS | 2025 | |0;ai-astar;111;109;111;112;111;111;121;143;112;111 17:59:29 INFO - PROCESS | 2025 | |1;audio-beat-detection;180;151;149;156;120;138;138;120;162;119 17:59:29 INFO - PROCESS | 2025 | |2;audio-dft;186;184;185;185;188;185;187;187;182;207 17:59:29 INFO - PROCESS | 2025 | |3;audio-fft;76;78;83;88;83;86;86;83;82;55 17:59:29 INFO - PROCESS | 2025 | |4;audio-oscillator;93;91;133;77;78;80;117;79;77;120 17:59:29 INFO - PROCESS | 2025 | |5;imaging-gaussian-blur;88;87;90;87;88;86;88;86;89;85 17:59:29 INFO - PROCESS | 2025 | |6;imaging-darkroom;94;94;94;94;112;151;95;94;95;93 17:59:29 INFO - PROCESS | 2025 | |7;imaging-desaturate;85;82;85;85;94;85;86;86;86;84 17:59:29 INFO - PROCESS | 2025 | |8;json-parse-financial;54;54;54;53;55;53;56;65;54;53 17:59:29 INFO - PROCESS | 2025 | |9;json-stringify-tinderbox;64;65;67;78;74;71;68;68;69;69 17:59:29 INFO - PROCESS | 2025 | |10;stanford-crypto-aes;87;94;114;113;114;84;85;86;84;86 17:59:29 INFO - PROCESS | 2025 | |11;stanford-crypto-ccm;146;146;144;143;140;140;147;143;143;145 17:59:29 INFO - PROCESS | 2025 | |12;stanford-crypto-pbkdf2;170;168;168;171;166;167;169;169;168;167 17:59:29 INFO - PROCESS | 2025 | |13;stanford-crypto-sha256-iterative;67;68;98;100;75;67;69;70;70;67 17:59:29 INFO - PROCESS | 2025 | __end_tp_report 17:59:29 INFO - PROCESS | 2025 | __start_cc_report 17:59:29 INFO - PROCESS | 2025 | _x_x_mozilla_cycle_collect,1339 17:59:29 INFO - PROCESS | 2025 | __end_cc_report 17:59:29 INFO - PROCESS | 2025 | __startTimestamp1460163569064__endTimestamp 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | ------- Summary: start ------- 17:59:29 INFO - PROCESS | 2025 | Number of tests: 14 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#0] ai-astar Cycles:10 Average:115.20 Median:111.50 stddev:10.29 (9.2%) stddev-sans-first:10.81 17:59:29 INFO - PROCESS | 2025 | Values: 111.0 109.0 111.0 112.0 111.0 111.0 121.0 143.0 112.0 111.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.00 stddev:20.23 (13.5%) stddev-sans-first:16.53 17:59:29 INFO - PROCESS | 2025 | Values: 180.0 151.0 149.0 156.0 120.0 138.0 138.0 120.0 162.0 119.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#2] audio-dft Cycles:10 Average:187.60 Median:186.50 stddev:7.03 (3.8%) stddev-sans-first:7.43 17:59:29 INFO - PROCESS | 2025 | Values: 186.0 184.0 185.0 185.0 188.0 185.0 187.0 187.0 182.0 207.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#3] audio-fft Cycles:10 Average:80.00 Median:83.00 stddev:9.50 (11.4%) stddev-sans-first:9.96 17:59:29 INFO - PROCESS | 2025 | Values: 76.0 78.0 83.0 88.0 83.0 86.0 86.0 83.0 82.0 55.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:78.50 stddev:21.05 (26.8%) stddev-sans-first:22.32 17:59:29 INFO - PROCESS | 2025 | Values: 93.0 91.0 133.0 77.0 78.0 80.0 117.0 79.0 77.0 120.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.51 (1.7%) stddev-sans-first:1.58 17:59:29 INFO - PROCESS | 2025 | Values: 88.0 87.0 90.0 87.0 88.0 86.0 88.0 86.0 89.0 85.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:94.00 stddev:18.25 (19.4%) stddev-sans-first:19.15 17:59:29 INFO - PROCESS | 2025 | Values: 94.0 94.0 94.0 94.0 112.0 151.0 95.0 94.0 95.0 93.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:3.12 (3.6%) stddev-sans-first:3.30 17:59:29 INFO - PROCESS | 2025 | Values: 85.0 82.0 85.0 85.0 94.0 85.0 86.0 86.0 86.0 84.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:3.60 (6.7%) stddev-sans-first:3.80 17:59:29 INFO - PROCESS | 2025 | Values: 54.0 54.0 54.0 53.0 55.0 53.0 56.0 65.0 54.0 53.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:4.16 (6.0%) stddev-sans-first:3.95 17:59:29 INFO - PROCESS | 2025 | Values: 64.0 65.0 67.0 78.0 74.0 71.0 68.0 68.0 69.0 69.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#10] stanford-crypto-aes Cycles:10 Average:94.70 Median:85.50 stddev:13.39 (15.7%) stddev-sans-first:13.91 17:59:29 INFO - PROCESS | 2025 | Values: 87.0 94.0 114.0 113.0 114.0 84.0 85.0 86.0 84.0 86.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:144.50 stddev:2.41 (1.7%) stddev-sans-first:2.40 17:59:29 INFO - PROCESS | 2025 | Values: 146.0 146.0 144.0 143.0 140.0 140.0 147.0 143.0 143.0 145.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:1.49 (0.9%) stddev-sans-first:1.45 17:59:29 INFO - PROCESS | 2025 | Values: 170.0 168.0 168.0 171.0 166.0 167.0 169.0 169.0 168.0 167.0 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - PROCESS | 2025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:69.50 stddev:12.83 (18.5%) stddev-sans-first:13.27 17:59:29 INFO - PROCESS | 2025 | Values: 67.0 68.0 98.0 100.0 75.0 67.0 69.0 70.0 70.0 67.0 17:59:29 INFO - PROCESS | 2025 | -------- Summary: end -------- 17:59:29 INFO - PROCESS | 2025 | 17:59:29 INFO - TEST-INFO | 2025: exit 0 17:59:29 INFO - TEST-OK | kraken | took 58051ms 17:59:29 INFO - SUITE-END | took 1171s 17:59:30 INFO - Completed test suite (00:19:32) 17:59:30 INFO - javascript benchmark 17:59:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2874.2526942994823, 3340.4989251612255, 3368.326334733053, 3372.460406334987, 3397.2356219850535, 5412.756425960832, 5515.117581187011, 5520.144377621465, 5529.944700552994, 5540.750666220019, 5420.295361602996, 5512.80705175318, 5518.889622207554, 5528.861778455541, 5529.944700552994, 4974.577160941315, 5007.0, 5010.123228435027, 5069.9493005070035, 5082.822101226458, 5011.423686276088, 5065.797368105272, 5082.898342033157, 5085.160948443502, 5086.389633244016, 5043.974780126113, 5080.466551012146, 5110.8466745997675, 5111.386633603955, 5165.560927321163, 5087.923681144767, 5114.386273647149, 5126.5642420394315, 5136.614753893473, 5164.406093299281, 4923.286123512071, 4945.307656928033, 5047.192449208146, 5052.747362631891, 5074.771635276422, 5394.163904594794, 5431.266778984826, 5452.754626041838, 5484.149956756709, 5534.944650553483, 6063.242094738158, 6077.118817771443, 6079.969600151971, 6090.512758979316, 6117.418845209698, 5869.589128760988, 5982.0, 6115.179495343464, 6121.908171377433, 6122.020476723747, 5625.493705566437, 5651.858703532444, 5660.915086273709, 5675.063614503602, 5679.204911312419, 6160.815175544741, 6202.658853763086, 6235.438810507076, 6236.968815155895, 6247.3440288769025, 5761.0, 5909.054551271776, 5990.161377407167, 6007.279126504847, 6034.879302413927, 6103.511719062464, 6103.6032657877095, 6111.663858487826, 6117.510599152146, 6118.847028824315, 6002.6098303611, 6031.185789918392, 6045.0, 6045.848853778691, 6046.5767396281835, 5864.736086876101, 6034.547408944347, 6104.156010547632, 6113.719560719409, 6134.436587033474, 4798.832040878552, 4803.1114243864995, 4812.51874812523, 4828.275758636232, 4860.4896485869185, 4185.393117997874, 4315.482142142901, 4315.892102697395, 4326.697131200849, 4379.5182529921685, 5456.454354564591, 5483.040467918098, 5527.585431092684, 5598.86002849932, 5613.045782217033, 6103.023516237381, 6105.877882442415, 6110.725017374229, 6117.143599896018, 6135.355787642323, 5407.810726624628, 5495.0, 5542.418046105101, 5551.2228288039705, 5561.694106824082, 5201.895962080813, 5239.371275446971, 5333.573314134937, 5345.919811202835, 5358.0, 6235.688215589203, 6248.062790581449, 6248.31268560458, 6250.968745156245, 6255.749770009331, 6135.0, 6140.478059364826, 6146.108814222002, 6160.507159427146, 6162.7534898605345, 5207.192885102815, 6112.716259964451, 6168.0439531872635, 6199.969000155151, 6245.5628106033955, 6011.458968692838, 6030.125631783455, 6035.668038257938, 6038.0, 6068.939310606837, 6045.486133678511, 6108.51131909455, 6140.508759299335, 6149.077638354103, 6152.107944348134, 5118.795248190031, 5727.11229759388, 5838.708064596838, 5970.731317090655, 6025.728842202199, 5920.4671579556325, 5931.7627294907725, 5941.613795103477, 5944.464998150187, 5947.9405205949115, 5616.943830561642, 5745.8563535911935, 5801.071828507418, 5803.564732644984, 5817.272840894888, 4847.345608342828, 5984.581079324405, 5987.101934709828, 6000.51995840323, 6020.819375418744, 5772.134179873053, 5783.537317014713, 5793.073108302651, 5803.7678492861505, 5847.678377689268], "value": 5544.85636055944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.4417419967035, 488.29441457094515, 498.91269027920106, 504.4148787406609, 518.1010946008674, 28987.420251594955, 29523.11430657081, 36475.81762091193, 37642.24715505688, 37686.811565942204, 41938.790306048504, 42715.786421067925, 42759.35860962088, 42788.35817462741, 42927.92680182997, 9381.859272110923, 9638.277129215301, 9639.325247232697, 9641.75895602612, 9656.420614763138, 9464.81070378592, 9631.181349585293, 9634.75913102171, 9638.855417168748, 9641.855372169422, 9615.086566776145, 9676.467794271312, 9681.0, 9692.854607180898, 9697.07877751616, 8131.878021829677, 9645.588602849288, 9656.951715241448, 9665.806683866283, 9672.56473458696, 7724.961375193145, 8755.0, 8765.693200738007, 9438.339316247866, 9491.335606507548, 33880.49179262313, 38705.64530241428, 38891.44434222628, 39425.21149576992, 39454.802725986185, 3318.4026875162463, 3331.6335203127637, 3336.432806422914, 3435.3301106284284, 3714.147879583621, 27054.32364190891, 28024.0, 28376.574351384745, 28474.430511389655, 28554.71445285562, 2728.836269823817, 2731.153342463823, 2751.269186678369, 2755.655543057118, 2816.2959260184953, 448118.75940620416, 451455.0, 451974.0, 452914.0, 453110.0, 34864.0, 35598.46602300968, 35698.643013569534, 57861.0, 57905.0, 34601.82699086539, 34676.65323346785, 34815.82592087074, 34887.0, 34891.0, 14566.0, 14751.262436878113, 14760.188189649672, 14765.187914664797, 14770.26148692561, 10324.638637647646, 12440.81338779919, 12493.812592811115, 12509.624711258495, 12536.686582835502, 7962.562059086806, 7999.920000800034, 8031.598420078973, 8060.0, 8076.192380761877, 3284.8521816518314, 3317.867285308609, 3322.0532148337606, 3323.916902077419, 3354.2452948086484, 931.8741969833985, 988.5008070924281, 1004.2919741582167, 1034.8344264917578, 1176.4764679717443, 28730.569041464394, 29065.854670726934, 29109.272268193043, 29270.414591708046, 29558.556621650692, 1085.7285678580356, 1089.5478376473834, 1101.7851518953887, 1131.7170707323169, 1156.410230782307, 14828.184449855145, 14856.925715371353, 14917.552473425598, 15319.693606128038, 15415.46045888411, 618246.0, 730528.0, 743722.0, 745605.0, 747896.0, 54870.17694734582, 55466.72266638641, 55851.0, 55964.720176398856, 55981.720091399286, 1191.3030876936916, 1275.005495713345, 1438.7266419380285, 1458.8614081662438, 1568.858802707739, 28269.71730282671, 28821.135365939055, 29065.0, 29520.671569779843, 29573.852130739207, 50510.74744626253, 51501.0, 51512.48487515077, 51599.71000724862, 51802.70493237548, 457544.0, 474407.0, 474521.0, 474770.0, 475032.2496774988, 22850.428739280986, 25760.484790303715, 25951.351216219744, 26162.084327048462, 26525.469490610467, 39963.00369962981, 40253.39619905762, 41675.95810104772, 41880.0, 41996.58003420049, 32866.0, 34428.48357274593, 34940.65059349374, 35149.47275790916, 35522.28955420929, 33433.66566334403, 33854.492182617774, 33976.490352645225, 34605.82697086498, 34628.30743385169, 28259.57610635801, 34321.0, 34496.48255276123, 35107.824460877535, 35197.120071998404, 28460.57309140406, 28816.71183288224, 30241.09276721702, 30414.032508777098, 30564.235894102825, 22456.88771556197, 22665.333666583356, 22687.77265362084, 23289.883550582137, 23606.173783917482], "value": 17774.58726902691, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.69146188546904, 396.9761814291142, 397.59643961379226, 401.56502358826316, 405.7382987972758, 19520.31678891239, 20320.780753154802, 20434.386968390954, 20512.794872051276, 21351.893240533813, 20410.89794551029, 20562.588748225066, 21129.788702112975, 21144.0, 21192.576148477023, 5778.24882765241, 6068.908966365508, 6070.301915279733, 6074.422929821682, 6075.149479072933, 5745.482906538411, 5886.941130588703, 5998.6400815950965, 6012.819615411545, 6013.248343957005, 5791.594588378815, 5914.704264786765, 5914.9408505915035, 5945.227120474332, 5954.434328738763, 5901.645901245939, 5930.7924222652, 5930.822075337746, 7212.675429605681, 7696.268854458817, 7136.2506936771415, 7431.591262480561, 7448.068991376078, 7449.925500745032, 7456.701731930716, 22319.99560019803, 28039.719602803914, 28539.85730071357, 28943.855280723674, 29007.0, 2065.6901464780403, 2157.482204270964, 2257.796798288162, 2276.829237807171, 3003.189138932476, 13574.710402511746, 15300.923495382563, 15659.686806263811, 15855.92072039644, 16287.429939952044, 1840.530664680498, 1840.723891416285, 1873.4473330367575, 1900.3918746001284, 1981.8909959952198, 112246.0, 113753.4312328433, 116396.0, 117009.41495292554, 117815.4109229457, 16980.575485612957, 20368.287109951376, 20821.835632873484, 20865.0, 21014.369568912956, 35327.0, 35384.46923296153, 35384.64615353814, 35447.4682879757, 35488.29023419517, 9825.705228843146, 10211.387316761018, 10240.948795255976, 10251.436171010517, 10418.218633602359, 7099.964500177466, 7959.681612735426, 8230.21812927771, 8250.21487537227, 8320.209580089882, 9367.62529498826, 9409.623615055458, 9545.425004874118, 9549.331546791796, 9602.375845570155, 3718.665320121202, 3736.5702944161226, 3761.9435708464393, 3765.5669597996034, 3775.0169775895556, 863.4085651328734, 909.9863502047475, 936.541094863512, 939.3565407695751, 1000.2398177385239, 19449.4165175045, 20050.498737531678, 20141.295054673017, 20240.797592024184, 20578.897105514377, 957.4590356448584, 960.351762560269, 976.9560369783377, 997.4115271989416, 1075.47839297942, 10112.646057387956, 10392.116670083127, 10429.478526073666, 10472.266941314036, 10492.861626134561, 621731.261499079, 622691.0, 627540.0, 660411.0, 660506.0, 120256.0, 127637.0, 128615.0, 131235.0, 135464.0, 992.8532544910496, 1002.3534820041178, 1010.6210171185805, 1026.3790406803926, 1030.5053574284386, 14233.217173055582, 14706.705865882837, 17147.314107435563, 17689.646207076043, 17889.73165402494, 47756.52243477521, 47813.28280075871, 48778.512214877395, 49005.0, 49127.99999999857, 69636.0, 70812.0, 71096.0, 72423.0, 73406.22859514115, 7900.881486777588, 8038.11580726108, 8131.186881311822, 8267.958660206901, 8451.112633173429, 10224.98564187092, 12122.030237580795, 12125.636230913087, 12205.084618653815, 12342.44458999365, 10344.896551034695, 10492.895071049497, 10656.520456579628, 10755.516001779783, 10761.46192690378, 9487.857682134636, 9746.561404736662, 10288.331258468175, 10300.896991030293, 10684.626038088629, 10427.68716938493, 10636.734081648021, 10861.837072444077, 10931.070858976758, 11189.160812938899, 7296.124465064227, 7517.774466766005, 8019.077806052145, 8154.877676834733, 8372.0, 9734.951325243328, 10671.893281067401, 10982.670519884416, 10993.670189894316, 10997.34015959045], "value": 10529.374026930738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.6106290238736, 1390.6175801654545, 1576.5506830553293, 1722.7071397862362, 1961.1076959983218, 7512.887306690397, 7628.931949527064, 8731.476111433303, 8751.868721969175, 8757.781055473617, 8395.748127556168, 8602.182792634705, 8604.182602652754, 8612.354073444485, 8626.568671566429, 2137.10241698487, 2386.868722220277, 2439.5608790417764, 2470.3824043989002, 2472.2830379190013, 2479.7148327942245, 2501.374656335916, 2504.9248522544353, 2506.9247922562354, 2513.0324824942345, 2416.7462416446283, 2468.90124395024, 2476.8018558515278, 2479.665245191903, 2481.4788894332214, 2067.183462532299, 2425.696787901521, 2436.8294219404647, 2456.6437866509436, 2461.2739241923678, 2429.6355546667965, 2448.375664205634, 2456.7666071723156, 2460.3480077779404, 2463.1255904154127, 8605.526696031715, 8682.30541556674, 8689.131086891324, 8699.478031318142, 8705.0, 5208.765605547722, 5389.245505629215, 5392.892142157135, 5404.567634589223, 5416.052190866582, 3226.370857682753, 3256.6580509046444, 3355.6141043780035, 3435.4675025371107, 3462.3594634992355, 845.382870504529, 939.1125386509751, 952.6951375559754, 954.2413781044087, 982.6609819612222, 11102.722431939186, 11197.272177308449, 11197.552097916074, 11201.271917325348, 11211.215214935039, 4681.368015317957, 4846.273059041101, 4925.064237794808, 4963.528464795839, 5014.423341315795, 9820.607175713034, 9879.06148915852, 9891.010898910052, 9893.15908147801, 9900.950495247622, 5401.891962160814, 5409.0, 5427.267318911975, 5433.782648694008, 5440.966216418868, 4379.956200438019, 4552.0668263006, 4768.61851051915, 4871.244957031666, 4890.682105663192, 3912.667423268997, 3970.1265721541213, 4010.6791456683977, 4055.3105971984833, 4088.9386659200136, 1334.9532766353325, 1356.5658989123385, 1361.6868120332379, 1368.637311112556, 1372.8695773901463, 1172.1384782185087, 1318.103689491136, 1356.3557310277736, 1364.208758919824, 1373.6359864635879, 7955.0, 7989.360851131895, 8011.1588283230585, 8022.839543209103, 8047.476914000571, 507.36832643359253, 513.7431284357821, 522.4148953172471, 524.2346174585149, 526.7471613625481, 6149.446549810538, 6212.192414986023, 6351.269603995507, 6362.9045564316575, 6367.363263673688, 10083.394996300245, 10439.217058720626, 10471.371717696962, 10561.63034293796, 10567.471626418803, 9034.14175653312, 9848.113669769755, 10045.497725113715, 10412.167026637851, 10420.0, 7769.961150194326, 7930.286274235231, 7945.841083178304, 8010.239027292398, 8043.276105150565, 7760.68957241704, 8081.515109093473, 8083.949086618702, 8089.069756978023, 8100.554469504234, 9479.194268487256, 9494.95252523733, 9500.619975200914, 9615.56729947168, 9673.854892176763, 9734.513274336396, 9779.462129582942, 10022.799544009225, 10027.197824174194, 10167.186625070124, 6494.6103233806125, 6749.190097188369, 6954.3393377629045, 7384.667689953858, 7547.433942454228, 8102.4328297021, 8200.343972482306, 8200.835983280182, 8207.261346478846, 8208.958955205186, 7128.6792094356915, 7208.243134471015, 7228.710851565878, 7327.450441217036, 7388.298111679382, 7099.43204543625, 7106.857862842611, 7144.249853765487, 7228.89156662661, 7290.270972902667, 7461.067366579177, 7604.315611594983, 7652.61736913141, 7658.770236892902, 7659.731909383145, 6899.241083480913, 6962.7911162665205, 6966.825829354307, 6968.198657154492, 6984.860302794017, 5872.412758724094, 7015.6842942066705, 7040.542364746275, 7058.5764854106865, 7076.433885289268], "value": 4760.012493135729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.8932873494277, 320.2633941933552, 325.5734987166811, 330.4448526475522, 332.2839281348694, 5171.560417364529, 5408.378036525796, 5903.664429597275, 5933.732982015809, 5939.940600594004, 5783.2481777368985, 5798.681072541009, 5825.854353641161, 5839.883202335951, 5846.678432686201, 3582.480540321652, 3870.8838734838, 3915.4533959086143, 4299.742015479065, 4351.26028575143, 3581.982090089546, 4347.3261644445165, 4380.934285985712, 4386.078923426085, 4390.473143222818, 4135.834566617332, 4369.366441865944, 4382.5398333175035, 4403.634873189306, 4416.160929423415, 4152.131540806634, 4200.836569166881, 4404.801783919731, 4432.689711720181, 4455.242608756519, 3783.451399547078, 3794.677452416548, 3798.810059497014, 3811.904702382463, 3819.2743378757946, 5549.528290095347, 5564.86087847803, 5608.383077861432, 5615.017371959891, 5640.492355687967, 3949.4273330366937, 4727.22000869856, 5035.949640503584, 5049.343585333883, 5112.006317536164, 5085.898282034339, 6126.663033533154, 6138.048602466625, 6169.29053158888, 6183.381661833826, 3600.387934051191, 4118.961114248466, 4128.566500517462, 4135.193637240739, 4137.97931010343, 5278.868028299285, 5939.67331796751, 6112.196901913946, 6398.752243312556, 6504.154459920227, 4098.52866920302, 4099.200655872076, 4110.917781644351, 4111.568285330057, 4123.9175216495505, 3465.636108208602, 4165.083681590046, 4305.268104422193, 4308.095299986975, 4319.373690814814, 4754.477007529169, 5033.79864805411, 5039.622028347889, 5056.292119103328, 5067.0, 6197.25632924052, 6264.436200741864, 6264.686765661699, 6280.7487700491465, 6285.371462853769, 1159.6984783956232, 1471.4555614422732, 1471.5732437593192, 1471.6026672798284, 1478.77079052747, 925.2921515040999, 951.6811868024151, 966.6278482784179, 978.5058545434653, 978.5107446276861, 5151.072806894795, 5735.799247026334, 5779.0, 5793.913091303634, 5816.47651711348, 6189.102580125857, 6397.392247736458, 6426.967865160645, 6448.451881590024, 6467.482601391877, 5497.230387745719, 5786.826395208151, 5838.970805146032, 5843.766249349978, 5853.268341457318, 2819.0407666671467, 2939.720726530976, 3357.1942733743726, 3391.796492210475, 3417.8803741868915, 6448.9355106449275, 6765.729370825112, 6767.492438067066, 6791.966040169767, 6889.827754306082, 5582.358028826737, 5969.701514924236, 6714.261431242559, 6751.662416879235, 6761.357671021246, 6504.7718982661645, 6813.150569927975, 6813.2846051163915, 6839.965800170868, 6841.555298905555, 6472.805815825533, 6491.48068154537, 6499.870002600016, 6519.869602608016, 6552.6068435894, 5285.62147033844, 6378.553501255054, 6394.1687580614225, 6411.358864113551, 6419.6790160490855, 6127.632342059491, 6383.457406120346, 6648.9002664961035, 6764.526483146133, 6782.28785977485, 3494.0, 3707.3326801174967, 4190.790460477025, 4247.214265360918, 4258.254805409103, 6129.601575897553, 6497.122888410004, 6507.219133703986, 6521.706523206372, 6535.052417399545, 5227.712475813867, 6274.839154756384, 6277.466415354746, 6287.245530536365, 6304.684765761602, 6247.562670613195, 6273.215848018997, 6285.622862628257, 6294.8111556653375, 6311.368863113652, 5137.559659161868, 5702.97346477638, 5833.562482813721, 5924.318703348998, 6155.0, 5440.0, 6274.215723034621, 6279.246490421178, 6316.684165791784, 6320.178376810985, 5867.501262392744, 6142.832861756252, 6164.568480206342, 6179.5056395489155, 6224.533160012927], "value": 4517.916049655747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7183751799137, 622.6730966242721, 635.9618422894627, 654.708654648681, 726.415235735233, 12529.0, 12650.367481625904, 15006.699866002687, 15539.844601553996, 15546.766798498018, 15504.069755814658, 16217.0, 16228.269727862245, 16234.51296461108, 16279.755803662954, 723.1033518437126, 741.2032065529551, 754.5057987018512, 904.9185573298402, 932.3986029011284, 766.6205228411944, 909.2771246858763, 934.2619330728717, 934.3179478980314, 934.6261495401826, 974.8440249560072, 980.3333733061515, 982.4694664880956, 983.6311383231289, 985.8816941966974, 751.3538357012965, 770.857391382596, 771.6141929035482, 973.3964941736134, 975.9853602195973, 567.6480582039121, 704.6723273677713, 724.022569531134, 730.5397599512273, 730.8099894027538, 15528.378864845392, 15598.844011559966, 15617.98483098595, 15647.295871685801, 15679.764803527956, 12135.393230338535, 12172.634820955385, 12204.877951220464, 12409.317487538181, 12493.18794278369, 9855.753606159831, 9977.201823854075, 10024.54889529973, 10410.843837342445, 10645.254832161752, 3448.2413868948793, 3465.861365545375, 3560.6439356064448, 3564.1446052947367, 3576.588692300367, 73793.0, 76114.0, 78922.60538697327, 79057.99999999942, 79365.60317198434, 9122.680706175252, 9182.954085229665, 9281.396709214014, 9318.813623727487, 9600.471974041495, 20920.895395522926, 20930.581388372146, 21007.369778906657, 21031.894840526005, 21060.684089738665, 7272.309130632581, 7272.854542909112, 7332.5967071811565, 7400.148982866932, 7449.106107267163, 3679.5768486623847, 3923.862664806718, 3936.9212615747524, 3938.0548668319398, 3997.9005773412546, 3376.7129793967297, 3492.1269682579355, 3494.965050349515, 3502.176988407722, 3506.6668666476644, 572.9885402291931, 611.9388061193845, 641.4836056974087, 642.24215425798, 649.5518092516148, 523.3275241314892, 557.3479029535454, 563.6477201748907, 588.2294194605081, 589.9616524925866, 7880.369570434352, 7944.642491087915, 7983.321417679563, 8084.0, 8129.3090087343235, 527.0302643136647, 559.9524040456607, 570.2131059138362, 573.9684317362585, 586.906095024794, 3183.9204019899225, 3799.8290076946605, 3821.636944490269, 3846.8461261549223, 4019.537753158366, 82387.7641835361, 91338.54330728303, 92851.0, 93668.0, 93952.53023734837, 69973.65013175004, 74550.0, 74806.5038699223, 75250.0, 78087.60956195183, 64264.0, 67875.66062169657, 68344.0, 69441.0, 69626.9555956661, 7503.7748867534065, 7521.135069467081, 7717.0, 7725.961370193113, 7911.723089691834, 42633.36049959191, 44173.0, 44189.77905110583, 45265.32102018406, 45362.092758145314, 60854.39145608487, 62563.68718156562, 62565.06152407808, 62805.0, 62940.685296573225, 9741.561629726537, 9850.802983940424, 9859.950700246452, 9895.851562226428, 10206.877243503357, 9733.637290779438, 9896.257780666334, 10420.739481512719, 11174.776504469703, 11616.535338586362, 10164.898351016394, 10426.27016108865, 10459.424731639832, 10461.843072353768, 10651.414172220293, 10262.640807571997, 10353.9482302588, 10357.0, 10794.406307653155, 11338.263012904135, 10104.797904042025, 10176.491175441346, 10204.642837500653, 10334.948325258325, 10855.185861060294, 8791.164839340252, 8875.050602482092, 8946.597403117006, 8967.686130985385, 9727.80544389094, 7219.0, 7396.482246242711, 8820.470771753715, 8930.106989301017, 8972.28221742272], "value": 6609.897788380932, "unit": "score"}], "name": "dromaeo_css", "value": 7269.066802504422, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 112.0, 111.0, 111.0, 121.0, 143.0, 112.0, 111.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 151.0, 149.0, 156.0, 120.0, 138.0, 138.0, 120.0, 162.0, 119.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 185.0, 188.0, 185.0, 187.0, 187.0, 182.0, 207.0], "value": 187.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 83.0, 88.0, 83.0, 86.0, 86.0, 83.0, 82.0, 55.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 133.0, 77.0, 78.0, 80.0, 117.0, 79.0, 77.0, 120.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 87.0, 88.0, 86.0, 88.0, 86.0, 89.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 112.0, 151.0, 95.0, 94.0, 95.0, 93.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 85.0, 94.0, 85.0, 86.0, 86.0, 86.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 55.0, 53.0, 56.0, 65.0, 54.0, 53.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 78.0, 74.0, 71.0, 68.0, 68.0, 69.0, 69.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 114.0, 113.0, 114.0, 84.0, 85.0, 86.0, 84.0, 86.0], "value": 94.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 144.0, 143.0, 140.0, 140.0, 147.0, 143.0, 143.0, 145.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 168.0, 171.0, 166.0, 167.0, 169.0, 169.0, 168.0, 167.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 98.0, 100.0, 75.0, 67.0, 69.0, 70.0, 70.0, 67.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1501.6, "alertThreshold": 2.0}]} 17:59:30 INFO - Return code: 0 17:59:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:59:30 ERROR - # TBPL SUCCESS # 17:59:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:30 INFO - 2016-04-08 17:59:30.359 screenresolution[2029:16052] starting screenresolution argv=screenresolution get 17:59:30 INFO - 2016-04-08 17:59:30.362 screenresolution[2029:16052] Display 0: 1600x1200x32@60 17:59:30 INFO - 2016-04-08 17:59:30.368 screenresolution[2030:16055] starting screenresolution argv=screenresolution list 17:59:30 INFO - Available Modes on Display 0 17:59:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:30 INFO - Intel Iris: 17:59:30 INFO - Chipset Model: Intel Iris 17:59:30 INFO - Type: GPU 17:59:30 INFO - Bus: Built-In 17:59:30 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:30 INFO - Vendor: Intel (0x8086) 17:59:30 INFO - Device ID: 0x0a2e 17:59:30 INFO - Revision ID: 0x0009 17:59:30 INFO - Displays: 17:59:30 INFO - Display: 17:59:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:30 INFO - Display Serial Number: 1600x1200 60 17:59:30 INFO - Main Display: Yes 17:59:30 INFO - Mirror: Off 17:59:30 INFO - Online: Yes 17:59:30 INFO - Rotation: Supported 17:59:30 INFO - Return code: 0 17:59:30 INFO - Running post-action listener: _resource_record_post_action 17:59:30 INFO - Running post-run listener: _resource_record_post_run 17:59:31 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 1544704; Write bytes: 691884544; Read time: 13; Write time: 1977 17:59:31 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 376945152; Write bytes: 371082752; Read time: 28486; Write time: 701 17:59:31 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 1544704; Write bytes: 297872384; Read time: 13; Write time: 1229 17:59:31 INFO - Running post-run listener: _upload_blobber_files 17:59:31 INFO - Blob upload gear active. 17:59:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:59:31 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'] 17:59:31 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 17:59:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:59:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:33 INFO - (blobuploader) - INFO - Done attempting. 17:59:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:59:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:34 INFO - (blobuploader) - INFO - Done attempting. 17:59:34 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:34 INFO - Return code: 0 17:59:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e4bb251a9b827942d4474d2725bf07454122390c931b19a9f215b1ab5804d5ba0856245dd6da7b7ecfebcd1155eb6b52d453887b6c513afeef1180ff1b49963", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eff4949cd6580fa832dc42a27274376f870f45794f10029331ce06449cc0f8e5073f2ccf3de2f900ca9d092bb581c9cf51e5f405f6e34dde92e313e4a0cf652"} 17:59:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:34 INFO - Contents: 17:59:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e4bb251a9b827942d4474d2725bf07454122390c931b19a9f215b1ab5804d5ba0856245dd6da7b7ecfebcd1155eb6b52d453887b6c513afeef1180ff1b49963", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eff4949cd6580fa832dc42a27274376f870f45794f10029331ce06449cc0f8e5073f2ccf3de2f900ca9d092bb581c9cf51e5f405f6e34dde92e313e4a0cf652"} 17:59:34 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:34 INFO - Copying logs to upload dir... 17:59:34 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.121123 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-04-08 17:59:34.983690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 17:59:34.987285) ========= 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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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/7e4bb251a9b827942d4474d2725bf07454122390c931b19a9f215b1ab5804d5ba0856245dd6da7b7ecfebcd1155eb6b52d453887b6c513afeef1180ff1b49963", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eff4949cd6580fa832dc42a27274376f870f45794f10029331ce06449cc0f8e5073f2ccf3de2f900ca9d092bb581c9cf51e5f405f6e34dde92e313e4a0cf652"} build_url:https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010909 build_url: 'https://queue.taskcluster.net/v1/task/BAtxkANVToqwt5-qCmEwXQ/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/7e4bb251a9b827942d4474d2725bf07454122390c931b19a9f215b1ab5804d5ba0856245dd6da7b7ecfebcd1155eb6b52d453887b6c513afeef1180ff1b49963", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eff4949cd6580fa832dc42a27274376f870f45794f10029331ce06449cc0f8e5073f2ccf3de2f900ca9d092bb581c9cf51e5f405f6e34dde92e313e4a0cf652"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 17:59:35.073884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:59:35.074209) ========= 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.FbKxckMvg8/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.HdMX1ax5Dc/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005268 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 17:59:35.226676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 17:59:35.227012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 17:59:35.227434) ========= ========= Total master_lag: 6.37 =========