builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0187 starttime: 1459769793.73 results: success (0) buildid: 20160404024022 builduid: 4290f01da82c4f2dae9bc8abc5ec8ee0 revision: 2ffa9007ef203a29052b6db3e1dd63c0349cc70e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.730686) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.731719) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.732488) ========= 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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005865 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.760360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.761067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.778986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.779652) ========= 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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005712 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.831705) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.832415) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.832993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:33.833303) ========= 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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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-04 04:36:33-- 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% 9.98M=0.001s 2016-04-04 04:36:33 (9.98 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:34.009632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:34.010005) ========= 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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.020969 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:34.060992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 04:36:34.061368) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2ffa9007ef203a29052b6db3e1dd63c0349cc70e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2ffa9007ef203a29052b6db3e1dd63c0349cc70e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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-04 04:36:34,134 truncating revision to first 12 chars 2016-04-04 04:36:34,134 Setting DEBUG logging. 2016-04-04 04:36:34,134 attempt 1/10 2016-04-04 04:36:34,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2ffa9007ef20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 04:36:35,518 unpacking tar archive at: fx-team-2ffa9007ef20/testing/mozharness/ program finished with exit code 0 elapsedTime=1.633445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 04:36:35.717747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:35.719065) ========= echo 2ffa9007ef203a29052b6db3e1dd63c0349cc70e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2ffa9007ef203a29052b6db3e1dd63c0349cc70e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 2ffa9007ef203a29052b6db3e1dd63c0349cc70e program finished with exit code 0 elapsedTime=0.005319 script_repo_revision: '2ffa9007ef203a29052b6db3e1dd63c0349cc70e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:35.777135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:35.777819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 04:36:35.794092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-04 04:36:35.794623) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:36:35 INFO - MultiFileLogger online at 20160404 04:36:35 in /builds/slave/test 04:36:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:35 INFO - {'append_to_log': False, 04:36:35 INFO - 'base_work_dir': '/builds/slave/test', 04:36:35 INFO - 'blob_upload_branch': 'Fx-Team', 04:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:35 INFO - 'branch': 'Fx-Team', 04:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:35 INFO - 'config_files': ('talos/mac_config.py',), 04:36:35 INFO - 'default_actions': ('clobber', 04:36:35 INFO - 'read-buildbot-config', 04:36:35 INFO - 'download-and-extract', 04:36:35 INFO - 'populate-webroot', 04:36:35 INFO - 'create-virtualenv', 04:36:35 INFO - 'install', 04:36:35 INFO - 'run-tests'), 04:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:35 INFO - 'download_minidump_stackwalk': True, 04:36:35 INFO - 'download_symbols': 'ondemand', 04:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:35 INFO - 'installer_path': 'installer.exe', 04:36:35 INFO - 'log_level': 'info', 04:36:35 INFO - 'log_name': 'talos', 04:36:35 INFO - 'log_to_console': True, 04:36:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:36:35 INFO - 'opt_config_files': (), 04:36:35 INFO - 'pip_index': False, 04:36:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:35 INFO - 'cmd': ('bash', 04:36:35 INFO - '-c', 04:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:35 INFO - 'enabled': True, 04:36:35 INFO - 'halt_on_failure': False, 04:36:35 INFO - 'name': 'check_screen_resolution'},), 04:36:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:35 INFO - 'cmd': ('bash', 04:36:35 INFO - '-c', 04:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:35 INFO - 'enabled': True, 04:36:35 INFO - 'halt_on_failure': False, 04:36:35 INFO - 'name': 'check_screen_resolution'},), 04:36:35 INFO - 'run_cmd_checks_enabled': True, 04:36:35 INFO - 'sps_profile': False, 04:36:35 INFO - 'sps_profile_interval': 0, 04:36:35 INFO - 'suite': 'dromaeojs', 04:36:35 INFO - 'system_bits': '32', 04:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:35 INFO - 'title': 't-yosemite-r7-0187', 04:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:35 INFO - 'use_talos_json': True, 04:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:35 INFO - 'work_dir': 'build'} 04:36:35 INFO - ##### 04:36:35 INFO - ##### Running clobber step. 04:36:35 INFO - ##### 04:36:35 INFO - Running pre-action listener: _resource_record_pre_action 04:36:35 INFO - Running main action method: clobber 04:36:35 INFO - rmtree: /builds/slave/test/build 04:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:37 INFO - Running post-action listener: _resource_record_post_action 04:36:37 INFO - ##### 04:36:37 INFO - ##### Running read-buildbot-config step. 04:36:37 INFO - ##### 04:36:37 INFO - Running pre-action listener: _resource_record_pre_action 04:36:37 INFO - Running main action method: read_buildbot_config 04:36:37 INFO - Using buildbot properties: 04:36:37 INFO - { 04:36:37 INFO - "project": "", 04:36:37 INFO - "product": "firefox", 04:36:37 INFO - "script_repo_revision": "production", 04:36:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:36:37 INFO - "repository": "", 04:36:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:36:37 INFO - "buildid": "20160404024022", 04:36:37 INFO - "pgo_build": "False", 04:36:37 INFO - "basedir": "/builds/slave/test", 04:36:37 INFO - "buildnumber": 575, 04:36:37 INFO - "slavename": "t-yosemite-r7-0187", 04:36:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:36:37 INFO - "platform": "yosemite_r7", 04:36:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:36:37 INFO - "branch": "fx-team", 04:36:37 INFO - "repo_path": "integration/fx-team", 04:36:37 INFO - "revision": "2ffa9007ef203a29052b6db3e1dd63c0349cc70e", 04:36:37 INFO - "stage_platform": "macosx64", 04:36:37 INFO - "builduid": "4290f01da82c4f2dae9bc8abc5ec8ee0", 04:36:37 INFO - "slavebuilddir": "test" 04:36:37 INFO - } 04:36:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:36:37 INFO - Running post-action listener: _resource_record_post_action 04:36:37 INFO - ##### 04:36:37 INFO - ##### Running download-and-extract step. 04:36:37 INFO - ##### 04:36:37 INFO - Running pre-action listener: _resource_record_pre_action 04:36:37 INFO - Running main action method: download_and_extract 04:36:37 INFO - mkdir: /builds/slave/test/build/tests 04:36:37 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')]} 04:36:37 INFO - https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:39 INFO - Downloaded 1199 bytes. 04:36:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:36:39 INFO - Using the following test package requirements: 04:36:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:36:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:36:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:36:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'jsshell-mac.zip'], 04:36:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:36:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:36:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:36:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:36:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:36:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:36:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:36:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:36: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')]} 04:36:39 INFO - https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:40 INFO - Downloaded 17959645 bytes. 04:36:40 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'] 04:36:40 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 04:36:43 INFO - Return code: 0 04:36:43 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 04:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:43 INFO - https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:44 INFO - Downloaded 17959645 bytes. 04:36:44 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'] 04:36:44 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 04:36:48 INFO - Return code: 0 04:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:36:48 INFO - https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:49 INFO - Downloaded 10847584 bytes. 04:36:49 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'] 04:36:49 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 04:36:49 INFO - Return code: 0 04:36: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')]} 04:36:49 INFO - https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mf5SF14WTQy6slCf5Y_pLw/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 04:36:52 INFO - Downloaded 111245496 bytes. 04:36:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:36:52 INFO - mkdir: /builds/slave/test/properties 04:36:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:52 INFO - Contents: 04:36:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:36:53 INFO - Running post-action listener: _resource_record_post_action 04:36:53 INFO - Running post-action listener: set_extra_try_arguments 04:36:53 INFO - ##### 04:36:53 INFO - ##### Running populate-webroot step. 04:36:53 INFO - ##### 04:36:53 INFO - Running pre-action listener: _resource_record_pre_action 04:36:53 INFO - Running main action method: populate_webroot 04:36:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:53 INFO - '--tppagecycles', 04:36:53 INFO - '7'], 04:36:53 INFO - 'tests': ['tsvgm']}}, 04:36:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:36:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:36:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'tests': ['damp', 'tps']}, 04:36:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['damp', 'tps']}, 04:36:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:36:53 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['dromaeo_dom']}, 04:36:53 INFO - 'other': {'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other_l64': {'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'other_nol64': {'tests': ['a11yr', 04:36:53 INFO - 'ts_paint', 04:36:53 INFO - 'tpaint', 04:36:53 INFO - 'sessionrestore', 04:36:53 INFO - 'sessionrestore_no_auto_restore', 04:36:53 INFO - 'tabpaint']}, 04:36:53 INFO - 'svgr': {'tests': ['tsvgx', 04:36:53 INFO - 'tsvgr_opacity', 04:36:53 INFO - 'tart', 04:36:53 INFO - 'tscrollx', 04:36:53 INFO - 'cart']}, 04:36:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['tsvgx', 04:36:53 INFO - 'tsvgr_opacity', 04:36:53 INFO - 'tart', 04:36:53 INFO - 'tscrollx', 04:36:53 INFO - 'cart']}, 04:36:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'tests': ['tp5o']}, 04:36:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--e10s'], 04:36:53 INFO - 'tests': ['tp5o']}, 04:36:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--xperf_path', 04:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:53 INFO - 'tests': ['tp5n']}, 04:36:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:53 INFO - 'talos_options': ['--e10s', 04:36:53 INFO - '--xperf_path', 04:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:53 INFO - 'tests': ['tp5n']}}, 04:36:53 INFO - 'talos.zip': {'path': '', 04:36:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:53 INFO - Running post-action listener: _resource_record_post_action 04:36:53 INFO - ##### 04:36:53 INFO - ##### Running create-virtualenv step. 04:36:53 INFO - ##### 04:36:53 INFO - Running pre-action listener: _resource_record_pre_action 04:36:53 INFO - Running main action method: create_virtualenv 04:36:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:53 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 04:36:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:53 INFO - Using real prefix '/tools/python27' 04:36:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:57 INFO - Installing pip.................done. 04:36:57 INFO - Return code: 0 04:36:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:57 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')]} 04:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:57 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')]} 04:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:57 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:36:57 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 04:36:57 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 04:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:57 INFO - 'HOME': '/Users/cltbld', 04:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:57 INFO - 'LOGNAME': 'cltbld', 04:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:57 INFO - 'MOZ_NO_REMOTE': '1', 04:36:57 INFO - 'NO_EM_RESTART': '1', 04:36:57 INFO - 'PAGER': '/bin/cat', 04:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:57 INFO - 'PWD': '/builds/slave/test', 04:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:57 INFO - 'SHELL': '/bin/bash', 04:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:36:57 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:57 INFO - 'USER': 'cltbld', 04:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:57 INFO - 'XPC_FLAGS': '0x0', 04:36:57 INFO - 'XPC_SERVICE_NAME': '0', 04:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:57 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 04:36:57 INFO - Cleaning up... 04:36:57 INFO - Return code: 0 04:36:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:36:57 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')]} 04:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:57 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')]} 04:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:57 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:36:57 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 04:36:57 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 04:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:57 INFO - 'HOME': '/Users/cltbld', 04:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:57 INFO - 'LOGNAME': 'cltbld', 04:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:57 INFO - 'MOZ_NO_REMOTE': '1', 04:36:57 INFO - 'NO_EM_RESTART': '1', 04:36:57 INFO - 'PAGER': '/bin/cat', 04:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:57 INFO - 'PWD': '/builds/slave/test', 04:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:57 INFO - 'SHELL': '/bin/bash', 04:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:36:57 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:57 INFO - 'USER': 'cltbld', 04:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:57 INFO - 'XPC_FLAGS': '0x0', 04:36:57 INFO - 'XPC_SERVICE_NAME': '0', 04:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:58 INFO - Downloading/unpacking psutil>=0.7.1 04:36:58 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 04:36:58 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 04:36:58 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 04:36:58 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 04:36:58 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 04:36:58 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 04:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:00 INFO - Installing collected packages: psutil 04:37:00 INFO - Running setup.py install for psutil 04:37:00 INFO - building 'psutil._psutil_osx' extension 04:37:00 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 04:37:00 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 04:37:01 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 04:37:01 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 04:37:01 INFO - building 'psutil._psutil_posix' extension 04:37:01 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 04:37:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:01 INFO - ^ 04:37:01 INFO - 1 warning generated. 04:37:01 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 04:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:01 INFO - Successfully installed psutil 04:37:01 INFO - Cleaning up... 04:37:01 INFO - Return code: 0 04:37:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:01 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')]} 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:01 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')]} 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:01 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:01 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 04:37:01 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 04:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:01 INFO - 'HOME': '/Users/cltbld', 04:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:01 INFO - 'LOGNAME': 'cltbld', 04:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:01 INFO - 'MOZ_NO_REMOTE': '1', 04:37:01 INFO - 'NO_EM_RESTART': '1', 04:37:01 INFO - 'PAGER': '/bin/cat', 04:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:01 INFO - 'PWD': '/builds/slave/test', 04:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:01 INFO - 'SHELL': '/bin/bash', 04:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:01 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:01 INFO - 'USER': 'cltbld', 04:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:01 INFO - 'XPC_FLAGS': '0x0', 04:37:01 INFO - 'XPC_SERVICE_NAME': '0', 04:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:01 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 04:37:01 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 04:37:01 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 04:37:01 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 04:37:01 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 04:37:01 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 04:37:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:37:04 INFO - Installing collected packages: mozsystemmonitor 04:37:04 INFO - Running setup.py install for mozsystemmonitor 04:37:04 INFO - Successfully installed mozsystemmonitor 04:37:04 INFO - Cleaning up... 04:37:04 INFO - Return code: 0 04:37:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:04 INFO - 'HOME': '/Users/cltbld', 04:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:04 INFO - 'LOGNAME': 'cltbld', 04:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:04 INFO - 'MOZ_NO_REMOTE': '1', 04:37:04 INFO - 'NO_EM_RESTART': '1', 04:37:04 INFO - 'PAGER': '/bin/cat', 04:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:04 INFO - 'PWD': '/builds/slave/test', 04:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:04 INFO - 'SHELL': '/bin/bash', 04:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:04 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:04 INFO - 'USER': 'cltbld', 04:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:04 INFO - 'XPC_FLAGS': '0x0', 04:37:04 INFO - 'XPC_SERVICE_NAME': '0', 04:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:08 INFO - Downloading docopt-0.6.1.tar.gz 04:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:08 INFO - Running setup.py install for blobuploader 04:37:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:08 INFO - Running setup.py install for requests 04:37:08 INFO - Running setup.py install for docopt 04:37:09 INFO - Successfully installed blobuploader requests docopt 04:37:09 INFO - Cleaning up... 04:37:09 INFO - Return code: 0 04:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:09 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 04:37:09 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 04:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:09 INFO - 'HOME': '/Users/cltbld', 04:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:09 INFO - 'LOGNAME': 'cltbld', 04:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:09 INFO - 'MOZ_NO_REMOTE': '1', 04:37:09 INFO - 'NO_EM_RESTART': '1', 04:37:09 INFO - 'PAGER': '/bin/cat', 04:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:09 INFO - 'PWD': '/builds/slave/test', 04:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:09 INFO - 'SHELL': '/bin/bash', 04:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:09 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:09 INFO - 'USER': 'cltbld', 04:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:09 INFO - 'XPC_FLAGS': '0x0', 04:37:09 INFO - 'XPC_SERVICE_NAME': '0', 04:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-HoS4Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-laWTmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-SCCYFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-f_Itaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:09 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-y50yps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-8rF3A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-idhi83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-TrqrtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-dqN57p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-OIle_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-8FSHJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-4PEfKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-GX1F22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-Bx1Wmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:10 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-65M1l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:11 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-hUngWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:11 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-LDHObH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:11 INFO - Running setup.py install for manifestparser 04:37:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:11 INFO - Running setup.py install for mozcrash 04:37:11 INFO - Running setup.py install for mozdebug 04:37:11 INFO - Running setup.py install for mozdevice 04:37:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:11 INFO - Running setup.py install for mozfile 04:37:12 INFO - Running setup.py install for mozhttpd 04:37:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozinfo 04:37:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozInstall 04:37:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozleak 04:37:12 INFO - Running setup.py install for mozlog 04:37:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for moznetwork 04:37:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:12 INFO - Running setup.py install for mozprocess 04:37:13 INFO - Running setup.py install for mozprofile 04:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozrunner 04:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozscreenshot 04:37:13 INFO - Running setup.py install for moztest 04:37:13 INFO - Running setup.py install for mozversion 04:37:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:13 INFO - Cleaning up... 04:37:13 INFO - Return code: 0 04:37:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:13 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:13 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 04:37:13 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 04:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:13 INFO - 'HOME': '/Users/cltbld', 04:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:13 INFO - 'LOGNAME': 'cltbld', 04:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:13 INFO - 'MOZ_NO_REMOTE': '1', 04:37:13 INFO - 'NO_EM_RESTART': '1', 04:37:13 INFO - 'PAGER': '/bin/cat', 04:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:13 INFO - 'PWD': '/builds/slave/test', 04:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:13 INFO - 'SHELL': '/bin/bash', 04:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:13 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:13 INFO - 'USER': 'cltbld', 04:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:13 INFO - 'XPC_FLAGS': '0x0', 04:37:13 INFO - 'XPC_SERVICE_NAME': '0', 04:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-eI3w6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-lmvr5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-V9G9rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-XEmHSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-b0GECX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-cE3D2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-D1QFLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:14 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)) 04:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:14 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-7YC1Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-RjK2c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-jCwFXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-4ebtLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-i65uHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-C7_xXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-KzNZFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-Qe2DkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-0jj_rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:15 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)) 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:15 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-e7vWaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 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)) 04:37:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:18 INFO - Downloading blessings-1.6.tar.gz 04:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:18 INFO - Installing collected packages: blessings 04:37:18 INFO - Running setup.py install for blessings 04:37:18 INFO - Successfully installed blessings 04:37:18 INFO - Cleaning up... 04:37:18 INFO - Return code: 0 04:37:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:19 INFO - Reading from file tmpfile_stdout 04:37:19 INFO - Current package versions: 04:37:19 INFO - blessings == 1.6 04:37:19 INFO - blobuploader == 1.2.4 04:37:19 INFO - docopt == 0.6.1 04:37:19 INFO - manifestparser == 1.1 04:37:19 INFO - mozInstall == 1.12 04:37:19 INFO - mozcrash == 0.17 04:37:19 INFO - mozdebug == 0.1 04:37:19 INFO - mozdevice == 0.48 04:37:19 INFO - mozfile == 1.2 04:37:19 INFO - mozhttpd == 0.7 04:37:19 INFO - mozinfo == 0.9 04:37:19 INFO - mozleak == 0.1 04:37:19 INFO - mozlog == 3.1 04:37:19 INFO - moznetwork == 0.27 04:37:19 INFO - mozprocess == 0.22 04:37:19 INFO - mozprofile == 0.28 04:37:19 INFO - mozrunner == 6.11 04:37:19 INFO - mozscreenshot == 0.1 04:37:19 INFO - mozsystemmonitor == 0.0 04:37:19 INFO - moztest == 0.7 04:37:19 INFO - mozversion == 1.4 04:37:19 INFO - psutil == 3.1.1 04:37:19 INFO - requests == 1.2.3 04:37:19 INFO - wsgiref == 0.1.2 04:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:19 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')]} 04:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:19 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')]} 04:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:19 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:19 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 04:37:19 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 04:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:19 INFO - 'HOME': '/Users/cltbld', 04:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:19 INFO - 'LOGNAME': 'cltbld', 04:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:19 INFO - 'MOZ_NO_REMOTE': '1', 04:37:19 INFO - 'NO_EM_RESTART': '1', 04:37:19 INFO - 'PAGER': '/bin/cat', 04:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:19 INFO - 'PWD': '/builds/slave/test', 04:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:19 INFO - 'SHELL': '/bin/bash', 04:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:19 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:19 INFO - 'USER': 'cltbld', 04:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:19 INFO - 'XPC_FLAGS': '0x0', 04:37:19 INFO - 'XPC_SERVICE_NAME': '0', 04:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 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)) 04:37:19 INFO - Cleaning up... 04:37:19 INFO - Return code: 0 04:37:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37:19 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')]} 04:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:19 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')]} 04:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:19 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 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:19 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 04:37:19 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 04:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:19 INFO - 'HOME': '/Users/cltbld', 04:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:19 INFO - 'LOGNAME': 'cltbld', 04:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:19 INFO - 'MOZ_NO_REMOTE': '1', 04:37:19 INFO - 'NO_EM_RESTART': '1', 04:37:19 INFO - 'PAGER': '/bin/cat', 04:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:19 INFO - 'PWD': '/builds/slave/test', 04:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:19 INFO - 'SHELL': '/bin/bash', 04:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:19 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:19 INFO - 'USER': 'cltbld', 04:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:19 INFO - 'XPC_FLAGS': '0x0', 04:37:19 INFO - 'XPC_SERVICE_NAME': '0', 04:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:19 INFO - Downloading/unpacking jsonschema 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 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 04:37:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:21 INFO - Downloading/unpacking functools32 (from jsonschema) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:22 INFO - warning: no files found matching '*.txt' 04:37:22 INFO - no previously-included directories found matching 'build' 04:37:22 INFO - no previously-included directories found matching 'dist' 04:37:22 INFO - no previously-included directories found matching '.git*' 04:37:22 INFO - Installing collected packages: jsonschema, functools32 04:37:22 INFO - Running setup.py install for functools32 04:37:22 INFO - warning: no files found matching '*.txt' 04:37:22 INFO - no previously-included directories found matching 'build' 04:37:22 INFO - no previously-included directories found matching 'dist' 04:37:22 INFO - no previously-included directories found matching '.git*' 04:37:22 INFO - Successfully installed jsonschema functools32 04:37:22 INFO - Cleaning up... 04:37:22 INFO - Return code: 0 04:37:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10457da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10458d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9112cd54c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, '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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 04:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:22 INFO - 'HOME': '/Users/cltbld', 04:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:22 INFO - 'LOGNAME': 'cltbld', 04:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:22 INFO - 'MOZ_NO_REMOTE': '1', 04:37:22 INFO - 'NO_EM_RESTART': '1', 04:37:22 INFO - 'PAGER': '/bin/cat', 04:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:22 INFO - 'PWD': '/builds/slave/test', 04:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:22 INFO - 'SHELL': '/bin/bash', 04:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:37:22 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:22 INFO - 'USER': 'cltbld', 04:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:22 INFO - 'XPC_FLAGS': '0x0', 04:37:22 INFO - 'XPC_SERVICE_NAME': '0', 04:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:22 INFO - Downloading/unpacking flake8 04:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:37:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:37:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:37:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:37:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:37:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:37:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:37:26 INFO - no previously-included directories found matching 'docs/_build' 04:37:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:37:26 INFO - Running setup.py install for pep8 04:37:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:37:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:37:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:37:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:37:26 INFO - no previously-included directories found matching 'docs/_build' 04:37:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:37:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:37:26 INFO - Cleaning up... 04:37:26 INFO - Return code: 0 04:37:26 INFO - Running post-action listener: _resource_record_post_action 04:37:26 INFO - Running post-action listener: _start_resource_monitoring 04:37:27 INFO - Starting resource monitoring. 04:37:27 INFO - ##### 04:37:27 INFO - ##### Running install step. 04:37:27 INFO - ##### 04:37:27 INFO - Running pre-action listener: _resource_record_pre_action 04:37:27 INFO - Running main action method: install 04:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:27 INFO - Reading from file tmpfile_stdout 04:37:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:27 INFO - Reading from file tmpfile_stdout 04:37:27 INFO - Output received: 04:37:27 INFO - Usage: mozinstall [options] installer 04:37:27 INFO - Options: 04:37:27 INFO - -h, --help show this help message and exit 04:37:27 INFO - -d DEST, --destination=DEST 04:37:27 INFO - Directory to install application into. [default: 04:37:27 INFO - "/builds/slave/test"] 04:37:27 INFO - --app=APP Application being installed. [default: firefox] 04:37:27 INFO - mkdir: /builds/slave/test/build/application 04:37:27 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'] 04:37:27 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 04:38:01 INFO - Reading from file tmpfile_stdout 04:38:01 INFO - Output received: 04:38:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:38:01 INFO - Running post-action listener: _resource_record_post_action 04:38:01 INFO - ##### 04:38:01 INFO - ##### Running run-tests step. 04:38:01 INFO - ##### 04:38:01 INFO - Running pre-action listener: _resource_record_pre_action 04:38:01 INFO - Running main action method: run_tests 04:38:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:01 INFO - 2016-04-04 04:38:01.536 screenresolution[2288:72332] starting screenresolution argv=screenresolution get 04:38:01 INFO - 2016-04-04 04:38:01.539 screenresolution[2288:72332] Display 0: 1600x1200x32@60 04:38:01 INFO - 2016-04-04 04:38:01.545 screenresolution[2289:72334] starting screenresolution argv=screenresolution list 04:38:01 INFO - Available Modes on Display 0 04:38:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:01 INFO - Intel Iris: 04:38:01 INFO - Chipset Model: Intel Iris 04:38:01 INFO - Type: GPU 04:38:01 INFO - Bus: Built-In 04:38:01 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:01 INFO - Vendor: Intel (0x8086) 04:38:01 INFO - Device ID: 0x0a2e 04:38:01 INFO - Revision ID: 0x0009 04:38:01 INFO - Displays: 04:38:01 INFO - Display: 04:38:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:01 INFO - Display Serial Number: 1600x1200 60 04:38:01 INFO - Main Display: Yes 04:38:01 INFO - Mirror: Off 04:38:01 INFO - Online: Yes 04:38:01 INFO - Rotation: Supported 04:38:01 INFO - Return code: 0 04:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:01 INFO - Python 2.7.3 04:38:01 INFO - Return code: 0 04:38:01 INFO - grabbing minidump binary from tooltool 04:38:01 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')]} 04:38:01 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 0x10441ce00>, '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 0x104245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104417b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:01 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 04:38:01 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 04:38:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:01 INFO - Return code: 0 04:38:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:03 INFO - Return code: 0 04:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0187', '--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 04:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0187 --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 04:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gbNNcXmQI8/Render', 04:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:03 INFO - 'HOME': '/Users/cltbld', 04:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:03 INFO - 'LOGNAME': 'cltbld', 04:38:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:03 INFO - 'MOZ_NO_REMOTE': '1', 04:38:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:03 INFO - 'NO_EM_RESTART': '1', 04:38:03 INFO - 'PAGER': '/bin/cat', 04:38:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:03 INFO - 'PWD': '/builds/slave/test', 04:38:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:03 INFO - 'SHELL': '/bin/bash', 04:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uVaeJmTXNd/Listeners', 04:38:03 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 04:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:03 INFO - 'USER': 'cltbld', 04:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:03 INFO - 'XPC_FLAGS': '0x0', 04:38:03 INFO - 'XPC_SERVICE_NAME': '0', 04:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0187', '--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 04:38:03 INFO - mozversion application_buildid: 20160404024022 04:38:03 INFO - mozversion application_changeset: 2ffa9007ef203a29052b6db3e1dd63c0349cc70e 04:38:03 INFO - mozversion application_display_name: Nightly 04:38:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:03 INFO - mozversion application_name: Firefox 04:38:03 INFO - mozversion application_remotingname: firefox 04:38:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:38:03 INFO - mozversion application_vendor: Mozilla 04:38:03 INFO - mozversion application_version: 48.0a1 04:38:03 INFO - mozversion platform_buildid: 20160404024022 04:38:03 INFO - mozversion platform_changeset: 2ffa9007ef203a29052b6db3e1dd63c0349cc70e 04:38:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:38:03 INFO - mozversion platform_version: 48.0a1 04:38:03 INFO - using testdate: 1459769883 04:38:03 INFO - actual date: 1459769883 04:38:03 INFO - starting webserver on 'localhost:53374' 04:38:03 INFO - SUITE-START | Running 2 tests 04:38:03 INFO - TEST-START | dromaeo_css 04:38:03 INFO - operating with platform_type : mac_ 04:38:03 INFO - Initialising browser for dromaeo_css test... 04:38:03 INFO - TEST-INFO | started process 2307 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmp9ffrTw/profile http://localhost:53374/getInfo.html) 04:38:05 INFO - PROCESS | 2307 | __metrics Screen width/height:1600/1200 04:38:05 INFO - PROCESS | 2307 | colorDepth:24 04:38:05 INFO - PROCESS | 2307 | Browser inner width/height: 1024/689 04:38:05 INFO - PROCESS | 2307 | __metrics 04:38:05 INFO - PROCESS | 2307 | 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" 04:38:05 ERROR - PROCESS | 2307 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:38:06 INFO - TEST-INFO | 2307: exit 0 04:38:06 INFO - Browser initialized. 04:38:06 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:06 INFO - TEST-INFO | started process 2309 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmp9ffrTw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:18 INFO - PROCESS | 2309 | RSS: Main: 236331008 04:38:18 INFO - PROCESS | 2309 | 04:39:09 INFO - PROCESS | 2309 | 1459769949290 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] 04:41:19 INFO - PROCESS | 2309 | Cycle 1(1): loaded http://localhost:53374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53374/tests/dromaeo/cssquery-ext.html) 04:41:21 INFO - PROCESS | 2309 | RSS: Main: 327233536 04:41:21 INFO - PROCESS | 2309 | 04:44:23 INFO - PROCESS | 2309 | Cycle 1(1): loaded http://localhost:53374/tests/dromaeo/cssquery-ext.html (next: http://localhost:53374/tests/dromaeo/cssquery-jquery.html) 04:44:24 INFO - PROCESS | 2309 | RSS: Main: 364142592 04:44:24 INFO - PROCESS | 2309 | 04:47:26 INFO - PROCESS | 2309 | Cycle 1(1): loaded http://localhost:53374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53374/tests/dromaeo/cssquery-mootools.html) 04:47:26 INFO - PROCESS | 2309 | RSS: Main: 365809664 04:47:26 INFO - PROCESS | 2309 | 04:50:28 INFO - PROCESS | 2309 | Cycle 1(1): loaded http://localhost:53374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53374/tests/dromaeo/cssquery-prototype.html) 04:50:29 INFO - PROCESS | 2309 | RSS: Main: 327536640 04:50:29 INFO - PROCESS | 2309 | 04:53:32 INFO - PROCESS | 2309 | Cycle 1(1): loaded http://localhost:53374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53374/tests/dromaeo/cssquery-yui.html) 04:53:33 INFO - PROCESS | 2309 | RSS: Main: 327704576 04:53:33 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | Cycle 1(1): loaded http://localhost:53374/tests/dromaeo/cssquery-yui.html (next: http://localhost:53374/tests/dromaeo/cssquery-dojo.html) 04:56:36 INFO - PROCESS | 2309 | RSS: Main: 380133376 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | __start_tp_report 04:56:36 INFO - PROCESS | 2309 | _x_x_mozilla_page_load 04:56:36 INFO - PROCESS | 2309 | _x_x_mozilla_page_load_details 04:56:36 INFO - PROCESS | 2309 | |i|pagename|runs| 04:56:36 INFO - PROCESS | 2309 | |0;dojo.html;3371.359441706076;3401.982990085049;3432.2449061206535;3449.1721986723196;3486.8953931382066;5574.358948720898;5627.493525582697;5697.287839020122;5745.913811292834;5772.624779389337;5552.555795536357;5693.089105743082;5698.857528561788;5738.655680659163;5750.654960702351;5128.666636668623;5131.615128865331;5153.665011774223;5185.170372740362;5284.709340986245;5266.394364648077;5278;5310.946890531103;5340.038793017256;5378.677279363231;5122.334096567422;5150.356205474316;5218.112920803473;5230.34620672416;5231.241469986869;5216.739163041871;5234.319538460014;5236.738163091868;5238.476152384769;5308.442613525602;5156.561692256163;5176.7411629418375;5214.634975551713;5245.344331958505;5247.212918062283;5478.890422191534;5570.080936645449;5598.748056337475;5621.100623900156;5696.544276457874;6130.601510901777;6149.385061493815;6157.168782214389;6164.352742961969;6181.938180618226;5447.754851031713;6114.2357205349335;6147.661878596676;6151.415615516519;6164.352742961969;5705.087186050254;5742.397048309951;5814.244148260699;5842.357340692521;5854.619449735754;6205.627662340274;6213.03697926822;6247.187865577446;6255.624662520172;6255.655938923403;6054.424829641265;6073.635581865014;6112.572119951649;6161.507079433724;6168.475679567197;6127.938720612826;6144.201253837062;6161.537884658668;6163.322034576193;6170.197874276315;6137.8673257933415;6148.262208534915;6149.692515374303;6164.260288765287;6174.413430724074;6122.173506576555;6140.846478838065;6143.38566143391;6162.938370616326;6165.660888651168;4731.858044258678;4852.51474852519;4876.853694389174;4886;4926.482719314492;4392.407025051641;4431.33529970507;4440.444944381952;4450.354698568754;4460.1971645104195;5661.320641523043;5728.513076388554;5743.62666426681;5747.310322761212;5758.1362795581;6103.701349646901;6148.600340977822;6149.692515374213;6161.322254551996;6165.10605962133;5729.914051289234;5749.051406517961;5758.654480731169;5765.336986246635;5783.363829978699;5256.526912577886;5317.574594032545;5345.9465405345445;5354.41101478837;5356.544693701001;6193.411625895533;6251.187345645037;6255.874882502416;6264.655443950626;6276.497880169575;6081.118237855398;6121.755129794758;6136.570440069152;6138.754449821957;6165.198524191826;5878;6097.25246653012;6224.37756224374;6235.501159907287;6270.7805226816845;6163.075538669235;6168.414000669929;6201.0388389799655;6208.937910621016;6211.565190436626;6217;6227;6236.376362363909;6238.064290356483;6248.062790581449;5929.347771745019;5979.671118088547;6082.026875700044;6082.513398928164;6116.174316467398;5161.380634323905;5370.54152629115;6072.544559158169;6090.634561926298;6094.329623741473;5933.347331793586;5952.940470595238;5954.136650185612;5967.940320596738;5989.3112292085225;5894.616849904743;5982.282126144891;6106.1451396803595;6112.473085128157;6115.331611965906;5909.734061967136;5912.172295878494;5924.555658325557;5926.1999630049395;5952.315483719428 04:56:36 INFO - PROCESS | 2309 | |1;ext.html;459.06121980549796;524.7223011965862;594.1622312539317;640.6572483721209;644.7066584703958;27966.580501292472;30263.24341891454;37846.810765946204;38337.808310958404;38401.423978640276;41367;41776.79111604446;41813;41859;41994;9428.622855085789;9632.903670963306;9643.469609171492;9643.90356096437;9659.468729219925;9482.956874743808;9608.80782384352;9624;9629.470379129145;9634;9566.521673916312;9637;9763.365381250196;9768.560414781316;9777.902220977805;9662.661806836762;9739.561719722595;9745.512724363789;9751;9751.976042515576;9560.713178604654;9662.227021838236;9667.984861589572;9676.70969870905;9695.806083878353;40262.19475610471;40633.59366406328;40680.79659601713;40699;40716;3273.819939903304;3370.8146051967133;3401.183715908189;3439.2605589798313;3896.9220615587815;28059.438811223867;28327.15018549447;28452.430951381062;28566.857165714246;28982.42035159285;2721.0612338743103;2747.8213916095588;2752.944941101167;2874.3101655602713;2935.222166125978;479848;481145;481396;482229;482827;44983.32525012128;45827.77086114548;46126.30810537845;65147.348526515074;65597.34402656008;44597.55402445999;45001.77499112549;45090.32364514535;45183.774081129384;45261.09477810491;15512.457064002705;15669.294881730122;15680.529584112495;15682.68634627301;15689.607759806097;12582.622521324374;12640.178388404724;12646.873531264753;12665;12675.746485070247;14421.639459013399;14457.349419276157;14458.421663133357;14498.927505362617;14595.124292542268;6121.173641558422;6193.628382297076;6205.627662340184;6252.406021427957;6262.373762623793;932.5710173320349;979.8383266760904;980.5734505490135;982.5627595719978;1003.3929472669076;25197.740112994277;28168.85915570409;28816.135515934555;29826.55260171099;29978.40043199124;944.1738478831023;1041.8645576075062;1072.619220176826;1075.9031687148195;1080.4219742437758;13906.652333691536;14083.577492675031;14215.85784142166;14219.36012879423;14240.287985600886;533918;535757;537910;538019;538402;58438;58714.706426467594;58754;58797.82404351889;58832.41167588269;1430.2920054573053;1457.744894643433;1482.044081567383;1485.1386196006506;1487.6132205626616;28216.730247139338;28332.15003549897;28619.856900715364;28755.856220718764;28946.84212631471;44434;44763.32855007242;44901.55098448974;44934.1013179728;44979.32531011972;321172;322476;324452;324527;325265;28053.43893122167;31991.68008319887;33063.83468082644;33095.66904331022;33115.840945566786;40469.785906422854;40831.79584102179;41206.38190427206;41506;41529;34545.65454345424;35877.64122358743;35933.64066359407;36600;36928.26143477169;35519.64480355164;35748;35905.28189436249;36249;36295.63704362923;35609.64390356167;35681.46477802887;35720.64279357277;35723;36190.09524761902;30379.544306835858;31366.215844604067;31377.744890204136;31420.685793141776;31440;23661.408464788517;23907.238924051046;23941.880290598434;24036;24236.39409014789 04:56:36 INFO - PROCESS | 2309 | |2;jquery.html;360.51150690813944;360.58532687409473;362.3749032918216;371.7713606132228;372.48596936228;19502.90248548757;20308.69536956945;20649.896750516265;20920.497926963402;21133.154673813067;15935.521934341989;20075.225902486076;20580;20706.792932070675;20752;5816.360200377955;6050.152978583002;6087.2086628738425;6101.237345331833;6106.511479081662;4246.129543443602;4297.183535128332;4388.253996820548;6021.849453763669;6663.233728121256;6431.839204019913;6608.735650573972;6691.431228345572;6715.2613212546585;6749.088873002131;6595.241547222083;6617.569857959217;6638.900416493757;6698.56459330142;6720.059191713164;3800.6959443244473;5051.141305977956;5268.31511903454;5281.947180528184;5715.513966368774;13082.215067096005;13628.591142265748;13652;24730.876345618155;24984;1955.7555305586802;2100.4643815826867;2228.7771222877745;2552.8468291902545;2732.6447561817035;9528.571214295373;9706.70879873598;9929.50352482373;10032.69901902944;10052.547635356426;1664.209500487271;1709.0856391830312;1710.7604935309066;1726.1800644693797;1801.5946412057183;95129.52435237849;98042.01957980401;98090;98671.0132898669;99940;9541.045895410403;10718.732031699114;10726.226829060994;11108.333499990027;11114;13636.250006249751;13706.560811114889;13708.45166193361;13715.519956801463;13732.931335343459;7848.411369147223;8393.286570641441;8395.70615028471;8519.57402129891;8519.659213631385;8520.8721869172;8538.573071346407;8573.614187361583;8678.56607169639;8682.43564168327;4300.440942677432;4341.934870976938;4367.951691593995;4438.267685831866;4452.354408610733;1779.7330400440037;1822.0798496759317;1822.9726554101435;1830.569816093217;1843.6589230992308;892.5626443042992;907.832051070554;1016.6390931219458;1033.493588141805;1094.190299178618;17738.65402976279;19616.545712629395;19993.900030499753;20189.49526261855;20717.482062948246;975.9560819763128;1005.3917379985149;1012.6607586458618;1048.2400259811727;1073.6510634043966;10834.730071147067;11026.338419694845;11225.382603956697;11535.480903359201;11934.701632459084;584479;587435;617954;638117.8094109499;642189;112297;120134;120172;123044.38477807553;123663;1080.6325849211305;1082.610260306289;1105.42517890698;1127.3461392392392;1155.0297749889965;15744.268130505407;17961.820381796013;18200.726989095438;18210.72683909716;18216.908915455337;38895.805520972215;48811.75594122149;50962.490375095775;51184;51657;67336.65326693536;72054;72656.54686906339;73660.89508657267;75844.62077689577;7587.962060189664;7810.648520816463;7950.4832185907735;7979.521228726295;8090.352771778126;11027.503762330874;12547.74904501923;12655;12865.678358041125;13008;10848.294860834336;10890.61882834097;11021.393823339793;11229.382383968634;11300.982911538002;10847.837282440612;10852.18608604342;10919.290246133976;11080.667579972614;11289.98390144891;10545.894541054491;11204.943975280072;11230.775384492428;11302.660920172408;11652.126090543412;7664.693412263447;7684.961575192088;7782.727604533814;7937.642806073856;8169.346452283922;9794.26543009263;10396.740081498023;10719.088877445505;10754.516046777757;10907.127429805438 04:56:36 INFO - PROCESS | 2309 | |3;mootools.html;1305.30818666107;1580.6917651058043;1622.9431969881057;1899.1833511590019;2023.5851650411666;7942.523448593089;8102.230288122626;8532.70135545256;8639.222469977702;8802.55987200639;8544.829103417927;8761.211490965812;8797.208251257385;8805.031446540892;8811.647534098629;2185.4208634711736;2398.2325655790155;2457.299669594166;2476.925692229236;2503.0488414402594;2512.6105453654623;2517.5845985412384;2518;2522.2937577478338;2523.911663091792;2272.2728726807427;2361.480474295652;2431.8419302745265;2486.5648511510503;2489.5892177790643;2403.891824867885;2404.3748625357443;2415.251272105644;2431.55016321981;2439.7194322652945;2459.692538432696;2464.236086813076;2474.1958863369478;2474.4679893822913;2498.4378514834198;8821.382503224777;8882.600282987281;8894.332925030649;8910.821783564292;8947.373683842134;5383.703896285702;5517.393086760453;5517.531009864167;5529.751161197756;5572.5263352615075;3503.789772613651;3561.7506774525796;3633.5094762207027;3704.833282502294;3723.4600982857605;1027.563285603623;1057.40256754934;1064.9414282214475;1072.0673014477377;1075.8278675411975;11945;11950.641480755592;11977.461014254379;11978.820317695328;11989;4860.343853579792;4881.8535443936735;4951.529604687549;4986.47641997585;4996.325496058058;10181.745456363502;10184.236182286359;10199.031092046243;10208.081272685495;10209.336393134423;5505.256790333334;5519.337679478488;5566.666000040011;5569.888602227933;5572.331320241597;4461.598456138963;4640.095181439587;4647.34937108805;4659.860204193879;4805.13507568641;3875.8062096895605;3919.941200881989;3974.16542526067;3977.880663580097;3996.540397854226;1305.771489989248;1315.4343632238229;1318.953836615733;1329.9335033248299;1331.8468376136675;1090.4765712457906;1110.5113749949996;1110.9444527773578;1278.3799857069314;1388.1532265318149;8182.059063207688;8207.466514676527;8310.127436619188;8313.08556058833;8324.167583241748;503.2375950435094;506.364512536764;510.6348960493265;512.5515174222555;527.8865044015555;6216.005439129717;6223.37766223374;6283.96858015707;6284.4344009039405;6291.402316779899;10412.219083568763;10773.138148948065;10898.782024359469;10909.563617455371;10915.23593348458;10510.789784204273;10619.36283822973;10635.41505217205;10701.036906678437;10761.085307748928;8298.958505207556;8351.248387645019;8367.414281000272;8410.537420441935;8423.831523369498;7817.101033381006;7948.523088614702;7967.880481792894;8006.679732810622;8034.919650803417;9365.484898330385;9513;9610.375325603813;9631.133198012212;9775.608975640895;9815.312928094965;9868.950655246965;9935.950320248352;10045.547950342398;10052.64815731446;6471.223453185459;6541.443977261986;7506.1743208248145;7575;7581.180516675848;7678.040244969379;8279.254867061993;8318.70884519039;8332.291755200633;8343.833123337621;7379.298966598165;7416.221296763762;7439.55362678241;7483.588402637907;7541.622918854145;6258.280297765633;7050.823729406806;7230.276972302728;7320.158181808947;7405.518641288299;7698.307152356315;7712.807179820549;7763.301302882767;7830.804229894298;7832.295093441618;7042.7887163385185;7053.858922821618;7109.182444019004;7114.466415018791;7114.964425177841;6328;7137.501124763858;7173.426125910019;7190.4607154464675;7227.747028853965 04:56:36 INFO - PROCESS | 2309 | |4;prototype.html;319.9040287913626;323.34683938444346;328.88982190966027;328.9391462579423;331.2645926044183;5430.647007944486;5745.626534275274;6325.7153428095735;6508.446782023528;6630.336966303379;6489.772857949973;6536.575122617039;6554.180727409074;6559.934400655992;6570.63861487618;4626.144163329778;4716.1982462981205;4735.85792426226;4745.383100196969;4891.755412229392;4214.136102099078;4819.373481447407;4820.39745031871;4825.324454576362;4887.437944636376;4808;4819.614430845524;4835.468098509161;4840.273958906175;4841.515848415165;4570.634349252052;4667.836625718083;4811.398575178103;4837.4920633333695;4850.054239423313;3649.85400583979;3936.665383442411;4116.814743336557;4117.3618089196225;4125.834966601363;5715.942840571583;5812.157237200625;6357.872842543169;6362.172917520739;6382.106505089291;5690.9146362804595;5699.316082070137;5704.971475142639;5705.286839145107;5718.285214348207;6033.939660603425;6950.096487456598;6955.234924158339;6977.581345119309;6997.440204783605;3906.3163946309564;4290.957090429087;4486.7980940857415;4500.482444518857;4630.791614377361;7318.3047610476915;7331.670074846591;7365.815854603624;7373.852522949564;7378.188399276021;4574.908501829945;4576.382188404589;4581.694217148097;4585.266357382803;4589.173948689268;4630.305454181899;4647.395838540968;4654.16225079489;4656.138614356355;4665.323528088408;5593.272874526286;5601.439856014447;5602.411746766612;5604.3835178130375;5611.242482264924;6023.6385816851125;6689.698963546554;6997.265287144878;7007.229204787469;7023.297670233038;1587.2460581223827;1595.058915240014;1613.5482065021813;1614.8869579129582;1615.8626516745974;967.8451447768323;1007.1791489935679;1009.9141572966233;1029.7374169586858;1034.534459493231;6376.521760867953;6386.968065159737;6398.680065996681;6407.871842563122;6409.230892292955;7047.365737083687;7189;7219.025431566672;7242.420606351585;7297.306755858185;5522.502974732213;6622.9006564901565;6630.30381809903;6636.2368327642935;6637.103990961255;3833.4441505981476;3891.20230352777;3892.630200130983;3894.2600905827803;3899.3566061600086;7290.817729556804;7683.231676832272;7693.230676932262;7695;7701.922980770232;7525.021747172942;7555.017847679766;7560.673303746334;7562.697492100255;7574.5076570022775;7634.656440460192;7650.081990161217;7655.961720191363;7656.80857978555;7673.61631918413;6957.860842783217;7290.671919763729;7338.816529586589;7341;7358.66885990121;7140.178879428932;7201.675924583511;7256.346928776436;7266.309700578437;7275.563466192046;7679.19368466303;7697.0378702662165;7708.691652333844;7738.92261077382;7746.845063098819;4563.885902852455;4600.355950166912;4610.077984403066;4618.56123668251;4619.722816631013;6932.584044957319;7298.270172982871;7301.707931682673;7322.231165727522;7328.193898671036;5477.780888764405;6989.685464154024;6990.755323563651;7007.194172670208;7018.192907815463;6966.442684585119;6994.755183568551;7009.12385951756;7015.403690686348;7016.403605693369;6833.453323734188;6843.62360070181;6848.486363522856;6855.862882742217;6859.5541289816;5916.290045194604;6747.122874026345;7024.1571011478945;7025.262347453444;7051.083359163481;6552.803415897531;6662.500312476487;6726.226483954212;6824.7952561423235;6841.042254084333 04:56:36 INFO - PROCESS | 2309 | |5;yui.html;693.1647364925265;727.9708811647531;752.8644843928091;756.2324240895489;759.2331744937613;14682.63293417665;14942.252887355617;14975.47585834496;14994.475193368235;15009.92495037526;11139.944300278508;13867.722645547083;13869.306534673276;13874;13882.305884705775;727.7271023366237;736.135041326442;888.2760550151605;891.5319457284928;919.1727445299217;900.6847603338812;907.5689047702322;909.1771946388529;910.9979023074632;911.6262332443699;975.9853602195973;981.1464026297132;983.3853841349156;984.7833476635165;986.6349450703214;772.8454309138167;963.8506031565119;983.0513554420019;984.6602921991902;987.0474991633108;730.9451791115688;732.5934106570851;733.2813842434444;734.5629350536423;735.9521631094016;14474.276286185648;14556.563303100924;14577.854221457861;14587.416503339853;14590.489332873298;12574.685632859251;12622.179558328678;12640.810387844189;12731.809022864665;12922.483100676056;10011;10181.898181018169;10526.736831579272;10576.312539684895;10787.190960677981;3490.7381946354126;3542.4863394807867;3616.4213725804007;3657.5976642569294;3815.4849095372324;76201;77165;79865.60067199684;80736;80829;9502.857457138149;9544.52277386128;9555.9044409555;9825.213982881352;9930.851037234448;22557.88721056417;22560;22817.88591057034;23073.653895191586;23122.421939451648;7724.227577242231;7728;7934.722284720007;8045.9597702011115;8146.796330091795;3588;4014.41790940312;4090.3046482098116;4126.381042843537;4131.111810960658;3608.3685355062757;3671.1372827385544;3676.761010534307;3682.429223470366;3683.4290684943876;619.4363129552086;628.2931701835436;633.0377825704903;646.890028695123;668.1848145262771;565.6577770448902;574.8591595059237;579.5508480927315;580.0834681203688;619.9132121502993;7730.845383092306;7973.8405231896195;8015.919840801634;8109.7161599343735;8131.390145738975;577.4254616656453;600.0878664430041;607.1924340626956;607.7690477618477;611.4802417944711;3703.629637036329;3762.1535154590547;3885.708571857122;3888.047428380065;3890.0858298299877;85864;86579;87150.69273960896;87172.1282787164;87298.69051964226;79335.60332198303;80071;80335.59832200801;81186.59406702929;85900;59085.70457147687;67766.66116669483;70517.53188638475;71650;75645;8117.512949223065;8356.6239519223;8494.27798637098;8583.785405364666;8610.65557377698;39747.43867045614;39776.80111599423;49470.752646236535;51758;51840;65653.34346656472;66737.66631167008;68097;69615.30384696089;70026;9502.857457138287;11194.83207751868;11234.438278086227;11348.54605815758;11689.415529223676;11775.35235562018;11803.173777835469;11820.23168494045;11912.940435297767;12330.321832299309;11403.087752979576;11464.31214127155;11611.941940290244;11752.471138798946;11823.82264266054;11213.775724485628;11359.772804544029;11380.317180969168;11739.47172377228;11775.941120294343;11166.832497512707;11195.313124849814;11463.828042579535;11464.885351146382;11572.59495917639;7978.760637180894;9239.307051970995;9466.822630794819;9504.524773761146;9518.048195180427;9550.474723890253;9552.665656701982;9576.569054392708;9633.855492167482;9649.710508684751 04:56:36 INFO - PROCESS | 2309 | __end_tp_report 04:56:36 INFO - PROCESS | 2309 | __start_cc_report 04:56:36 INFO - PROCESS | 2309 | _x_x_mozilla_cycle_collect,1319 04:56:36 INFO - PROCESS | 2309 | __end_cc_report 04:56:36 INFO - PROCESS | 2309 | __startTimestamp1459770996290__endTimestamp 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | ------- Summary: start ------- 04:56:36 INFO - PROCESS | 2309 | Number of tests: 6 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | [#0] dojo.html Cycles:165 Average:5702.98 Median:5924.56 stddev:610.31 (10.3%) stddev-sans-first:584.13 04:56:36 INFO - PROCESS | 2309 | Values: 3371.4 3402.0 3432.2 3449.2 3486.9 5574.4 5627.5 5697.3 5745.9 5772.6 5552.6 5693.1 5698.9 5738.7 5750.7 5128.7 5131.6 5153.7 5185.2 5284.7 5266.4 5278.0 5310.9 5340.0 5378.7 5122.3 5150.4 5218.1 5230.3 5231.2 5216.7 5234.3 5236.7 5238.5 5308.4 5156.6 5176.7 5214.6 5245.3 5247.2 5478.9 5570.1 5598.7 5621.1 5696.5 6130.6 6149.4 6157.2 6164.4 6181.9 5447.8 6114.2 6147.7 6151.4 6164.4 5705.1 5742.4 5814.2 5842.4 5854.6 6205.6 6213.0 6247.2 6255.6 6255.7 6054.4 6073.6 6112.6 6161.5 6168.5 6127.9 6144.2 6161.5 6163.3 6170.2 6137.9 6148.3 6149.7 6164.3 6174.4 6122.2 6140.8 6143.4 6162.9 6165.7 4731.9 4852.5 4876.9 4886.0 4926.5 4392.4 4431.3 4440.4 4450.4 4460.2 5661.3 5728.5 5743.6 5747.3 5758.1 6103.7 6148.6 6149.7 6161.3 6165.1 5729.9 5749.1 5758.7 5765.3 5783.4 5256.5 5317.6 5345.9 5354.4 5356.5 6193.4 6251.2 6255.9 6264.7 6276.5 6081.1 6121.8 6136.6 6138.8 6165.2 5878.0 6097.3 6224.4 6235.5 6270.8 6163.1 6168.4 6201.0 6208.9 6211.6 6217.0 6227.0 6236.4 6238.1 6248.1 5929.3 5979.7 6082.0 6082.5 6116.2 5161.4 5370.5 6072.5 6090.6 6094.3 5933.3 5952.9 5954.1 5967.9 5989.3 5894.6 5982.3 6106.1 6112.5 6115.3 5909.7 5912.2 5924.6 5926.2 5952.3 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | [#1] ext.html Cycles:180 Average:58441.32 Median:37387.54 stddev:121523.82 (325.0%) stddev-sans-first:121786.75 04:56:36 INFO - PROCESS | 2309 | Values: 459.1 524.7 594.2 640.7 644.7 27966.6 30263.2 37846.8 38337.8 38401.4 41367.0 41776.8 41813.0 41859.0 41994.0 9428.6 9632.9 9643.5 9643.9 9659.5 9483.0 9608.8 9624.0 9629.5 9634.0 9566.5 9637.0 9763.4 9768.6 9777.9 9662.7 9739.6 9745.5 9751.0 9752.0 9560.7 9662.2 9668.0 9676.7 9695.8 40262.2 40633.6 40680.8 40699.0 40716.0 3273.8 3370.8 3401.2 3439.3 3896.9 28059.4 28327.2 28452.4 28566.9 28982.4 2721.1 2747.8 2752.9 2874.3 2935.2 479848.0 481145.0 481396.0 482229.0 482827.0 44983.3 45827.8 46126.3 65147.3 65597.3 44597.6 45001.8 45090.3 45183.8 45261.1 15512.5 15669.3 15680.5 15682.7 15689.6 12582.6 12640.2 12646.9 12665.0 12675.7 14421.6 14457.3 14458.4 14498.9 14595.1 6121.2 6193.6 6205.6 6252.4 6262.4 932.6 979.8 980.6 982.6 1003.4 25197.7 28168.9 28816.1 29826.6 29978.4 944.2 1041.9 1072.6 1075.9 1080.4 13906.7 14083.6 14215.9 14219.4 14240.3 533918.0 535757.0 537910.0 538019.0 538402.0 58438.0 58714.7 58754.0 58797.8 58832.4 1430.3 1457.7 1482.0 1485.1 1487.6 28216.7 28332.2 28619.9 28755.9 28946.8 44434.0 44763.3 44901.6 44934.1 44979.3 321172.0 322476.0 324452.0 324527.0 325265.0 28053.4 31991.7 33063.8 33095.7 33115.8 40469.8 40831.8 41206.4 41506.0 41529.0 34545.7 35877.6 35933.6 36600.0 36928.3 35519.6 35748.0 35905.3 36249.0 36295.6 35609.6 35681.5 35720.6 35723.0 36190.1 30379.5 31366.2 31377.7 31420.7 31440.0 23661.4 23907.2 23941.9 24036.0 24236.4 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | [#2] jquery.html Cycles:180 Average:34040.97 Median:11616.81 stddev:101799.26 (876.3%) stddev-sans-first:102053.42 04:56:36 INFO - PROCESS | 2309 | Values: 360.5 360.6 362.4 371.8 372.5 19502.9 20308.7 20649.9 20920.5 21133.2 15935.5 20075.2 20580.0 20706.8 20752.0 5816.4 6050.2 6087.2 6101.2 6106.5 4246.1 4297.2 4388.3 6021.8 6663.2 6431.8 6608.7 6691.4 6715.3 6749.1 6595.2 6617.6 6638.9 6698.6 6720.1 3800.7 5051.1 5268.3 5281.9 5715.5 13082.2 13628.6 13652.0 24730.9 24984.0 1955.8 2100.5 2228.8 2552.8 2732.6 9528.6 9706.7 9929.5 10032.7 10052.5 1664.2 1709.1 1710.8 1726.2 1801.6 95129.5 98042.0 98090.0 98671.0 99940.0 9541.0 10718.7 10726.2 11108.3 11114.0 13636.3 13706.6 13708.5 13715.5 13732.9 7848.4 8393.3 8395.7 8519.6 8519.7 8520.9 8538.6 8573.6 8678.6 8682.4 4300.4 4341.9 4368.0 4438.3 4452.4 1779.7 1822.1 1823.0 1830.6 1843.7 892.6 907.8 1016.6 1033.5 1094.2 17738.7 19616.5 19993.9 20189.5 20717.5 976.0 1005.4 1012.7 1048.2 1073.7 10834.7 11026.3 11225.4 11535.5 11934.7 584479.0 587435.0 617954.0 638117.8 642189.0 112297.0 120134.0 120172.0 123044.4 123663.0 1080.6 1082.6 1105.4 1127.3 1155.0 15744.3 17961.8 18200.7 18210.7 18216.9 38895.8 48811.8 50962.5 51184.0 51657.0 67336.7 72054.0 72656.5 73660.9 75844.6 7588.0 7810.6 7950.5 7979.5 8090.4 11027.5 12547.7 12655.0 12865.7 13008.0 10848.3 10890.6 11021.4 11229.4 11301.0 10847.8 10852.2 10919.3 11080.7 11290.0 10545.9 11204.9 11230.8 11302.7 11652.1 7664.7 7685.0 7782.7 7937.6 8169.3 9794.3 10396.7 10719.1 10754.5 10907.1 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | [#3] mootools.html Cycles:180 Average:6052.92 Median:520.22 stddev:3225.39 (620.0%) stddev-sans-first:3214.70 04:56:36 INFO - PROCESS | 2309 | Values: 1305.3 1580.7 1622.9 1899.2 2023.6 7942.5 8102.2 8532.7 8639.2 8802.6 8544.8 8761.2 8797.2 8805.0 8811.6 2185.4 2398.2 2457.3 2476.9 2503.0 2512.6 2517.6 2518.0 2522.3 2523.9 2272.3 2361.5 2431.8 2486.6 2489.6 2403.9 2404.4 2415.3 2431.6 2439.7 2459.7 2464.2 2474.2 2474.5 2498.4 8821.4 8882.6 8894.3 8910.8 8947.4 5383.7 5517.4 5517.5 5529.8 5572.5 3503.8 3561.8 3633.5 3704.8 3723.5 1027.6 1057.4 1064.9 1072.1 1075.8 11945.0 11950.6 11977.5 11978.8 11989.0 4860.3 4881.9 4951.5 4986.5 4996.3 10181.7 10184.2 10199.0 10208.1 10209.3 5505.3 5519.3 5566.7 5569.9 5572.3 4461.6 4640.1 4647.3 4659.9 4805.1 3875.8 3919.9 3974.2 3977.9 3996.5 1305.8 1315.4 1319.0 1329.9 1331.8 1090.5 1110.5 1110.9 1278.4 1388.2 8182.1 8207.5 8310.1 8313.1 8324.2 503.2 506.4 510.6 512.6 527.9 6216.0 6223.4 6284.0 6284.4 6291.4 10412.2 10773.1 10898.8 10909.6 10915.2 10510.8 10619.4 10635.4 10701.0 10761.1 8299.0 8351.2 8367.4 8410.5 8423.8 7817.1 7948.5 7967.9 8006.7 8034.9 9365.5 9513.0 9610.4 9631.1 9775.6 9815.3 9869.0 9936.0 10045.5 10052.6 6471.2 6541.4 7506.2 7575.0 7581.2 7678.0 8279.3 8318.7 8332.3 8343.8 7379.3 7416.2 7439.6 7483.6 7541.6 6258.3 7050.8 7230.3 7320.2 7405.5 7698.3 7712.8 7763.3 7830.8 7832.3 7042.8 7053.9 7109.2 7114.5 7115.0 6328.0 7137.5 7173.4 7190.5 7227.7 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | [#4] prototype.html Cycles:180 Average:5703.17 Median:6408.55 stddev:1845.81 (28.8%) stddev-sans-first:1806.22 04:56:36 INFO - PROCESS | 2309 | Values: 319.9 323.3 328.9 328.9 331.3 5430.6 5745.6 6325.7 6508.4 6630.3 6489.8 6536.6 6554.2 6559.9 6570.6 4626.1 4716.2 4735.9 4745.4 4891.8 4214.1 4819.4 4820.4 4825.3 4887.4 4808.0 4819.6 4835.5 4840.3 4841.5 4570.6 4667.8 4811.4 4837.5 4850.1 3649.9 3936.7 4116.8 4117.4 4125.8 5715.9 5812.2 6357.9 6362.2 6382.1 5690.9 5699.3 5705.0 5705.3 5718.3 6033.9 6950.1 6955.2 6977.6 6997.4 3906.3 4291.0 4486.8 4500.5 4630.8 7318.3 7331.7 7365.8 7373.9 7378.2 4574.9 4576.4 4581.7 4585.3 4589.2 4630.3 4647.4 4654.2 4656.1 4665.3 5593.3 5601.4 5602.4 5604.4 5611.2 6023.6 6689.7 6997.3 7007.2 7023.3 1587.2 1595.1 1613.5 1614.9 1615.9 967.8 1007.2 1009.9 1029.7 1034.5 6376.5 6387.0 6398.7 6407.9 6409.2 7047.4 7189.0 7219.0 7242.4 7297.3 5522.5 6622.9 6630.3 6636.2 6637.1 3833.4 3891.2 3892.6 3894.3 3899.4 7290.8 7683.2 7693.2 7695.0 7701.9 7525.0 7555.0 7560.7 7562.7 7574.5 7634.7 7650.1 7656.0 7656.8 7673.6 6957.9 7290.7 7338.8 7341.0 7358.7 7140.2 7201.7 7256.3 7266.3 7275.6 7679.2 7697.0 7708.7 7738.9 7746.8 4563.9 4600.4 4610.1 4618.6 4619.7 6932.6 7298.3 7301.7 7322.2 7328.2 5477.8 6989.7 6990.8 7007.2 7018.2 6966.4 6994.8 7009.1 7015.4 7016.4 6833.5 6843.6 6848.5 6855.9 6859.6 5916.3 6747.1 7024.2 7025.3 7051.1 6552.8 6662.5 6726.2 6824.8 6841.0 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - PROCESS | 2309 | [#5] yui.html Cycles:180 Average:18099.17 Median:624.10 stddev:25242.01 (4044.5%) stddev-sans-first:25278.98 04:56:36 INFO - PROCESS | 2309 | Values: 693.2 728.0 752.9 756.2 759.2 14682.6 14942.3 14975.5 14994.5 15009.9 11139.9 13867.7 13869.3 13874.0 13882.3 727.7 736.1 888.3 891.5 919.2 900.7 907.6 909.2 911.0 911.6 976.0 981.1 983.4 984.8 986.6 772.8 963.9 983.1 984.7 987.0 730.9 732.6 733.3 734.6 736.0 14474.3 14556.6 14577.9 14587.4 14590.5 12574.7 12622.2 12640.8 12731.8 12922.5 10011.0 10181.9 10526.7 10576.3 10787.2 3490.7 3542.5 3616.4 3657.6 3815.5 76201.0 77165.0 79865.6 80736.0 80829.0 9502.9 9544.5 9555.9 9825.2 9930.9 22557.9 22560.0 22817.9 23073.7 23122.4 7724.2 7728.0 7934.7 8046.0 8146.8 3588.0 4014.4 4090.3 4126.4 4131.1 3608.4 3671.1 3676.8 3682.4 3683.4 619.4 628.3 633.0 646.9 668.2 565.7 574.9 579.6 580.1 619.9 7730.8 7973.8 8015.9 8109.7 8131.4 577.4 600.1 607.2 607.8 611.5 3703.6 3762.2 3885.7 3888.0 3890.1 85864.0 86579.0 87150.7 87172.1 87298.7 79335.6 80071.0 80335.6 81186.6 85900.0 59085.7 67766.7 70517.5 71650.0 75645.0 8117.5 8356.6 8494.3 8583.8 8610.7 39747.4 39776.8 49470.8 51758.0 51840.0 65653.3 66737.7 68097.0 69615.3 70026.0 9502.9 11194.8 11234.4 11348.5 11689.4 11775.4 11803.2 11820.2 11912.9 12330.3 11403.1 11464.3 11611.9 11752.5 11823.8 11213.8 11359.8 11380.3 11739.5 11775.9 11166.8 11195.3 11463.8 11464.9 11572.6 7978.8 9239.3 9466.8 9504.5 9518.0 9550.5 9552.7 9576.6 9633.9 9649.7 04:56:36 INFO - PROCESS | 2309 | -------- Summary: end -------- 04:56:36 INFO - PROCESS | 2309 | 04:56:36 INFO - TEST-INFO | 2309: exit 0 04:56:36 INFO - TEST-OK | dromaeo_css | took 1113596ms 04:56:36 INFO - TEST-START | kraken 04:56:36 INFO - operating with platform_type : mac_ 04:56:36 INFO - Initialising browser for kraken test... 04:56:36 INFO - TEST-INFO | started process 2311 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpcnCdMc/profile http://localhost:53374/getInfo.html) 04:56:38 INFO - PROCESS | 2311 | __metrics Screen width/height:1600/1200 04:56:38 INFO - PROCESS | 2311 | colorDepth:24 04:56:38 INFO - PROCESS | 2311 | Browser inner width/height: 1024/689 04:56:38 INFO - PROCESS | 2311 | __metrics 04:56:39 INFO - PROCESS | 2311 | 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" 04:56:39 ERROR - PROCESS | 2311 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:56:39 INFO - TEST-INFO | 2311: exit 0 04:56:39 INFO - Browser initialized. 04:56:39 INFO - Running cycle 1/1 for kraken test... 04:56:39 INFO - TEST-INFO | started process 2313 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpcnCdMc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:51 INFO - PROCESS | 2313 | RSS: Main: 235941888 04:56:51 INFO - PROCESS | 2313 | 04:56:54 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53374/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:54 INFO - PROCESS | 2313 | RSS: Main: 281739264 04:56:54 INFO - PROCESS | 2313 | 04:56:57 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53374/tests/kraken/driver.html?testName=audio-dft) 04:56:58 INFO - PROCESS | 2313 | RSS: Main: 291926016 04:56:58 INFO - PROCESS | 2313 | 04:57:01 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53374/tests/kraken/driver.html?testName=audio-fft) 04:57:02 INFO - PROCESS | 2313 | RSS: Main: 278827008 04:57:02 INFO - PROCESS | 2313 | 04:57:04 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53374/tests/kraken/driver.html?testName=audio-oscillator) 04:57:04 INFO - PROCESS | 2313 | RSS: Main: 281108480 04:57:04 INFO - PROCESS | 2313 | 04:57:06 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:07 INFO - PROCESS | 2313 | RSS: Main: 282030080 04:57:07 INFO - PROCESS | 2313 | 04:57:10 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53374/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:10 INFO - PROCESS | 2313 | RSS: Main: 282054656 04:57:10 INFO - PROCESS | 2313 | 04:57:13 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53374/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:14 INFO - PROCESS | 2313 | RSS: Main: 282316800 04:57:14 INFO - PROCESS | 2313 | 04:57:16 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53374/tests/kraken/driver.html?testName=json-parse-financial) 04:57:17 INFO - PROCESS | 2313 | RSS: Main: 282619904 04:57:17 INFO - PROCESS | 2313 | 04:57:19 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:19 INFO - PROCESS | 2313 | RSS: Main: 314028032 04:57:19 INFO - PROCESS | 2313 | 04:57:21 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:22 INFO - PROCESS | 2313 | RSS: Main: 314974208 04:57:22 INFO - PROCESS | 2313 | 04:57:24 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:24 INFO - PROCESS | 2313 | RSS: Main: 320802816 04:57:24 INFO - PROCESS | 2313 | 04:57:27 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:28 INFO - PROCESS | 2313 | RSS: Main: 321818624 04:57:28 INFO - PROCESS | 2313 | 04:57:30 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:31 INFO - PROCESS | 2313 | RSS: Main: 322977792 04:57:31 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:53374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53374/tests/kraken/driver.html?testName=ai-astar) 04:57:33 INFO - PROCESS | 2313 | RSS: Main: 385343488 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | __start_tp_report 04:57:33 INFO - PROCESS | 2313 | _x_x_mozilla_page_load 04:57:33 INFO - PROCESS | 2313 | _x_x_mozilla_page_load_details 04:57:33 INFO - PROCESS | 2313 | |i|pagename|runs| 04:57:33 INFO - PROCESS | 2313 | |0;ai-astar;111;108;110;111;110;111;117;109;110;111 04:57:33 INFO - PROCESS | 2313 | |1;audio-beat-detection;159;120;142;160;119;145;160;141;161;121 04:57:33 INFO - PROCESS | 2313 | |2;audio-dft;187;187;187;187;188;186;188;202;262;187 04:57:33 INFO - PROCESS | 2313 | |3;audio-fft;76;76;85;80;55;59;57;82;80;57 04:57:33 INFO - PROCESS | 2313 | |4;audio-oscillator;90;90;129;77;77;81;114;87;110;145 04:57:33 INFO - PROCESS | 2313 | |5;imaging-gaussian-blur;88;84;90;127;132;85;87;84;87;84 04:57:33 INFO - PROCESS | 2313 | |6;imaging-darkroom;94;94;94;94;94;94;94;94;93;93 04:57:33 INFO - PROCESS | 2313 | |7;imaging-desaturate;84;87;83;84;86;84;87;87;88;85 04:57:33 INFO - PROCESS | 2313 | |8;json-parse-financial;54;57;55;55;52;52;54;65;55;52 04:57:33 INFO - PROCESS | 2313 | |9;json-stringify-tinderbox;65;64;76;76;71;69;72;69;70;70 04:57:33 INFO - PROCESS | 2313 | |10;stanford-crypto-aes;84;84;82;83;83;83;81;79;82;84 04:57:33 INFO - PROCESS | 2313 | |11;stanford-crypto-ccm;128;122;136;132;122;123;134;127;126;126 04:57:33 INFO - PROCESS | 2313 | |12;stanford-crypto-pbkdf2;142;168;173;161;141;125;157;171;147;139 04:57:33 INFO - PROCESS | 2313 | |13;stanford-crypto-sha256-iterative;68;67;68;92;91;58;65;91;87;89 04:57:33 INFO - PROCESS | 2313 | __end_tp_report 04:57:33 INFO - PROCESS | 2313 | __start_cc_report 04:57:33 INFO - PROCESS | 2313 | _x_x_mozilla_cycle_collect,1259 04:57:33 INFO - PROCESS | 2313 | __end_cc_report 04:57:33 INFO - PROCESS | 2313 | __startTimestamp1459771053416__endTimestamp 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | ------- Summary: start ------- 04:57:33 INFO - PROCESS | 2313 | Number of tests: 14 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.39 (2.2%) stddev-sans-first:2.54 04:57:33 INFO - PROCESS | 2313 | Values: 111.0 108.0 110.0 111.0 110.0 111.0 117.0 109.0 110.0 111.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:152.00 stddev:17.50 (11.5%) stddev-sans-first:17.55 04:57:33 INFO - PROCESS | 2313 | Values: 159.0 120.0 142.0 160.0 119.0 145.0 160.0 141.0 161.0 121.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#2] audio-dft Cycles:10 Average:196.10 Median:187.50 stddev:23.63 (12.6%) stddev-sans-first:24.83 04:57:33 INFO - PROCESS | 2313 | Values: 187.0 187.0 187.0 187.0 188.0 186.0 188.0 202.0 262.0 187.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#3] audio-fft Cycles:10 Average:70.70 Median:78.00 stddev:12.11 (15.5%) stddev-sans-first:12.69 04:57:33 INFO - PROCESS | 2313 | Values: 76.0 76.0 85.0 80.0 55.0 59.0 57.0 82.0 80.0 57.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:79.00 stddev:23.45 (29.7%) stddev-sans-first:24.59 04:57:33 INFO - PROCESS | 2313 | Values: 90.0 90.0 129.0 77.0 77.0 81.0 114.0 87.0 110.0 145.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:86.00 stddev:18.43 (21.4%) stddev-sans-first:19.38 04:57:33 INFO - PROCESS | 2313 | Values: 88.0 84.0 90.0 127.0 132.0 85.0 87.0 84.0 87.0 84.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:57:33 INFO - PROCESS | 2313 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.50 stddev:1.72 (2.0%) stddev-sans-first:1.73 04:57:33 INFO - PROCESS | 2313 | Values: 84.0 87.0 83.0 84.0 86.0 84.0 87.0 87.0 88.0 85.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:3.84 (7.0%) stddev-sans-first:4.06 04:57:33 INFO - PROCESS | 2313 | Values: 54.0 57.0 55.0 55.0 52.0 52.0 54.0 65.0 55.0 52.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:3.94 (5.6%) stddev-sans-first:3.70 04:57:33 INFO - PROCESS | 2313 | Values: 65.0 64.0 76.0 76.0 71.0 69.0 72.0 69.0 70.0 70.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.58 (1.9%) stddev-sans-first:1.58 04:57:33 INFO - PROCESS | 2313 | Values: 84.0 84.0 82.0 83.0 83.0 83.0 81.0 79.0 82.0 84.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:4.95 (3.9%) stddev-sans-first:5.25 04:57:33 INFO - PROCESS | 2313 | Values: 128.0 122.0 136.0 132.0 122.0 123.0 134.0 127.0 126.0 126.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:159.00 stddev:16.01 (10.1%) stddev-sans-first:16.53 04:57:33 INFO - PROCESS | 2313 | Values: 142.0 168.0 173.0 161.0 141.0 125.0 157.0 171.0 147.0 139.0 04:57:33 INFO - PROCESS | 2313 | 04:57:33 INFO - PROCESS | 2313 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.60 Median:88.00 stddev:13.43 (15.3%) stddev-sans-first:13.79 04:57:33 INFO - PROCESS | 2313 | Values: 68.0 67.0 68.0 92.0 91.0 58.0 65.0 91.0 87.0 89.0 04:57:33 INFO - PROCESS | 2313 | -------- Summary: end -------- 04:57:33 INFO - PROCESS | 2313 | 04:57:34 INFO - TEST-INFO | 2313: exit 0 04:57:34 INFO - TEST-OK | kraken | took 57281ms 04:57:34 INFO - SUITE-END | took 1170s 04:57:34 INFO - Completed test suite (00:19:31) 04:57:34 INFO - javascript benchmark 04:57:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3371.359441706076, 3401.982990085049, 3432.2449061206535, 3449.1721986723196, 3486.8953931382066, 5574.358948720898, 5627.493525582697, 5697.287839020122, 5745.913811292834, 5772.624779389337, 5552.555795536357, 5693.089105743082, 5698.857528561788, 5738.655680659163, 5750.654960702351, 5128.666636668623, 5131.615128865331, 5153.665011774223, 5185.170372740362, 5284.709340986245, 5266.394364648077, 5278.0, 5310.946890531103, 5340.038793017256, 5378.677279363231, 5122.334096567422, 5150.356205474316, 5218.112920803473, 5230.34620672416, 5231.241469986869, 5216.739163041871, 5234.319538460014, 5236.738163091868, 5238.476152384769, 5308.442613525602, 5156.561692256163, 5176.7411629418375, 5214.634975551713, 5245.344331958505, 5247.212918062283, 5478.890422191534, 5570.080936645449, 5598.748056337475, 5621.100623900156, 5696.544276457874, 6130.601510901777, 6149.385061493815, 6157.168782214389, 6164.352742961969, 6181.938180618226, 5447.754851031713, 6114.2357205349335, 6147.661878596676, 6151.415615516519, 6164.352742961969, 5705.087186050254, 5742.397048309951, 5814.244148260699, 5842.357340692521, 5854.619449735754, 6205.627662340274, 6213.03697926822, 6247.187865577446, 6255.624662520172, 6255.655938923403, 6054.424829641265, 6073.635581865014, 6112.572119951649, 6161.507079433724, 6168.475679567197, 6127.938720612826, 6144.201253837062, 6161.537884658668, 6163.322034576193, 6170.197874276315, 6137.8673257933415, 6148.262208534915, 6149.692515374303, 6164.260288765287, 6174.413430724074, 6122.173506576555, 6140.846478838065, 6143.38566143391, 6162.938370616326, 6165.660888651168, 4731.858044258678, 4852.51474852519, 4876.853694389174, 4886.0, 4926.482719314492, 4392.407025051641, 4431.33529970507, 4440.444944381952, 4450.354698568754, 4460.1971645104195, 5661.320641523043, 5728.513076388554, 5743.62666426681, 5747.310322761212, 5758.1362795581, 6103.701349646901, 6148.600340977822, 6149.692515374213, 6161.322254551996, 6165.10605962133, 5729.914051289234, 5749.051406517961, 5758.654480731169, 5765.336986246635, 5783.363829978699, 5256.526912577886, 5317.574594032545, 5345.9465405345445, 5354.41101478837, 5356.544693701001, 6193.411625895533, 6251.187345645037, 6255.874882502416, 6264.655443950626, 6276.497880169575, 6081.118237855398, 6121.755129794758, 6136.570440069152, 6138.754449821957, 6165.198524191826, 5878.0, 6097.25246653012, 6224.37756224374, 6235.501159907287, 6270.7805226816845, 6163.075538669235, 6168.414000669929, 6201.0388389799655, 6208.937910621016, 6211.565190436626, 6217.0, 6227.0, 6236.376362363909, 6238.064290356483, 6248.062790581449, 5929.347771745019, 5979.671118088547, 6082.026875700044, 6082.513398928164, 6116.174316467398, 5161.380634323905, 5370.54152629115, 6072.544559158169, 6090.634561926298, 6094.329623741473, 5933.347331793586, 5952.940470595238, 5954.136650185612, 5967.940320596738, 5989.3112292085225, 5894.616849904743, 5982.282126144891, 6106.1451396803595, 6112.473085128157, 6115.331611965906, 5909.734061967136, 5912.172295878494, 5924.555658325557, 5926.1999630049395, 5952.315483719428], "unit": "score", "name": "dojo.html", "value": 5665.467199613902}, {"lowerIsBetter": false, "replicates": [459.06121980549796, 524.7223011965862, 594.1622312539317, 640.6572483721209, 644.7066584703958, 27966.580501292472, 30263.24341891454, 37846.810765946204, 38337.808310958404, 38401.423978640276, 41367.0, 41776.79111604446, 41813.0, 41859.0, 41994.0, 9428.622855085789, 9632.903670963306, 9643.469609171492, 9643.90356096437, 9659.468729219925, 9482.956874743808, 9608.80782384352, 9624.0, 9629.470379129145, 9634.0, 9566.521673916312, 9637.0, 9763.365381250196, 9768.560414781316, 9777.902220977805, 9662.661806836762, 9739.561719722595, 9745.512724363789, 9751.0, 9751.976042515576, 9560.713178604654, 9662.227021838236, 9667.984861589572, 9676.70969870905, 9695.806083878353, 40262.19475610471, 40633.59366406328, 40680.79659601713, 40699.0, 40716.0, 3273.819939903304, 3370.8146051967133, 3401.183715908189, 3439.2605589798313, 3896.9220615587815, 28059.438811223867, 28327.15018549447, 28452.430951381062, 28566.857165714246, 28982.42035159285, 2721.0612338743103, 2747.8213916095588, 2752.944941101167, 2874.3101655602713, 2935.222166125978, 479848.0, 481145.0, 481396.0, 482229.0, 482827.0, 44983.32525012128, 45827.77086114548, 46126.30810537845, 65147.348526515074, 65597.34402656008, 44597.55402445999, 45001.77499112549, 45090.32364514535, 45183.774081129384, 45261.09477810491, 15512.457064002705, 15669.294881730122, 15680.529584112495, 15682.68634627301, 15689.607759806097, 12582.622521324374, 12640.178388404724, 12646.873531264753, 12665.0, 12675.746485070247, 14421.639459013399, 14457.349419276157, 14458.421663133357, 14498.927505362617, 14595.124292542268, 6121.173641558422, 6193.628382297076, 6205.627662340184, 6252.406021427957, 6262.373762623793, 932.5710173320349, 979.8383266760904, 980.5734505490135, 982.5627595719978, 1003.3929472669076, 25197.740112994277, 28168.85915570409, 28816.135515934555, 29826.55260171099, 29978.40043199124, 944.1738478831023, 1041.8645576075062, 1072.619220176826, 1075.9031687148195, 1080.4219742437758, 13906.652333691536, 14083.577492675031, 14215.85784142166, 14219.36012879423, 14240.287985600886, 533918.0, 535757.0, 537910.0, 538019.0, 538402.0, 58438.0, 58714.706426467594, 58754.0, 58797.82404351889, 58832.41167588269, 1430.2920054573053, 1457.744894643433, 1482.044081567383, 1485.1386196006506, 1487.6132205626616, 28216.730247139338, 28332.15003549897, 28619.856900715364, 28755.856220718764, 28946.84212631471, 44434.0, 44763.32855007242, 44901.55098448974, 44934.1013179728, 44979.32531011972, 321172.0, 322476.0, 324452.0, 324527.0, 325265.0, 28053.43893122167, 31991.68008319887, 33063.83468082644, 33095.66904331022, 33115.840945566786, 40469.785906422854, 40831.79584102179, 41206.38190427206, 41506.0, 41529.0, 34545.65454345424, 35877.64122358743, 35933.64066359407, 36600.0, 36928.26143477169, 35519.64480355164, 35748.0, 35905.28189436249, 36249.0, 36295.63704362923, 35609.64390356167, 35681.46477802887, 35720.64279357277, 35723.0, 36190.09524761902, 30379.544306835858, 31366.215844604067, 31377.744890204136, 31420.685793141776, 31440.0, 23661.408464788517, 23907.238924051046, 23941.880290598434, 24036.0, 24236.39409014789], "unit": "score", "name": "ext.html", "value": 18669.00891295101}, {"lowerIsBetter": false, "replicates": [360.51150690813944, 360.58532687409473, 362.3749032918216, 371.7713606132228, 372.48596936228, 19502.90248548757, 20308.69536956945, 20649.896750516265, 20920.497926963402, 21133.154673813067, 15935.521934341989, 20075.225902486076, 20580.0, 20706.792932070675, 20752.0, 5816.360200377955, 6050.152978583002, 6087.2086628738425, 6101.237345331833, 6106.511479081662, 4246.129543443602, 4297.183535128332, 4388.253996820548, 6021.849453763669, 6663.233728121256, 6431.839204019913, 6608.735650573972, 6691.431228345572, 6715.2613212546585, 6749.088873002131, 6595.241547222083, 6617.569857959217, 6638.900416493757, 6698.56459330142, 6720.059191713164, 3800.6959443244473, 5051.141305977956, 5268.31511903454, 5281.947180528184, 5715.513966368774, 13082.215067096005, 13628.591142265748, 13652.0, 24730.876345618155, 24984.0, 1955.7555305586802, 2100.4643815826867, 2228.7771222877745, 2552.8468291902545, 2732.6447561817035, 9528.571214295373, 9706.70879873598, 9929.50352482373, 10032.69901902944, 10052.547635356426, 1664.209500487271, 1709.0856391830312, 1710.7604935309066, 1726.1800644693797, 1801.5946412057183, 95129.52435237849, 98042.01957980401, 98090.0, 98671.0132898669, 99940.0, 9541.045895410403, 10718.732031699114, 10726.226829060994, 11108.333499990027, 11114.0, 13636.250006249751, 13706.560811114889, 13708.45166193361, 13715.519956801463, 13732.931335343459, 7848.411369147223, 8393.286570641441, 8395.70615028471, 8519.57402129891, 8519.659213631385, 8520.8721869172, 8538.573071346407, 8573.614187361583, 8678.56607169639, 8682.43564168327, 4300.440942677432, 4341.934870976938, 4367.951691593995, 4438.267685831866, 4452.354408610733, 1779.7330400440037, 1822.0798496759317, 1822.9726554101435, 1830.569816093217, 1843.6589230992308, 892.5626443042992, 907.832051070554, 1016.6390931219458, 1033.493588141805, 1094.190299178618, 17738.65402976279, 19616.545712629395, 19993.900030499753, 20189.49526261855, 20717.482062948246, 975.9560819763128, 1005.3917379985149, 1012.6607586458618, 1048.2400259811727, 1073.6510634043966, 10834.730071147067, 11026.338419694845, 11225.382603956697, 11535.480903359201, 11934.701632459084, 584479.0, 587435.0, 617954.0, 638117.8094109499, 642189.0, 112297.0, 120134.0, 120172.0, 123044.38477807553, 123663.0, 1080.6325849211305, 1082.610260306289, 1105.42517890698, 1127.3461392392392, 1155.0297749889965, 15744.268130505407, 17961.820381796013, 18200.726989095438, 18210.72683909716, 18216.908915455337, 38895.805520972215, 48811.75594122149, 50962.490375095775, 51184.0, 51657.0, 67336.65326693536, 72054.0, 72656.54686906339, 73660.89508657267, 75844.62077689577, 7587.962060189664, 7810.648520816463, 7950.4832185907735, 7979.521228726295, 8090.352771778126, 11027.503762330874, 12547.74904501923, 12655.0, 12865.678358041125, 13008.0, 10848.294860834336, 10890.61882834097, 11021.393823339793, 11229.382383968634, 11300.982911538002, 10847.837282440612, 10852.18608604342, 10919.290246133976, 11080.667579972614, 11289.98390144891, 10545.894541054491, 11204.943975280072, 11230.775384492428, 11302.660920172408, 11652.126090543412, 7664.693412263447, 7684.961575192088, 7782.727604533814, 7937.642806073856, 8169.346452283922, 9794.26543009263, 10396.740081498023, 10719.088877445505, 10754.516046777757, 10907.127429805438], "unit": "score", "name": "jquery.html", "value": 9298.688218113039}, {"lowerIsBetter": false, "replicates": [1305.30818666107, 1580.6917651058043, 1622.9431969881057, 1899.1833511590019, 2023.5851650411666, 7942.523448593089, 8102.230288122626, 8532.70135545256, 8639.222469977702, 8802.55987200639, 8544.829103417927, 8761.211490965812, 8797.208251257385, 8805.031446540892, 8811.647534098629, 2185.4208634711736, 2398.2325655790155, 2457.299669594166, 2476.925692229236, 2503.0488414402594, 2512.6105453654623, 2517.5845985412384, 2518.0, 2522.2937577478338, 2523.911663091792, 2272.2728726807427, 2361.480474295652, 2431.8419302745265, 2486.5648511510503, 2489.5892177790643, 2403.891824867885, 2404.3748625357443, 2415.251272105644, 2431.55016321981, 2439.7194322652945, 2459.692538432696, 2464.236086813076, 2474.1958863369478, 2474.4679893822913, 2498.4378514834198, 8821.382503224777, 8882.600282987281, 8894.332925030649, 8910.821783564292, 8947.373683842134, 5383.703896285702, 5517.393086760453, 5517.531009864167, 5529.751161197756, 5572.5263352615075, 3503.789772613651, 3561.7506774525796, 3633.5094762207027, 3704.833282502294, 3723.4600982857605, 1027.563285603623, 1057.40256754934, 1064.9414282214475, 1072.0673014477377, 1075.8278675411975, 11945.0, 11950.641480755592, 11977.461014254379, 11978.820317695328, 11989.0, 4860.343853579792, 4881.8535443936735, 4951.529604687549, 4986.47641997585, 4996.325496058058, 10181.745456363502, 10184.236182286359, 10199.031092046243, 10208.081272685495, 10209.336393134423, 5505.256790333334, 5519.337679478488, 5566.666000040011, 5569.888602227933, 5572.331320241597, 4461.598456138963, 4640.095181439587, 4647.34937108805, 4659.860204193879, 4805.13507568641, 3875.8062096895605, 3919.941200881989, 3974.16542526067, 3977.880663580097, 3996.540397854226, 1305.771489989248, 1315.4343632238229, 1318.953836615733, 1329.9335033248299, 1331.8468376136675, 1090.4765712457906, 1110.5113749949996, 1110.9444527773578, 1278.3799857069314, 1388.1532265318149, 8182.059063207688, 8207.466514676527, 8310.127436619188, 8313.08556058833, 8324.167583241748, 503.2375950435094, 506.364512536764, 510.6348960493265, 512.5515174222555, 527.8865044015555, 6216.005439129717, 6223.37766223374, 6283.96858015707, 6284.4344009039405, 6291.402316779899, 10412.219083568763, 10773.138148948065, 10898.782024359469, 10909.563617455371, 10915.23593348458, 10510.789784204273, 10619.36283822973, 10635.41505217205, 10701.036906678437, 10761.085307748928, 8298.958505207556, 8351.248387645019, 8367.414281000272, 8410.537420441935, 8423.831523369498, 7817.101033381006, 7948.523088614702, 7967.880481792894, 8006.679732810622, 8034.919650803417, 9365.484898330385, 9513.0, 9610.375325603813, 9631.133198012212, 9775.608975640895, 9815.312928094965, 9868.950655246965, 9935.950320248352, 10045.547950342398, 10052.64815731446, 6471.223453185459, 6541.443977261986, 7506.1743208248145, 7575.0, 7581.180516675848, 7678.040244969379, 8279.254867061993, 8318.70884519039, 8332.291755200633, 8343.833123337621, 7379.298966598165, 7416.221296763762, 7439.55362678241, 7483.588402637907, 7541.622918854145, 6258.280297765633, 7050.823729406806, 7230.276972302728, 7320.158181808947, 7405.518641288299, 7698.307152356315, 7712.807179820549, 7763.301302882767, 7830.804229894298, 7832.295093441618, 7042.7887163385185, 7053.858922821618, 7109.182444019004, 7114.466415018791, 7114.964425177841, 6328.0, 7137.501124763858, 7173.426125910019, 7190.4607154464675, 7227.747028853965], "unit": "score", "name": "mootools.html", "value": 4840.006705935464}, {"lowerIsBetter": false, "replicates": [319.9040287913626, 323.34683938444346, 328.88982190966027, 328.9391462579423, 331.2645926044183, 5430.647007944486, 5745.626534275274, 6325.7153428095735, 6508.446782023528, 6630.336966303379, 6489.772857949973, 6536.575122617039, 6554.180727409074, 6559.934400655992, 6570.63861487618, 4626.144163329778, 4716.1982462981205, 4735.85792426226, 4745.383100196969, 4891.755412229392, 4214.136102099078, 4819.373481447407, 4820.39745031871, 4825.324454576362, 4887.437944636376, 4808.0, 4819.614430845524, 4835.468098509161, 4840.273958906175, 4841.515848415165, 4570.634349252052, 4667.836625718083, 4811.398575178103, 4837.4920633333695, 4850.054239423313, 3649.85400583979, 3936.665383442411, 4116.814743336557, 4117.3618089196225, 4125.834966601363, 5715.942840571583, 5812.157237200625, 6357.872842543169, 6362.172917520739, 6382.106505089291, 5690.9146362804595, 5699.316082070137, 5704.971475142639, 5705.286839145107, 5718.285214348207, 6033.939660603425, 6950.096487456598, 6955.234924158339, 6977.581345119309, 6997.440204783605, 3906.3163946309564, 4290.957090429087, 4486.7980940857415, 4500.482444518857, 4630.791614377361, 7318.3047610476915, 7331.670074846591, 7365.815854603624, 7373.852522949564, 7378.188399276021, 4574.908501829945, 4576.382188404589, 4581.694217148097, 4585.266357382803, 4589.173948689268, 4630.305454181899, 4647.395838540968, 4654.16225079489, 4656.138614356355, 4665.323528088408, 5593.272874526286, 5601.439856014447, 5602.411746766612, 5604.3835178130375, 5611.242482264924, 6023.6385816851125, 6689.698963546554, 6997.265287144878, 7007.229204787469, 7023.297670233038, 1587.2460581223827, 1595.058915240014, 1613.5482065021813, 1614.8869579129582, 1615.8626516745974, 967.8451447768323, 1007.1791489935679, 1009.9141572966233, 1029.7374169586858, 1034.534459493231, 6376.521760867953, 6386.968065159737, 6398.680065996681, 6407.871842563122, 6409.230892292955, 7047.365737083687, 7189.0, 7219.025431566672, 7242.420606351585, 7297.306755858185, 5522.502974732213, 6622.9006564901565, 6630.30381809903, 6636.2368327642935, 6637.103990961255, 3833.4441505981476, 3891.20230352777, 3892.630200130983, 3894.2600905827803, 3899.3566061600086, 7290.817729556804, 7683.231676832272, 7693.230676932262, 7695.0, 7701.922980770232, 7525.021747172942, 7555.017847679766, 7560.673303746334, 7562.697492100255, 7574.5076570022775, 7634.656440460192, 7650.081990161217, 7655.961720191363, 7656.80857978555, 7673.61631918413, 6957.860842783217, 7290.671919763729, 7338.816529586589, 7341.0, 7358.66885990121, 7140.178879428932, 7201.675924583511, 7256.346928776436, 7266.309700578437, 7275.563466192046, 7679.19368466303, 7697.0378702662165, 7708.691652333844, 7738.92261077382, 7746.845063098819, 4563.885902852455, 4600.355950166912, 4610.077984403066, 4618.56123668251, 4619.722816631013, 6932.584044957319, 7298.270172982871, 7301.707931682673, 7322.231165727522, 7328.193898671036, 5477.780888764405, 6989.685464154024, 6990.755323563651, 7007.194172670208, 7018.192907815463, 6966.442684585119, 6994.755183568551, 7009.12385951756, 7015.403690686348, 7016.403605693369, 6833.453323734188, 6843.62360070181, 6848.486363522856, 6855.862882742217, 6859.5541289816, 5916.290045194604, 6747.122874026345, 7024.1571011478945, 7025.262347453444, 7051.083359163481, 6552.803415897531, 6662.500312476487, 6726.226483954212, 6824.7952561423235, 6841.042254084333], "unit": "score", "name": "prototype.html", "value": 5083.4753553840355}, {"lowerIsBetter": false, "replicates": [693.1647364925265, 727.9708811647531, 752.8644843928091, 756.2324240895489, 759.2331744937613, 14682.63293417665, 14942.252887355617, 14975.47585834496, 14994.475193368235, 15009.92495037526, 11139.944300278508, 13867.722645547083, 13869.306534673276, 13874.0, 13882.305884705775, 727.7271023366237, 736.135041326442, 888.2760550151605, 891.5319457284928, 919.1727445299217, 900.6847603338812, 907.5689047702322, 909.1771946388529, 910.9979023074632, 911.6262332443699, 975.9853602195973, 981.1464026297132, 983.3853841349156, 984.7833476635165, 986.6349450703214, 772.8454309138167, 963.8506031565119, 983.0513554420019, 984.6602921991902, 987.0474991633108, 730.9451791115688, 732.5934106570851, 733.2813842434444, 734.5629350536423, 735.9521631094016, 14474.276286185648, 14556.563303100924, 14577.854221457861, 14587.416503339853, 14590.489332873298, 12574.685632859251, 12622.179558328678, 12640.810387844189, 12731.809022864665, 12922.483100676056, 10011.0, 10181.898181018169, 10526.736831579272, 10576.312539684895, 10787.190960677981, 3490.7381946354126, 3542.4863394807867, 3616.4213725804007, 3657.5976642569294, 3815.4849095372324, 76201.0, 77165.0, 79865.60067199684, 80736.0, 80829.0, 9502.857457138149, 9544.52277386128, 9555.9044409555, 9825.213982881352, 9930.851037234448, 22557.88721056417, 22560.0, 22817.88591057034, 23073.653895191586, 23122.421939451648, 7724.227577242231, 7728.0, 7934.722284720007, 8045.9597702011115, 8146.796330091795, 3588.0, 4014.41790940312, 4090.3046482098116, 4126.381042843537, 4131.111810960658, 3608.3685355062757, 3671.1372827385544, 3676.761010534307, 3682.429223470366, 3683.4290684943876, 619.4363129552086, 628.2931701835436, 633.0377825704903, 646.890028695123, 668.1848145262771, 565.6577770448902, 574.8591595059237, 579.5508480927315, 580.0834681203688, 619.9132121502993, 7730.845383092306, 7973.8405231896195, 8015.919840801634, 8109.7161599343735, 8131.390145738975, 577.4254616656453, 600.0878664430041, 607.1924340626956, 607.7690477618477, 611.4802417944711, 3703.629637036329, 3762.1535154590547, 3885.708571857122, 3888.047428380065, 3890.0858298299877, 85864.0, 86579.0, 87150.69273960896, 87172.1282787164, 87298.69051964226, 79335.60332198303, 80071.0, 80335.59832200801, 81186.59406702929, 85900.0, 59085.70457147687, 67766.66116669483, 70517.53188638475, 71650.0, 75645.0, 8117.512949223065, 8356.6239519223, 8494.27798637098, 8583.785405364666, 8610.65557377698, 39747.43867045614, 39776.80111599423, 49470.752646236535, 51758.0, 51840.0, 65653.34346656472, 66737.66631167008, 68097.0, 69615.30384696089, 70026.0, 9502.857457138287, 11194.83207751868, 11234.438278086227, 11348.54605815758, 11689.415529223676, 11775.35235562018, 11803.173777835469, 11820.23168494045, 11912.940435297767, 12330.321832299309, 11403.087752979576, 11464.31214127155, 11611.941940290244, 11752.471138798946, 11823.82264266054, 11213.775724485628, 11359.772804544029, 11380.317180969168, 11739.47172377228, 11775.941120294343, 11166.832497512707, 11195.313124849814, 11463.828042579535, 11464.885351146382, 11572.59495917639, 7978.760637180894, 9239.307051970995, 9466.822630794819, 9504.524773761146, 9518.048195180427, 9550.474723890253, 9552.665656701982, 9576.569054392708, 9633.855492167482, 9649.710508684751], "unit": "score", "name": "yui.html", "value": 6909.285073225523}], "name": "dromaeo_css", "value": 7422.35986712803}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 111.0, 110.0, 111.0, 117.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 142.0, 160.0, 119.0, 145.0, 160.0, 141.0, 161.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [187.0, 187.0, 187.0, 187.0, 188.0, 186.0, 188.0, 202.0, 262.0, 187.0], "unit": "score", "name": "audio-dft", "value": 196.1}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 85.0, 80.0, 55.0, 59.0, 57.0, 82.0, 80.0, 57.0], "unit": "score", "name": "audio-fft", "value": 70.7}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 129.0, 77.0, 77.0, 81.0, 114.0, 87.0, 110.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 100.0}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 90.0, 127.0, 132.0, 85.0, 87.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 83.0, 84.0, 86.0, 84.0, 87.0, 87.0, 88.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 55.0, 52.0, 52.0, 54.0, 65.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 76.0, 76.0, 71.0, 69.0, 72.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 82.0, 83.0, 83.0, 83.0, 81.0, 79.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 136.0, 132.0, 122.0, 123.0, 134.0, 127.0, 126.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [142.0, 168.0, 173.0, 161.0, 141.0, 125.0, 157.0, 171.0, 147.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 92.0, 91.0, 58.0, 65.0, 91.0, 87.0, 89.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.6}], "name": "kraken", "value": 1459.9}]} 04:57:34 INFO - Return code: 0 04:57:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:57:34 ERROR - # TBPL SUCCESS # 04:57:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:34 INFO - 2016-04-04 04:57:34.678 screenresolution[2317:74157] starting screenresolution argv=screenresolution get 04:57:34 INFO - 2016-04-04 04:57:34.681 screenresolution[2317:74157] Display 0: 1600x1200x32@60 04:57:34 INFO - 2016-04-04 04:57:34.687 screenresolution[2318:74160] starting screenresolution argv=screenresolution list 04:57:34 INFO - Available Modes on Display 0 04:57:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:34 INFO - Intel Iris: 04:57:34 INFO - Chipset Model: Intel Iris 04:57:34 INFO - Type: GPU 04:57:34 INFO - Bus: Built-In 04:57:34 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:34 INFO - Vendor: Intel (0x8086) 04:57:34 INFO - Device ID: 0x0a2e 04:57:34 INFO - Revision ID: 0x0009 04:57:34 INFO - Displays: 04:57:34 INFO - Display: 04:57:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:34 INFO - Display Serial Number: 1600x1200 60 04:57:34 INFO - Main Display: Yes 04:57:34 INFO - Mirror: Off 04:57:34 INFO - Online: Yes 04:57:34 INFO - Rotation: Supported 04:57:34 INFO - Return code: 0 04:57:34 INFO - Running post-action listener: _resource_record_post_action 04:57:34 INFO - Running post-run listener: _resource_record_post_run 04:57:35 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 0; Write bytes: 701104640; Read time: 0; Write time: 2186 04:57:35 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392487424; Write bytes: 387393024; Read time: 29978; Write time: 703 04:57:35 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 0; Write bytes: 296258560; Read time: 0; Write time: 1444 04:57:35 INFO - Running post-run listener: _upload_blobber_files 04:57:35 INFO - Blob upload gear active. 04:57:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:35 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 04:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:37 INFO - (blobuploader) - INFO - Done attempting. 04:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:38 INFO - (blobuploader) - INFO - Done attempting. 04:57:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:38 INFO - Return code: 0 04:57:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f04384c45a46da6b3e33e6f7f2ccad251506df51a36493f13711190099fe821b8810754721bab977bb241e68b5828e73f35561dab7646ed663fe3c491e9a3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fdad4d00db24db03e857072e9a3be1568357fe89acd954a92ed2348dde965ba67f6d7a329fbdd9d186e8bde74f036a70770011f2086c35fbaa75ab3fec8ccb"} 04:57:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:38 INFO - Contents: 04:57:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f04384c45a46da6b3e33e6f7f2ccad251506df51a36493f13711190099fe821b8810754721bab977bb241e68b5828e73f35561dab7646ed663fe3c491e9a3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fdad4d00db24db03e857072e9a3be1568357fe89acd954a92ed2348dde965ba67f6d7a329fbdd9d186e8bde74f036a70770011f2086c35fbaa75ab3fec8ccb"} 04:57:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:38 INFO - Copying logs to upload dir... 04:57:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.615375 ========= master_lag: 2.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-04 04:57:41.101570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-04-04 04:57:41.107249) ========= 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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f04384c45a46da6b3e33e6f7f2ccad251506df51a36493f13711190099fe821b8810754721bab977bb241e68b5828e73f35561dab7646ed663fe3c491e9a3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fdad4d00db24db03e857072e9a3be1568357fe89acd954a92ed2348dde965ba67f6d7a329fbdd9d186e8bde74f036a70770011f2086c35fbaa75ab3fec8ccb"} build_url:https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/Mf5SF14WTQy6slCf5Y_pLw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f04384c45a46da6b3e33e6f7f2ccad251506df51a36493f13711190099fe821b8810754721bab977bb241e68b5828e73f35561dab7646ed663fe3c491e9a3c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fdad4d00db24db03e857072e9a3be1568357fe89acd954a92ed2348dde965ba67f6d7a329fbdd9d186e8bde74f036a70770011f2086c35fbaa75ab3fec8ccb"}' ========= master_lag: 4.74 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-04-04 04:57:45.857980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2016-04-04 04:57:45.858278) ========= 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.gbNNcXmQI8/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.uVaeJmTXNd/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005981 ========= master_lag: 13.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2016-04-04 04:57:58.903948) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-04 04:57:58.904316) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-04 04:58:03.578914) ========= ========= Total master_lag: 20.66 =========