builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0132 starttime: 1459740147.12 results: success (0) buildid: 20160403183818 builduid: 0370e4b7ad4243fd8473f907b22eef70 revision: eaab4a3353618c192dbc9f3fa2ec3fc006034c30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.123146) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.123552) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.123886) ========= 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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005507 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.195148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.195456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.250734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.251082) ========= 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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005937 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.301200) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.301574) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.302053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.302446) ========= 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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-03 20:22:27-- 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% 143M=0s 2016-04-03 20:22:27 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.547052 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.865309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.865638) ========= 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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.026582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.918684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:27.919488) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eaab4a3353618c192dbc9f3fa2ec3fc006034c30 --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 eaab4a3353618c192dbc9f3fa2ec3fc006034c30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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-03 20:22:28,003 truncating revision to first 12 chars 2016-04-03 20:22:28,003 Setting DEBUG logging. 2016-04-03 20:22:28,003 attempt 1/10 2016-04-03 20:22:28,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eaab4a335361?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-03 20:22:28,663 unpacking tar archive at: fx-team-eaab4a335361/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:28.848274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:28.848651) ========= echo eaab4a3353618c192dbc9f3fa2ec3fc006034c30 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'eaab4a3353618c192dbc9f3fa2ec3fc006034c30'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 eaab4a3353618c192dbc9f3fa2ec3fc006034c30 program finished with exit code 0 elapsedTime=0.005469 script_repo_revision: 'eaab4a3353618c192dbc9f3fa2ec3fc006034c30' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:28.907131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:28.907445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 20:22:28.925058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-03 20:22:28.925751) ========= /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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:22:29 INFO - MultiFileLogger online at 20160403 20:22:29 in /builds/slave/test 20:22:29 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 20:22:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:29 INFO - {'append_to_log': False, 20:22:29 INFO - 'base_work_dir': '/builds/slave/test', 20:22:29 INFO - 'blob_upload_branch': 'Fx-Team', 20:22:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:29 INFO - 'branch': 'Fx-Team', 20:22:29 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:29 INFO - 'config_files': ('talos/mac_config.py',), 20:22:29 INFO - 'default_actions': ('clobber', 20:22:29 INFO - 'read-buildbot-config', 20:22:29 INFO - 'download-and-extract', 20:22:29 INFO - 'populate-webroot', 20:22:29 INFO - 'create-virtualenv', 20:22:29 INFO - 'install', 20:22:29 INFO - 'run-tests'), 20:22:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:29 INFO - 'download_minidump_stackwalk': True, 20:22:29 INFO - 'download_symbols': 'ondemand', 20:22:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:29 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:29 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:29 INFO - 'installer_path': 'installer.exe', 20:22:29 INFO - 'log_level': 'info', 20:22:29 INFO - 'log_name': 'talos', 20:22:29 INFO - 'log_to_console': True, 20:22:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:22:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:22:29 INFO - 'opt_config_files': (), 20:22:29 INFO - 'pip_index': False, 20:22:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:22:29 INFO - 'cmd': ('bash', 20:22:29 INFO - '-c', 20:22:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:22:29 INFO - 'enabled': True, 20:22:29 INFO - 'halt_on_failure': False, 20:22:29 INFO - 'name': 'check_screen_resolution'},), 20:22:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:22:29 INFO - 'cmd': ('bash', 20:22:29 INFO - '-c', 20:22:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:22:29 INFO - 'enabled': True, 20:22:29 INFO - 'halt_on_failure': False, 20:22:29 INFO - 'name': 'check_screen_resolution'},), 20:22:29 INFO - 'run_cmd_checks_enabled': True, 20:22:29 INFO - 'sps_profile': False, 20:22:29 INFO - 'sps_profile_interval': 0, 20:22:29 INFO - 'suite': 'dromaeojs', 20:22:29 INFO - 'system_bits': '32', 20:22:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:29 INFO - 'title': 't-yosemite-r7-0132', 20:22:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:29 INFO - 'use_talos_json': True, 20:22:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:29 INFO - 'work_dir': 'build'} 20:22:29 INFO - ##### 20:22:29 INFO - ##### Running clobber step. 20:22:29 INFO - ##### 20:22:29 INFO - Running pre-action listener: _resource_record_pre_action 20:22:29 INFO - Running main action method: clobber 20:22:29 INFO - rmtree: /builds/slave/test/build 20:22:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:30 INFO - Running post-action listener: _resource_record_post_action 20:22:30 INFO - ##### 20:22:30 INFO - ##### Running read-buildbot-config step. 20:22:30 INFO - ##### 20:22:30 INFO - Running pre-action listener: _resource_record_pre_action 20:22:30 INFO - Running main action method: read_buildbot_config 20:22:30 INFO - Using buildbot properties: 20:22:30 INFO - { 20:22:30 INFO - "project": "", 20:22:30 INFO - "product": "firefox", 20:22:30 INFO - "script_repo_revision": "production", 20:22:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 20:22:30 INFO - "repository": "", 20:22:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 20:22:30 INFO - "buildid": "20160403183818", 20:22:30 INFO - "pgo_build": "False", 20:22:30 INFO - "basedir": "/builds/slave/test", 20:22:30 INFO - "buildnumber": 574, 20:22:30 INFO - "slavename": "t-yosemite-r7-0132", 20:22:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:22:30 INFO - "platform": "yosemite_r7", 20:22:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 20:22:30 INFO - "branch": "fx-team", 20:22:30 INFO - "repo_path": "integration/fx-team", 20:22:30 INFO - "revision": "eaab4a3353618c192dbc9f3fa2ec3fc006034c30", 20:22:30 INFO - "stage_platform": "macosx64", 20:22:30 INFO - "builduid": "0370e4b7ad4243fd8473f907b22eef70", 20:22:30 INFO - "slavebuilddir": "test" 20:22:30 INFO - } 20:22:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 20:22:30 INFO - Running post-action listener: _resource_record_post_action 20:22:30 INFO - ##### 20:22:30 INFO - ##### Running download-and-extract step. 20:22:30 INFO - ##### 20:22:30 INFO - Running pre-action listener: _resource_record_pre_action 20:22:30 INFO - Running main action method: download_and_extract 20:22:30 INFO - mkdir: /builds/slave/test/build/tests 20:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:30 INFO - https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 20:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 20:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:22:41 INFO - Downloaded 1199 bytes. 20:22:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 20:22:41 INFO - Using the following test package requirements: 20:22:41 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 20:22:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 20:22:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 20:22:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'jsshell-mac.zip'], 20:22:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 20:22:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 20:22:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 20:22:41 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 20:22:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 20:22:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 20:22:41 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 20:22:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:41 INFO - https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 20:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 20:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:22:43 INFO - Downloaded 17960036 bytes. 20:22:43 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'] 20:22:43 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 20:22:46 INFO - Return code: 0 20:22:46 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 20:22:46 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')]} 20:22:46 INFO - https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 20:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 20:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:23:00 INFO - Downloaded 17960036 bytes. 20:23:00 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'] 20:23:00 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 20:23:03 INFO - Return code: 0 20:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:03 INFO - https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 20:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 20:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:23:04 INFO - Downloaded 10847584 bytes. 20:23:04 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'] 20:23:04 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 20:23:04 INFO - Return code: 0 20:23: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')]} 20:23:04 INFO - https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 20:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 20:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 20:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bmyQxZxjS7eXQvTuScyJhw/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 20:23:10 INFO - Downloaded 111316411 bytes. 20:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 20:23:10 INFO - mkdir: /builds/slave/test/properties 20:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 20:23:10 INFO - Contents: 20:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 20:23:11 INFO - Running post-action listener: _resource_record_post_action 20:23:11 INFO - Running post-action listener: set_extra_try_arguments 20:23:11 INFO - ##### 20:23:11 INFO - ##### Running populate-webroot step. 20:23:11 INFO - ##### 20:23:11 INFO - Running pre-action listener: _resource_record_pre_action 20:23:11 INFO - Running main action method: populate_webroot 20:23:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:23:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:23:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:23:11 INFO - '--tppagecycles', 20:23:11 INFO - '7'], 20:23:11 INFO - 'tests': ['tsvgm']}}, 20:23:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:23:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:23:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:23:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:23:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:23:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:23:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'tests': ['damp', 'tps']}, 20:23:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['damp', 'tps']}, 20:23:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:23:11 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['dromaeo_dom']}, 20:23:11 INFO - 'other': {'tests': ['a11yr', 20:23:11 INFO - 'ts_paint', 20:23:11 INFO - 'tpaint', 20:23:11 INFO - 'sessionrestore', 20:23:11 INFO - 'sessionrestore_no_auto_restore', 20:23:11 INFO - 'tabpaint']}, 20:23:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['a11yr', 20:23:11 INFO - 'ts_paint', 20:23:11 INFO - 'tpaint', 20:23:11 INFO - 'sessionrestore', 20:23:11 INFO - 'sessionrestore_no_auto_restore', 20:23:11 INFO - 'tabpaint']}, 20:23:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['a11yr', 20:23:11 INFO - 'ts_paint', 20:23:11 INFO - 'tpaint', 20:23:11 INFO - 'sessionrestore', 20:23:11 INFO - 'sessionrestore_no_auto_restore', 20:23:11 INFO - 'tabpaint']}, 20:23:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['a11yr', 20:23:11 INFO - 'ts_paint', 20:23:11 INFO - 'tpaint', 20:23:11 INFO - 'sessionrestore', 20:23:11 INFO - 'sessionrestore_no_auto_restore', 20:23:11 INFO - 'tabpaint']}, 20:23:11 INFO - 'other_l64': {'tests': ['a11yr', 20:23:11 INFO - 'ts_paint', 20:23:11 INFO - 'tpaint', 20:23:11 INFO - 'sessionrestore', 20:23:11 INFO - 'sessionrestore_no_auto_restore', 20:23:11 INFO - 'tabpaint']}, 20:23:11 INFO - 'other_nol64': {'tests': ['a11yr', 20:23:11 INFO - 'ts_paint', 20:23:11 INFO - 'tpaint', 20:23:11 INFO - 'sessionrestore', 20:23:11 INFO - 'sessionrestore_no_auto_restore', 20:23:11 INFO - 'tabpaint']}, 20:23:11 INFO - 'svgr': {'tests': ['tsvgx', 20:23:11 INFO - 'tsvgr_opacity', 20:23:11 INFO - 'tart', 20:23:11 INFO - 'tscrollx', 20:23:11 INFO - 'cart']}, 20:23:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['tsvgx', 20:23:11 INFO - 'tsvgr_opacity', 20:23:11 INFO - 'tart', 20:23:11 INFO - 'tscrollx', 20:23:11 INFO - 'cart']}, 20:23:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'tests': ['tp5o']}, 20:23:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'talos_options': ['--e10s'], 20:23:11 INFO - 'tests': ['tp5o']}, 20:23:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'talos_options': ['--xperf_path', 20:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:23:11 INFO - 'tests': ['tp5n']}, 20:23:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:23:11 INFO - 'talos_options': ['--e10s', 20:23:11 INFO - '--xperf_path', 20:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:23:11 INFO - 'tests': ['tp5n']}}, 20:23:11 INFO - 'talos.zip': {'path': '', 20:23:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:23:11 INFO - Running post-action listener: _resource_record_post_action 20:23:11 INFO - ##### 20:23:11 INFO - ##### Running create-virtualenv step. 20:23:11 INFO - ##### 20:23:11 INFO - Running pre-action listener: _resource_record_pre_action 20:23:11 INFO - Running main action method: create_virtualenv 20:23:11 INFO - Creating virtualenv /builds/slave/test/build/venv 20:23:11 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 20:23:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:23:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:23:11 INFO - Using real prefix '/tools/python27' 20:23:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:23:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:23:15 INFO - Installing pip.................done. 20:23:15 INFO - Return code: 0 20:23:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:23:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:15 INFO - 'HOME': '/Users/cltbld', 20:23:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:15 INFO - 'LOGNAME': 'cltbld', 20:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:15 INFO - 'MOZ_NO_REMOTE': '1', 20:23:15 INFO - 'NO_EM_RESTART': '1', 20:23:15 INFO - 'PAGER': '/bin/cat', 20:23:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:15 INFO - 'PWD': '/builds/slave/test', 20:23:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:15 INFO - 'SHELL': '/bin/bash', 20:23:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:15 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:15 INFO - 'USER': 'cltbld', 20:23:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:15 INFO - 'XPC_FLAGS': '0x0', 20:23:15 INFO - 'XPC_SERVICE_NAME': '0', 20:23:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:15 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 20:23:15 INFO - Cleaning up... 20:23:15 INFO - Return code: 0 20:23:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:23:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:15 INFO - 'HOME': '/Users/cltbld', 20:23:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:15 INFO - 'LOGNAME': 'cltbld', 20:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:15 INFO - 'MOZ_NO_REMOTE': '1', 20:23:15 INFO - 'NO_EM_RESTART': '1', 20:23:15 INFO - 'PAGER': '/bin/cat', 20:23:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:15 INFO - 'PWD': '/builds/slave/test', 20:23:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:15 INFO - 'SHELL': '/bin/bash', 20:23:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:15 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:15 INFO - 'USER': 'cltbld', 20:23:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:15 INFO - 'XPC_FLAGS': '0x0', 20:23:15 INFO - 'XPC_SERVICE_NAME': '0', 20:23:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:15 INFO - Downloading/unpacking psutil>=0.7.1 20:23: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 20:23: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 20:23: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 20:23: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 20:23: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 20:23: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 20:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:23:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:23:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:23:18 INFO - Installing collected packages: psutil 20:23:18 INFO - Running setup.py install for psutil 20:23:18 INFO - building 'psutil._psutil_osx' extension 20:23:18 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 20:23:19 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 20:23:19 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 20:23:19 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 20:23:19 INFO - building 'psutil._psutil_posix' extension 20:23:19 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 20:23:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:23:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:23:19 INFO - ^ 20:23:19 INFO - 1 warning generated. 20:23:19 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 20:23:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:23:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:23:20 INFO - Successfully installed psutil 20:23:20 INFO - Cleaning up... 20:23:20 INFO - Return code: 0 20:23:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:23:20 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')]} 20:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:20 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')]} 20:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:20 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:20 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 20:23:20 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 20:23:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:20 INFO - 'HOME': '/Users/cltbld', 20:23:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:20 INFO - 'LOGNAME': 'cltbld', 20:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:20 INFO - 'MOZ_NO_REMOTE': '1', 20:23:20 INFO - 'NO_EM_RESTART': '1', 20:23:20 INFO - 'PAGER': '/bin/cat', 20:23:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:20 INFO - 'PWD': '/builds/slave/test', 20:23:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:20 INFO - 'SHELL': '/bin/bash', 20:23:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:20 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:20 INFO - 'USER': 'cltbld', 20:23:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:20 INFO - 'XPC_FLAGS': '0x0', 20:23:20 INFO - 'XPC_SERVICE_NAME': '0', 20:23:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:23:22 INFO - Installing collected packages: mozsystemmonitor 20:23:22 INFO - Running setup.py install for mozsystemmonitor 20:23:22 INFO - Successfully installed mozsystemmonitor 20:23:22 INFO - Cleaning up... 20:23:23 INFO - Return code: 0 20:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:23:23 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')]} 20:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:23 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')]} 20:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:23 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:23 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 20:23:23 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 20:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:23 INFO - 'HOME': '/Users/cltbld', 20:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:23 INFO - 'LOGNAME': 'cltbld', 20:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:23 INFO - 'MOZ_NO_REMOTE': '1', 20:23:23 INFO - 'NO_EM_RESTART': '1', 20:23:23 INFO - 'PAGER': '/bin/cat', 20:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:23 INFO - 'PWD': '/builds/slave/test', 20:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:23 INFO - 'SHELL': '/bin/bash', 20:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:23 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:23 INFO - 'USER': 'cltbld', 20:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:23 INFO - 'XPC_FLAGS': '0x0', 20:23:23 INFO - 'XPC_SERVICE_NAME': '0', 20:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:23 INFO - Downloading/unpacking blobuploader==1.2.4 20:23: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 20:23: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 20:23:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23: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 20:23: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 20:23: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 20:23:25 INFO - Downloading blobuploader-1.2.4.tar.gz 20:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:23:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:23: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 20:23: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 20:23: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 20:23: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 20:23: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 20:23: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 20:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:23:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:23: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 20:23: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 20:23: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 20:23: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 20:23: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 20:23: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 20:23:26 INFO - Downloading docopt-0.6.1.tar.gz 20:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:23:26 INFO - Installing collected packages: blobuploader, requests, docopt 20:23:26 INFO - Running setup.py install for blobuploader 20:23:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:23:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:23:27 INFO - Running setup.py install for requests 20:23:27 INFO - Running setup.py install for docopt 20:23:27 INFO - Successfully installed blobuploader requests docopt 20:23:27 INFO - Cleaning up... 20:23:27 INFO - Return code: 0 20:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:27 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')]} 20:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:27 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')]} 20:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:27 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:27 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 20:23:27 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 20:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:27 INFO - 'HOME': '/Users/cltbld', 20:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:27 INFO - 'LOGNAME': 'cltbld', 20:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:27 INFO - 'MOZ_NO_REMOTE': '1', 20:23:27 INFO - 'NO_EM_RESTART': '1', 20:23:27 INFO - 'PAGER': '/bin/cat', 20:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:27 INFO - 'PWD': '/builds/slave/test', 20:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:27 INFO - 'SHELL': '/bin/bash', 20:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:27 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:27 INFO - 'USER': 'cltbld', 20:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:27 INFO - 'XPC_FLAGS': '0x0', 20:23:27 INFO - 'XPC_SERVICE_NAME': '0', 20:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-wpb1nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-2uDQ92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-wd2LS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Sfgz8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-l50e7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-7DQH7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-atdCpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-J9LY2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:23:28 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-exQPA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TpJ1KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-dULCEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1L0epn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-qnITTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-hQ_Myp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-r8ohay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-yl2mSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:23:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-W2ZlMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:23:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:23:29 INFO - Running setup.py install for manifestparser 20:23:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:23:29 INFO - Running setup.py install for mozcrash 20:23:30 INFO - Running setup.py install for mozdebug 20:23:30 INFO - Running setup.py install for mozdevice 20:23:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Running setup.py install for mozfile 20:23:30 INFO - Running setup.py install for mozhttpd 20:23:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Running setup.py install for mozinfo 20:23:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Running setup.py install for mozInstall 20:23:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:23:30 INFO - Running setup.py install for mozleak 20:23:31 INFO - Running setup.py install for mozlog 20:23:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:23:31 INFO - Running setup.py install for moznetwork 20:23:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:23:31 INFO - Running setup.py install for mozprocess 20:23:31 INFO - Running setup.py install for mozprofile 20:23:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:23:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:23:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:23:31 INFO - Running setup.py install for mozrunner 20:23:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:23:31 INFO - Running setup.py install for mozscreenshot 20:23:32 INFO - Running setup.py install for moztest 20:23:32 INFO - Running setup.py install for mozversion 20:23:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:23:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:23:32 INFO - Cleaning up... 20:23:32 INFO - Return code: 0 20:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23:32 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')]} 20:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:32 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')]} 20:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:32 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:32 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 20:23:32 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 20:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:32 INFO - 'HOME': '/Users/cltbld', 20:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:32 INFO - 'LOGNAME': 'cltbld', 20:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:32 INFO - 'MOZ_NO_REMOTE': '1', 20:23:32 INFO - 'NO_EM_RESTART': '1', 20:23:32 INFO - 'PAGER': '/bin/cat', 20:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:32 INFO - 'PWD': '/builds/slave/test', 20:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:32 INFO - 'SHELL': '/bin/bash', 20:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:32 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:32 INFO - 'USER': 'cltbld', 20:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:32 INFO - 'XPC_FLAGS': '0x0', 20:23:32 INFO - 'XPC_SERVICE_NAME': '0', 20:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:23:32 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-3ZKdec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:23:32 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)) 20:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:23:32 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-mcphgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:23:32 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)) 20:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:23:32 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-JTLyFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:23:32 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)) 20:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:23:32 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-HzWs9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RxXQzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-S9WjQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TibW9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-hXNw_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-JpKJmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-v_weUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-D2MiHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-eyUfmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:23:33 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)) 20:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:23:33 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-pG383e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:23:34 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)) 20:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:23:34 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zjwlXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:23:34 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)) 20:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:34 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-GrdLWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:23:34 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)) 20:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:23:34 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-hFNyzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:23:34 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)) 20:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:23:34 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-mHK_FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:23:34 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)) 20:23:34 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)) 20:23:34 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)) 20:23:34 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)) 20:23:34 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)) 20:23:34 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)) 20:23:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:36 INFO - Downloading blessings-1.6.tar.gz 20:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:23:36 INFO - Installing collected packages: blessings 20:23:36 INFO - Running setup.py install for blessings 20:23:37 INFO - Successfully installed blessings 20:23:37 INFO - Cleaning up... 20:23:37 INFO - Return code: 0 20:23:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:23:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:37 INFO - Reading from file tmpfile_stdout 20:23:37 INFO - Current package versions: 20:23:37 INFO - blessings == 1.6 20:23:37 INFO - blobuploader == 1.2.4 20:23:37 INFO - docopt == 0.6.1 20:23:37 INFO - manifestparser == 1.1 20:23:37 INFO - mozInstall == 1.12 20:23:37 INFO - mozcrash == 0.17 20:23:37 INFO - mozdebug == 0.1 20:23:37 INFO - mozdevice == 0.48 20:23:37 INFO - mozfile == 1.2 20:23:37 INFO - mozhttpd == 0.7 20:23:37 INFO - mozinfo == 0.9 20:23:37 INFO - mozleak == 0.1 20:23:37 INFO - mozlog == 3.1 20:23:37 INFO - moznetwork == 0.27 20:23:37 INFO - mozprocess == 0.22 20:23:37 INFO - mozprofile == 0.28 20:23:37 INFO - mozrunner == 6.11 20:23:37 INFO - mozscreenshot == 0.1 20:23:37 INFO - mozsystemmonitor == 0.0 20:23:37 INFO - moztest == 0.7 20:23:37 INFO - mozversion == 1.4 20:23:37 INFO - psutil == 3.1.1 20:23:37 INFO - requests == 1.2.3 20:23:37 INFO - wsgiref == 0.1.2 20:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:23: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')]} 20:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23: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')]} 20:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:37 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:37 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 20:23:37 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 20:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:37 INFO - 'HOME': '/Users/cltbld', 20:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:37 INFO - 'LOGNAME': 'cltbld', 20:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:37 INFO - 'MOZ_NO_REMOTE': '1', 20:23:37 INFO - 'NO_EM_RESTART': '1', 20:23:37 INFO - 'PAGER': '/bin/cat', 20:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:37 INFO - 'PWD': '/builds/slave/test', 20:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:37 INFO - 'SHELL': '/bin/bash', 20:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:37 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:37 INFO - 'USER': 'cltbld', 20:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:37 INFO - 'XPC_FLAGS': '0x0', 20:23:37 INFO - 'XPC_SERVICE_NAME': '0', 20:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 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)) 20:23:37 INFO - Cleaning up... 20:23:37 INFO - Return code: 0 20:23:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:23: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')]} 20:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23: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')]} 20:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:37 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:37 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 20:23:37 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 20:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:37 INFO - 'HOME': '/Users/cltbld', 20:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:37 INFO - 'LOGNAME': 'cltbld', 20:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:37 INFO - 'MOZ_NO_REMOTE': '1', 20:23:37 INFO - 'NO_EM_RESTART': '1', 20:23:37 INFO - 'PAGER': '/bin/cat', 20:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:37 INFO - 'PWD': '/builds/slave/test', 20:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:37 INFO - 'SHELL': '/bin/bash', 20:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:37 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:37 INFO - 'USER': 'cltbld', 20:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:37 INFO - 'XPC_FLAGS': '0x0', 20:23:37 INFO - 'XPC_SERVICE_NAME': '0', 20:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:37 INFO - Downloading/unpacking jsonschema 20:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:23:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:23:40 INFO - Downloading/unpacking functools32 (from jsonschema) 20:23:40 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 20:23:40 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 20:23:40 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 20:23:40 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 20:23:40 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 20:23:40 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 20:23:40 INFO - Downloading functools32-3.2.3-2.tar.gz 20:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:23:40 INFO - warning: no files found matching '*.txt' 20:23:40 INFO - no previously-included directories found matching 'build' 20:23:40 INFO - no previously-included directories found matching 'dist' 20:23:40 INFO - no previously-included directories found matching '.git*' 20:23:40 INFO - Installing collected packages: jsonschema, functools32 20:23:40 INFO - Running setup.py install for functools32 20:23:41 INFO - warning: no files found matching '*.txt' 20:23:41 INFO - no previously-included directories found matching 'build' 20:23:41 INFO - no previously-included directories found matching 'dist' 20:23:41 INFO - no previously-included directories found matching '.git*' 20:23:41 INFO - Successfully installed jsonschema functools32 20:23:41 INFO - Cleaning up... 20:23:41 INFO - Return code: 0 20:23:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:23:41 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 0x104746a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104756420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5248a5b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, '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.gstFTeQoSs/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.bRLBki6FmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 20:23:41 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 20:23:41 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 20:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:23:41 INFO - 'HOME': '/Users/cltbld', 20:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:23:41 INFO - 'LOGNAME': 'cltbld', 20:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:41 INFO - 'MOZ_NO_REMOTE': '1', 20:23:41 INFO - 'NO_EM_RESTART': '1', 20:23:41 INFO - 'PAGER': '/bin/cat', 20:23:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:23:41 INFO - 'PWD': '/builds/slave/test', 20:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:23:41 INFO - 'SHELL': '/bin/bash', 20:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:23:41 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:23:41 INFO - 'USER': 'cltbld', 20:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:41 INFO - 'XPC_FLAGS': '0x0', 20:23:41 INFO - 'XPC_SERVICE_NAME': '0', 20:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:23:41 INFO - Downloading/unpacking flake8 20:23:41 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 20:23:41 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 20:23:41 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 20:23:41 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 20:23:41 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 20:23:41 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 20:23:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:23:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:23:43 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 20:23:43 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 20:23:43 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 20:23:43 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 20:23:43 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 20:23:43 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 20:23:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:23:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 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 20:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:23:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:23:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:23:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:23:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:23:45 INFO - no previously-included directories found matching 'docs/_build' 20:23:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:23:45 INFO - Running setup.py install for pep8 20:23:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:23:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:23:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:23:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:23:45 INFO - no previously-included directories found matching 'docs/_build' 20:23:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:23:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:23:45 INFO - Cleaning up... 20:23:45 INFO - Return code: 0 20:23:45 INFO - Running post-action listener: _resource_record_post_action 20:23:45 INFO - Running post-action listener: _start_resource_monitoring 20:23:45 INFO - Starting resource monitoring. 20:23:45 INFO - ##### 20:23:45 INFO - ##### Running install step. 20:23:45 INFO - ##### 20:23:45 INFO - Running pre-action listener: _resource_record_pre_action 20:23:45 INFO - Running main action method: install 20:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:23:45 INFO - Reading from file tmpfile_stdout 20:23:45 INFO - Detecting whether we're running mozinstall >=1.0... 20:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:23:45 INFO - Reading from file tmpfile_stdout 20:23:45 INFO - Output received: 20:23:45 INFO - Usage: mozinstall [options] installer 20:23:45 INFO - Options: 20:23:45 INFO - -h, --help show this help message and exit 20:23:45 INFO - -d DEST, --destination=DEST 20:23:45 INFO - Directory to install application into. [default: 20:23:45 INFO - "/builds/slave/test"] 20:23:45 INFO - --app=APP Application being installed. [default: firefox] 20:23:45 INFO - mkdir: /builds/slave/test/build/application 20:23:45 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'] 20:23:45 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 20:24:19 INFO - Reading from file tmpfile_stdout 20:24:19 INFO - Output received: 20:24:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:24:19 INFO - Running post-action listener: _resource_record_post_action 20:24:19 INFO - ##### 20:24:19 INFO - ##### Running run-tests step. 20:24:19 INFO - ##### 20:24:19 INFO - Running pre-action listener: _resource_record_pre_action 20:24:19 INFO - Running main action method: run_tests 20:24:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:24:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:24:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:24:19 INFO - 2016-04-03 20:24:19.345 screenresolution[1650:8000] starting screenresolution argv=screenresolution get 20:24:19 INFO - 2016-04-03 20:24:19.348 screenresolution[1650:8000] Display 0: 1600x1200x32@60 20:24:19 INFO - 2016-04-03 20:24:19.353 screenresolution[1651:8002] starting screenresolution argv=screenresolution list 20:24:19 INFO - Available Modes on Display 0 20:24:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:24:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:24:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:24:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:24:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:24:19 INFO - Intel Iris: 20:24:19 INFO - Chipset Model: Intel Iris 20:24:19 INFO - Type: GPU 20:24:19 INFO - Bus: Built-In 20:24:19 INFO - VRAM (Dynamic, Max): 1536 MB 20:24:19 INFO - Vendor: Intel (0x8086) 20:24:19 INFO - Device ID: 0x0a2e 20:24:19 INFO - Revision ID: 0x0009 20:24:19 INFO - Displays: 20:24:19 INFO - Display: 20:24:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:24:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:24:19 INFO - Display Serial Number: 1600x1200 60 20:24:19 INFO - Main Display: Yes 20:24:19 INFO - Mirror: Off 20:24:19 INFO - Online: Yes 20:24:19 INFO - Rotation: Supported 20:24:19 INFO - Return code: 0 20:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:24:19 INFO - Python 2.7.3 20:24:19 INFO - Return code: 0 20:24:19 INFO - grabbing minidump binary from tooltool 20:24: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')]} 20:24:19 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 0x1045e5e00>, '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 0x10440edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:24:19 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 20:24:19 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 20:24:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:24:19 INFO - Return code: 0 20:24:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:24:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:24:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:24:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:24:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:24:20 INFO - Return code: 0 20:24:20 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/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 20:24:20 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/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --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 20:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gstFTeQoSs/Render', 20:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:20 INFO - 'HOME': '/Users/cltbld', 20:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:20 INFO - 'LOGNAME': 'cltbld', 20:24:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:24:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:20 INFO - 'MOZ_NO_REMOTE': '1', 20:24:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:24:20 INFO - 'NO_EM_RESTART': '1', 20:24:20 INFO - 'PAGER': '/bin/cat', 20:24:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:20 INFO - 'PWD': '/builds/slave/test', 20:24:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:20 INFO - 'SHELL': '/bin/bash', 20:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bRLBki6FmQ/Listeners', 20:24:20 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 20:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:20 INFO - 'USER': 'cltbld', 20:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:20 INFO - 'XPC_FLAGS': '0x0', 20:24:20 INFO - 'XPC_SERVICE_NAME': '0', 20:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:20 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/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 20:24:21 INFO - mozversion application_buildid: 20160403183818 20:24:21 INFO - mozversion application_changeset: eaab4a3353618c192dbc9f3fa2ec3fc006034c30 20:24:21 INFO - mozversion application_display_name: Nightly 20:24:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:24:21 INFO - mozversion application_name: Firefox 20:24:21 INFO - mozversion application_remotingname: firefox 20:24:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:24:21 INFO - mozversion application_vendor: Mozilla 20:24:21 INFO - mozversion application_version: 48.0a1 20:24:21 INFO - mozversion platform_buildid: 20160403183818 20:24:21 INFO - mozversion platform_changeset: eaab4a3353618c192dbc9f3fa2ec3fc006034c30 20:24:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:24:21 INFO - mozversion platform_version: 48.0a1 20:24:21 INFO - using testdate: 1459740261 20:24:21 INFO - actual date: 1459740261 20:24:21 INFO - starting webserver on 'localhost:49277' 20:24:21 INFO - SUITE-START | Running 2 tests 20:24:21 INFO - TEST-START | dromaeo_css 20:24:21 INFO - operating with platform_type : mac_ 20:24:21 INFO - Initialising browser for dromaeo_css test... 20:24:21 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpZl4cyk/profile http://localhost:49277/getInfo.html) 20:24:23 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 20:24:23 INFO - PROCESS | 1669 | colorDepth:24 20:24:23 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 20:24:23 INFO - PROCESS | 1669 | __metrics 20:24:23 INFO - PROCESS | 1669 | 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" 20:24:23 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:24:24 INFO - TEST-INFO | 1669: exit 0 20:24:24 INFO - Browser initialized. 20:24:24 INFO - Running cycle 1/1 for dromaeo_css test... 20:24:24 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpZl4cyk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:35 INFO - PROCESS | 1672 | RSS: Main: 236560384 20:24:35 INFO - PROCESS | 1672 | 20:25:27 INFO - PROCESS | 1672 | 1459740327270 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] 20:27:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 20:27:39 INFO - PROCESS | 1672 | RSS: Main: 353374208 20:27:39 INFO - PROCESS | 1672 | 20:30:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 20:30:42 INFO - PROCESS | 1672 | RSS: Main: 364896256 20:30:42 INFO - PROCESS | 1672 | 20:33:44 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 20:33:44 INFO - PROCESS | 1672 | RSS: Main: 361783296 20:33:44 INFO - PROCESS | 1672 | 20:36:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 20:36:47 INFO - PROCESS | 1672 | RSS: Main: 321863680 20:36:47 INFO - PROCESS | 1672 | 20:39:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 20:39:51 INFO - PROCESS | 1672 | RSS: Main: 324771840 20:39:51 INFO - PROCESS | 1672 | 20:42:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 20:42:54 INFO - PROCESS | 1672 | RSS: Main: 373960704 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | __start_tp_report 20:42:54 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 20:42:54 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 20:42:54 INFO - PROCESS | 1672 | |i|pagename|runs| 20:42:54 INFO - PROCESS | 1672 | |0;dojo.html;3433.6394678558754;3488.040788783083;3517.56030496188;3519.2785478976803;3558.4128618777904;5576.163575463683;5612.69130197839;5656.264685590872;5658.830235092949;5665.603407761453;5602.691851948141;5696;5696.430356964302;5709.514691251248;5711.600187986843;5099.617528685345;5166.250893620423;5194.8701282468055;5222.686638801684;5230.189320655304;5126.846194614168;5227;5233.921491177616;5235.188545775411;5253.133233016548;4405.515393306734;5247.265382846385;5254.710990895499;5282.128448805943;5318.867028324285;5077.136886729228;5104.719240441774;5160.767765450564;5201.661891977009;5209.817656382046;5135.3067335909545;5140.177571588528;5153.0466863630345;5161.458046905096;5224.294720212761;5580.609357344987;5581.944180558224;5598.048331783607;5615.719214039323;5617.522510586564;6057.727402266909;6098.420650038239;6129.846753831145;6231.594946328474;6235.781747638856;5212.791488340462;6230.408111229426;6277.748890044393;6303.842403939892;6324.209473815773;5780.104083867007;5783.421657834183;5803.245578074865;5808.332041815203;5845.532357411397;6208.50331973441;6231.345708700612;6271.592346497463;6272.2159730033745;6320.841978950563;6083.087536869417;6084.11780291864;6096.237970253718;6102.908456373158;6111.682900513584;6138.416850399294;6180.6600636965395;6187.102870083902;6225.315215326311;6229.221347331583;6043.214382130295;6122.081687746873;6144.262688477412;6169.136320914986;6174.753009879644;6186.257649082139;6189.690515474208;6193.6903154842075;6209.59637623553;6228.906566401508;4876.366072410564;4879.268109783561;4880.316755654211;4886.975565122223;4908.680935739166;4328.394024836525;4402.823887044482;4436.0462500562535;4439.733615983051;4458.621017213508;5563.165525171256;5621.325440947031;5644.435556444323;5649.180868774087;5649.491545760901;6096.420840020191;6118.527810132473;6123.526657168203;6130.122981477994;6166.4758495527485;5633.915491267634;5634.957532856434;5645.294338207724;5676.772929082873;5757.596968212185;5331.493508116722;5341.519263266325;5346.545543628835;5364;5370.758315875795;6270.655113968684;6278.058291256348;6290.0250461177675;6293.685315734195;6308.526860485574;6118.314626315956;6161.969190154021;6243.656598887105;6261.279952805486;6281.685915704105;6254.468370188585;6262.060690896402;6271.96864015677;6278.277998030102;6285;5737.770489180553;6071.848203794941;6132.41742034506;6147.231596050494;6171.105189747551;6106.389361064036;6119.472088496418;6184;6261.436470717657;6263.843403914756;5961.2846458425265;6061.818145455643;6063;6077.908831367445;6082.847928801815;4723.929141062956;6049.78825741097;6051.75792968294;6055.636661800306;6069.0592958091565;5859.091840764689;5912.674802885883;5917.289925209003;5940.732667030081;5958.344582096052;6025.276966764016;6029.547783916136;6061.848453788691;6080.2399700037495;6103.7253323601435;5745;5892.998190307572;5903.763849445974;5936.732847021981;5954 20:42:54 INFO - PROCESS | 1672 | |1;ext.html;490.5192910947274;543.418542159889;574.6867956963457;599.8365770316447;631.4317114596862;30651;30810;30969;31025;31045.844770776144;40714;40986;41003.9749006275;41015.35938562454;41023.794881025555;9538.284628652862;9788.804223915517;9789.07003834638;9791.902080979205;9799.265055120859;9639.759006024835;9762.511874406251;9810.21518278536;9813.558389872473;9814.165795907356;9750.414975101481;9827.262955278347;9835.70492885211;9843.507824608776;9844.950775246114;9721.611135554569;9810.21518278536;9814.509274536316;9815.067568580973;9833.01669833018;9589.082183563316;9716.31985760997;9825.312228144032;9834.754131146707;9837.803243935154;41328.793356033326;41713.1657366851;41735.7913210432;41855.581444185475;41935.7903210485;3284.1953721338186;3421.367047096295;3581.5702115746017;3728.384816505273;3865.594112618191;28742.425151497064;28790.424191516053;29043;29429.11712648624;29438.67525961337;2671.3455203475078;2749.1477641930865;2778;2797.3560601909726;2867;484184.5790771059;485151.1484885141;486001;487701;487705;46060.76969615131;46690.766546167055;46706.06587868224;66922;67741;45497.545024549334;45557;45831.47926863988;45868.77065614717;45885;15580.220988950507;15752.842471575366;15762.290696918666;15774.211289435483;15775.684486310209;12740.745185096246;12759.298238596966;12759.489620415265;12765.319282950684;12779.105462617714;13089.803652945213;14915.254237288093;14917.179555124572;14961.72825309839;14967.850321496646;5407.675539467566;6202.72087756052;6339.4611458025665;6396.936030639634;6397.904031439532;907.2379201470796;945.8297506448905;1054.536004158168;1074.3929679730927;1088.2436706489073;26569.867150664122;26617.600735988977;29541.966031188804;29891.850540747157;30024.399512009637;935.3359115028406;1153.3425947210178;1154.440096553171;1160.7562411893427;1186.163754553038;14953.419699937242;15075.39698412073;15200.315985780666;15209.239538023054;15223.391064357524;440131;502405;502993;503143;504091;57978;59669.10496342558;59701.40298597045;59753.701231493564;59817.50456238542;1330.9800352994712;1359.2863746533149;1443.1269082205115;1465.5163795947312;1487.6950225203807;28433.715662843108;28603;28968.479253573427;29110.7088929108;29881.95413160529;48003.75998119987;48363.79090522765;48703.78240544015;48711;48900.77748056327;342788;345641.2717936394;346070;346313;346800;28416.715832841408;33301.16747081342;34168.31663366669;34174;34188.974330770114;41020.384694230204;41737.79131104325;42034.7898260519;42078.737637870916;42145.36781948212;33996.66003339935;35178.59285628546;35618.821905890305;36386.8180659095;37234.813825930694;35252;35258.647413525534;35828.64171358253;36035.414510749826;36080.27839443249;29697.851510742308;35759.82120089383;35877.82061089678;36294.91115266546;36482;31172.908948186705;31929.8403507981;31951.520727188647;32068.83965580157;32841;20068.498287542927;21268.893655532243;24646.383840403418;24695.62956555689;24702.01191952374 20:42:54 INFO - PROCESS | 1672 | |2;jquery.html;361.9113317237277;363.1520399866314;368.3130960758186;370.78123906894945;373.5069707985457;19102.426927192188;19792.505187370323;20555.280565180205;21007.47481312968;21014;11882.702932426693;12272.07959403044;12276.447559859806;12282.447289871954;12303.446344914479;4676.415448068991;5130.51260130287;5178.818741344054;5402.162664786964;5417.674939503642;5319.601029922752;5360.303160589118;5382.1926710993275;5385.865353366158;5398.784048638069;5256.237845512398;5378.112611419111;5387.19192121183;5505.174223866412;6377.42603165715;5613.663180209201;6346.079818426326;6355.428011478943;6408.166938298014;6418.390252925965;5506.03644362235;5534.667919924817;5583.190437386556;5617.269754931874;5628.577856660767;13134.408951597201;13151.342432878319;17564.297428102862;22971.736554489496;23394.53210935772;2044.6830741235133;2097.674860396641;2136.9893150534303;2174.173813950689;2223.49971256466;9712.854307185398;9815.558299876522;9944.403335799803;10241.590336386536;10278.640247591298;1690.3238704518292;1694.74578813179;1722.457425910834;1786.3836976243176;1853.1938606706126;63390.38335016736;87193.69209461863;94682.52658736662;96561.9999999993;98450.52324215142;10981;11075.335479871233;11093.223474356879;11143.387113708824;11231.989120979151;12173.39133043362;12502.3748812559;12875.163114397534;13833.446662133401;13878.306084695725;6480.611163330215;6608.471322294205;7517.361024312994;7940.1265860755275;8009.918660980809;7169.749058782918;8577.914220857712;8664.09027052163;8695.739127826175;8781.07798681142;3634.60019397866;4370.661695992692;4383.3424986251675;4392.231359512072;4427.6236519896165;1771.6545273671768;1858.3124244029796;1863.9813601863807;1901.847852171823;1905.7046157845557;745;802.6027116577332;992.5682328187262;992.9453880036523;1031.7626945802358;16676.58308542296;19004.42986710401;19464.902675486814;19556.902215489117;19704.802951970585;824.7834444194765;893.2898345815092;920.4707293306376;961.6826447272383;985.3496692183124;9316.8602470963;9387.779588653431;10182.745431364276;10560.366378017343;10567.735806604742;566238;566917;569831;589180;592885;96280;96451.31938125602;98875;100163.49591260277;103455.4827225859;982.3643633350534;1033.8655974723238;1047.8794938582162;1050.7268110291227;1051.7055224537141;17243.482695519153;17565.736513952044;17650.91174544119;17867.642647146724;17935.282588696828;37468;37745.81127094347;42438.51465198703;49352.76618084576;51150.48849511457;44240.55759442493;61071.389286108344;62358.88205589793;62452;63357.366426335146;6163.722632481638;6947.826304342432;7560.546367217985;7605.847883042419;7902.723404680809;9773.755656108655;11779.469923853618;12124.272543647057;12178.57374991871;12226.816597751218;10438.217133715154;10684.679459616224;10688.625898093529;11071.723206919569;11196.104311655212;10729.195310351599;10875.075618572193;10995.505202265756;11130.944345278222;11228.55085796559;9630.759231019281;10877.347359158159;11217.551297948317;11289.943550282196;11401.657950261506;7770.10643775973;7856.135825059353;7898.210178982055;8117.55353455542;8158.265756081981;10130.392176469435;10771.46142692878;10873.836892446778;11188.888111118784;11189.104871610089 20:42:54 INFO - PROCESS | 1672 | |3;mootools.html;1437.942482300708;1585.9762103568444;1618.595351162209;1899.7435346228256;2021.3632705697705;8139.104698483162;8851.734447966563;9013.819723605524;9019.864702029476;9022.54887255638;8670.95664521678;8909.242714369286;8911.955440222806;8918.509481978488;8918.77703057424;2202.4053505553493;2438.341647755105;2454.631805229212;2471.369800700819;2520.861352625605;2521.18061629971;2566.922992310234;2569.730178331267;2572.356910772307;2573.202307284748;2459.631055341695;2524.8485090894515;2528.987355063222;2531.0635065025967;2532.569463191253;2469.148143890364;2482.094035676974;2525.3812815860047;2531.227975467491;2532.987335063331;2258.570871534403;2300.64340027296;2427.526632306701;2464.18681834994;2467.198160597813;8773.298136149093;8779.429337093132;8880.422772519765;8881.33389995753;8888.155625215659;5500.092484740013;5648.152777083429;5666.348369937468;5670.744816483269;5681.062624666966;3498.440249560058;3604.387254166798;3785.5646600641003;3792.260509200707;3792.7724336539895;1053.5469748008354;1065.0361422912276;1076.580133747839;1082.7942690888706;1086.7772106718103;11911.821322680167;12136.33250171249;12138.332391718452;12144.271343719405;12168.81746773799;4939.160342741742;4971.37857767779;5052.898942021213;5095.159298715745;5111.207762796698;10454.895451045544;10480.109190718722;10480.47597620116;10481.056704896597;10506.949305069586;5671.6597004179885;5673.3475650299915;5685.658860468385;5694.515966142924;5697.572682048863;4476.395686582335;4657.464391594942;4929.457759646436;4994.8251811187165;5039.370078740158;3925.4700615417123;3995.9400608990886;4002.7198096133575;4051.0682543015273;4061.3907913812573;1319.8680131986916;1351.5877657314418;1353.9729205415836;1365.6381059019368;1372.19726460022;1197.8921897029309;1347.3128704360847;1392.1507880193074;1399.846016938136;1405.7329107469548;7929.405294602928;8269.338452923752;8275.62759675816;8346.66613335472;8348.833023339499;1197.7903866823272;1200.5257923120319;1208.8005479096028;1211.2429731417865;1224.5530381410722;5910.379410161957;6023.427774361428;6358.43589807082;6415.262244841903;6462.386073323027;10482.633107841342;10866.782664346669;10890.945545272223;10979.780404391868;10997.945010274898;10711.25021248505;10714.571417143226;10716.928307169377;10740.624078157227;10810.243282970274;8271.917280827234;8423.031351394668;8433.28317093054;8448.746537603882;8480.575971201415;7646.694132234871;7764.5729484878875;8003.279704826594;8014.479058861155;8093.716719914774;9585.329026968046;9689.176420004096;9771.267154963549;9883.901160988586;9933.65232216869;9842.015798420101;10117.59529618807;10224.386536807815;10249.12882405004;10285.588576457158;6412;6416.13382193398;6416.45460135875;7040.929590704028;7161.4270858330165;8293.875591866248;8358.205970432798;8366.790830229293;8369.372297077865;8374.120717324593;7304.4886857921565;7375.520591161558;7405.666744996596;7514.586697731677;7553.5845528494265;7241.058662373857;7272.345488905812;7379.778606641809;7415.740449084256;7426.554406735613;6678.76624318166;7716.652750626123;7818.648160832662;7871.48835325702;7879.448438609243;7066.293370662893;7076.752313668997;7118.394936430254;7138;7151.713931442684;7190.496665233383;7192.42460603161;7234.131904171533;7259.165196002316;7259.854802904018 20:42:54 INFO - PROCESS | 1672 | |4;prototype.html;296.8011432340332;329.9935197647177;334.37471927495585;335.8606178435949;340.962494125646;6377.553571250009;6392.936070639293;6447.2263328400595;6471.1263979362775;6475.481961443085;5136.409312929014;6348.428641422271;6388.297287298405;6397.3602639736;6421.004744264646;4586.4266966629175;4657;4663.277192035223;4687.976560117212;4817.445993710724;3903.2583809076327;4282.29342158545;4436.8464199308255;4790.952090479085;4796.064767370364;4705.4823969363515;4727.81088756451;4738.620910327183;4748.4301883774;4764.285357196413;4504;4693.741844198567;4711.057788442326;4732.100900828848;4749.810007599692;4074.449949256842;4076.4700588923547;4081.551029386765;4096.446979657768;4105.4662893823615;4983.277424773424;5896.351401345849;6035.849103772397;6087.634741915499;6088.360722124202;5568.081266591008;5569.8607534811545;5580.776768929238;5582.497575218209;5588.804391846306;6810.4892133089725;6821.829454263633;6825.215100263484;6831.521793474459;6831.965840170817;4247.723897946624;4276.5295817460055;4488.640908727294;4592.311153326994;4592.540745925381;7182.281771822776;7189.964050179716;7221.963890180516;7251.311125443074;7256.891146632752;4529.38853254813;4547.8180872764715;4554.43069616298;4554.908901821945;4569.200389931749;4103.938440923389;4622.884427889329;4629.837955671535;4630.32860235264;4632.930506042412;4237.766922819274;5432.456754324536;5459.29029226206;5464.590155738336;5468.507834294933;4890.486498917562;6576.86846263072;6817.5568588041615;6879.58722476653;6880.759173428906;1508.8943773935719;1579.0367875595878;1600.6878658661683;1602.5192442267273;1607.3811582540807;882.2280504558511;1015.4973288222229;1019.6023550815188;1029.8506716526213;1042.9374237545771;5157.613179011589;6183.134361189437;6378.138951241615;6488.578242414228;6505.967470162619;7114.857702845914;7124.786256412316;7141.89287160693;7150.10623672041;7162.961370601338;6384.6169229846355;6406.711697973602;6416.294207637156;6417.358264173546;6429.099926010363;3699.7040236780995;3725.0873535983314;3730.8880733578035;3734.178480734234;3758.1544152565452;7238.457115716343;7430.256974302634;7504.812379690442;7509.399248060142;7541.35898448638;7360.33756961876;7397.963010184914;7405.074365704287;7432.5878083164025;7438;6116.449519543174;7468.701251949969;7505.737299194502;7511.136219334737;7518.248175182438;7138.821529461805;7145.321194486515;7150.249223831631;7165;7181.389581885389;5669.886602268014;6744.966275168593;6974.79075627732;7095.82260443493;7098.219195888551;7453.180150183584;7510.211427800003;7522.435817313614;7528.736494222676;7547.962260188664;3772.2832661794173;4567.87593768899;4582.175208462509;4586.72479651222;4589.2657174851865;7120.287971203045;7128.28717128283;7139.21468638439;7152.892706609301;7162.7493037743425;6600.8349791255605;6827.590344579341;6867.587944723333;6870.27862074475;6924.619145947021;6846.691898864464;6850.862982740417;6913.896291555731;6915.861682766216;6922.930770692228;5497.752601133038;6729.966350168218;6773.254941956479;6775.1531058617675;6778.796636100925;6896.241413444617;6896.310368963063;6902.516823822284;6905.861882762216;6909.792706218822;5597.552195824405;6462.612243265419;6506.02409638539;6682.9331706682315;6730.831729206613 20:42:54 INFO - PROCESS | 1672 | |5;yui.html;658.9143411356523;701.6772284749015;705.7036044861161;706.2443185791199;724.2974314914533;14770.409183632655;15024.924875375607;15027.474038408658;15029.62425939352;15065;13708;13787.379567919443;13806.378712957916;13813.102148360349;13838;722.8734971380001;740.097081560498;896.318797713739;916.083916083916;922.5617831530037;902.363833497386;906.7007887397143;908.1735620585268;909.8908131024286;914.826183025223;970.9320347575673;974.9122578967891;977.5454413697629;977.8239916814971;979.4025644356936;765.315043036482;942.5852624845046;959.4579062829549;964.744342749172;965.7682156282511;722.8048426924753;723.3959643697519;724.0659549181602;726.2809818279865;727.9990013731119;14634.121952682874;14681.04573202749;14683.63290917725;14723.631909202248;14739.852601473955;12314.876851231553;12709.93645031769;12715.809262861065;12761.298128602923;12859.292738899358;9944.154746846527;10129.493525323704;10147.64483243083;10164.847527287096;10653.467326633714;3170.239142605758;3435.934860193348;3516.5428494295834;3529.170644898447;3725.1990821973136;75372;75458.62270688666;75571.62214188949;75733.621331893;78568.60715696384;9434.386764860263;9437.292203084797;9537.952310238543;9558.139767420966;9864.062914023156;21524.24665136744;21615.67576486354;21617.243396481048;21629.78370216309;21632.567348653254;7263.636818159071;7494.6627401767055;7496.212897645778;7553.924460755322;7579.446213526214;4054.3310353791294;4118.546959834416;4124.649404800625;4125.587441255911;4128.091819799639;3570;3623.7282203834816;3627.764195327295;3629.038304849217;3631.763935344194;624.9031400132986;636.4590098416309;638.2787450181265;648.4034688086876;656.9047488114293;564.7204633706259;582.3681305783273;593.7535922592076;602.8071017274518;614.6066517428849;8028.157043510348;8139;8200.753977380688;8237.258646721824;8327.084020757711;504.17063929835217;531.4924247343778;582.7494177503629;599.8800239952027;626.5833220908045;3325.7362202362947;3650.9817450912574;3726.7391282609956;3797.5632802227547;3907.374820028782;91590.62614060794;93063;93867.0613293872;93874.53062734779;93898.53050734839;72592;73657;76398;77910;78562.21437785664;64582.03126953099;64956.67521662456;65770.34229657738;66191;68680.6565967167;7582.734604288823;7608.8478230433975;7802.843943121219;7842.921570784448;8029.197080291924;47005.529944700116;47375.76312118417;47513;48118;48965.26552101793;60289.69855150696;68315;68609.2847678812;68821.96767048398;69872;9773.657921972697;10029;10129.341592796445;10230.405671524164;10239.7440063999;10209.183265338903;10609.620749302541;10639.627613033506;11040.392778396945;11217.270877392943;9553.808923821623;9970.40177589347;10061.849072263776;10067.345622534513;10411.895881041395;9933.801323973335;9992.050755178247;10464.895351046393;10524.579016839241;10539.525721342712;10026.448545329786;10061.094501494901;10315.329503582243;10518.105960993402;10949.288296260718;9048.866272543539;9108.271338293052;9223.631054757734;9375.203107735919;9495.287853410884;8945.37382383253;8978.371513993958;9333.953330233306;9424.198943089914;9499.43003419797 20:42:54 INFO - PROCESS | 1672 | __end_tp_report 20:42:54 INFO - PROCESS | 1672 | __start_cc_report 20:42:54 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1054 20:42:54 INFO - PROCESS | 1672 | __end_cc_report 20:42:54 INFO - PROCESS | 1672 | __startTimestamp1459741374040__endTimestamp 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | ------- Summary: start ------- 20:42:54 INFO - PROCESS | 1672 | Number of tests: 6 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5694.71 Median:5912.67 stddev:622.80 (10.5%) stddev-sans-first:598.91 20:42:54 INFO - PROCESS | 1672 | Values: 3433.6 3488.0 3517.6 3519.3 3558.4 5576.2 5612.7 5656.3 5658.8 5665.6 5602.7 5696.0 5696.4 5709.5 5711.6 5099.6 5166.3 5194.9 5222.7 5230.2 5126.8 5227.0 5233.9 5235.2 5253.1 4405.5 5247.3 5254.7 5282.1 5318.9 5077.1 5104.7 5160.8 5201.7 5209.8 5135.3 5140.2 5153.0 5161.5 5224.3 5580.6 5581.9 5598.0 5615.7 5617.5 6057.7 6098.4 6129.8 6231.6 6235.8 5212.8 6230.4 6277.7 6303.8 6324.2 5780.1 5783.4 5803.2 5808.3 5845.5 6208.5 6231.3 6271.6 6272.2 6320.8 6083.1 6084.1 6096.2 6102.9 6111.7 6138.4 6180.7 6187.1 6225.3 6229.2 6043.2 6122.1 6144.3 6169.1 6174.8 6186.3 6189.7 6193.7 6209.6 6228.9 4876.4 4879.3 4880.3 4887.0 4908.7 4328.4 4402.8 4436.0 4439.7 4458.6 5563.2 5621.3 5644.4 5649.2 5649.5 6096.4 6118.5 6123.5 6130.1 6166.5 5633.9 5635.0 5645.3 5676.8 5757.6 5331.5 5341.5 5346.5 5364.0 5370.8 6270.7 6278.1 6290.0 6293.7 6308.5 6118.3 6162.0 6243.7 6261.3 6281.7 6254.5 6262.1 6272.0 6278.3 6285.0 5737.8 6071.8 6132.4 6147.2 6171.1 6106.4 6119.5 6184.0 6261.4 6263.8 5961.3 6061.8 6063.0 6077.9 6082.8 4723.9 6049.8 6051.8 6055.6 6069.1 5859.1 5912.7 5917.3 5940.7 5958.3 6025.3 6029.5 6061.8 6080.2 6103.7 5745.0 5893.0 5903.8 5936.7 5954.0 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:58069.23 Median:36187.59 stddev:118548.88 (327.6%) stddev-sans-first:118802.62 20:42:54 INFO - PROCESS | 1672 | Values: 490.5 543.4 574.7 599.8 631.4 30651.0 30810.0 30969.0 31025.0 31045.8 40714.0 40986.0 41004.0 41015.4 41023.8 9538.3 9788.8 9789.1 9791.9 9799.3 9639.8 9762.5 9810.2 9813.6 9814.2 9750.4 9827.3 9835.7 9843.5 9845.0 9721.6 9810.2 9814.5 9815.1 9833.0 9589.1 9716.3 9825.3 9834.8 9837.8 41328.8 41713.2 41735.8 41855.6 41935.8 3284.2 3421.4 3581.6 3728.4 3865.6 28742.4 28790.4 29043.0 29429.1 29438.7 2671.3 2749.1 2778.0 2797.4 2867.0 484184.6 485151.1 486001.0 487701.0 487705.0 46060.8 46690.8 46706.1 66922.0 67741.0 45497.5 45557.0 45831.5 45868.8 45885.0 15580.2 15752.8 15762.3 15774.2 15775.7 12740.7 12759.3 12759.5 12765.3 12779.1 13089.8 14915.3 14917.2 14961.7 14967.9 5407.7 6202.7 6339.5 6396.9 6397.9 907.2 945.8 1054.5 1074.4 1088.2 26569.9 26617.6 29542.0 29891.9 30024.4 935.3 1153.3 1154.4 1160.8 1186.2 14953.4 15075.4 15200.3 15209.2 15223.4 440131.0 502405.0 502993.0 503143.0 504091.0 57978.0 59669.1 59701.4 59753.7 59817.5 1331.0 1359.3 1443.1 1465.5 1487.7 28433.7 28603.0 28968.5 29110.7 29882.0 48003.8 48363.8 48703.8 48711.0 48900.8 342788.0 345641.3 346070.0 346313.0 346800.0 28416.7 33301.2 34168.3 34174.0 34189.0 41020.4 41737.8 42034.8 42078.7 42145.4 33996.7 35178.6 35618.8 36386.8 37234.8 35252.0 35258.6 35828.6 36035.4 36080.3 29697.9 35759.8 35877.8 36294.9 36482.0 31172.9 31929.8 31951.5 32068.8 32841.0 20068.5 21268.9 24646.4 24695.6 24702.0 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:31245.21 Median:18920.75 stddev:95164.03 (503.0%) stddev-sans-first:95402.73 20:42:54 INFO - PROCESS | 1672 | Values: 361.9 363.2 368.3 370.8 373.5 19102.4 19792.5 20555.3 21007.5 21014.0 11882.7 12272.1 12276.4 12282.4 12303.4 4676.4 5130.5 5178.8 5402.2 5417.7 5319.6 5360.3 5382.2 5385.9 5398.8 5256.2 5378.1 5387.2 5505.2 6377.4 5613.7 6346.1 6355.4 6408.2 6418.4 5506.0 5534.7 5583.2 5617.3 5628.6 13134.4 13151.3 17564.3 22971.7 23394.5 2044.7 2097.7 2137.0 2174.2 2223.5 9712.9 9815.6 9944.4 10241.6 10278.6 1690.3 1694.7 1722.5 1786.4 1853.2 63390.4 87193.7 94682.5 96562.0 98450.5 10981.0 11075.3 11093.2 11143.4 11232.0 12173.4 12502.4 12875.2 13833.4 13878.3 6480.6 6608.5 7517.4 7940.1 8009.9 7169.7 8577.9 8664.1 8695.7 8781.1 3634.6 4370.7 4383.3 4392.2 4427.6 1771.7 1858.3 1864.0 1901.8 1905.7 745.0 802.6 992.6 992.9 1031.8 16676.6 19004.4 19464.9 19556.9 19704.8 824.8 893.3 920.5 961.7 985.3 9316.9 9387.8 10182.7 10560.4 10567.7 566238.0 566917.0 569831.0 589180.0 592885.0 96280.0 96451.3 98875.0 100163.5 103455.5 982.4 1033.9 1047.9 1050.7 1051.7 17243.5 17565.7 17650.9 17867.6 17935.3 37468.0 37745.8 42438.5 49352.8 51150.5 44240.6 61071.4 62358.9 62452.0 63357.4 6163.7 6947.8 7560.5 7605.8 7902.7 9773.8 11779.5 12124.3 12178.6 12226.8 10438.2 10684.7 10688.6 11071.7 11196.1 10729.2 10875.1 10995.5 11130.9 11228.6 9630.8 10877.3 11217.6 11289.9 11401.7 7770.1 7856.1 7898.2 8117.6 8158.3 10130.4 10771.5 10873.8 11188.9 11189.1 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6141.21 Median:5046.13 stddev:3220.42 (63.8%) stddev-sans-first:3210.04 20:42:54 INFO - PROCESS | 1672 | Values: 1437.9 1586.0 1618.6 1899.7 2021.4 8139.1 8851.7 9013.8 9019.9 9022.5 8671.0 8909.2 8912.0 8918.5 8918.8 2202.4 2438.3 2454.6 2471.4 2520.9 2521.2 2566.9 2569.7 2572.4 2573.2 2459.6 2524.8 2529.0 2531.1 2532.6 2469.1 2482.1 2525.4 2531.2 2533.0 2258.6 2300.6 2427.5 2464.2 2467.2 8773.3 8779.4 8880.4 8881.3 8888.2 5500.1 5648.2 5666.3 5670.7 5681.1 3498.4 3604.4 3785.6 3792.3 3792.8 1053.5 1065.0 1076.6 1082.8 1086.8 11911.8 12136.3 12138.3 12144.3 12168.8 4939.2 4971.4 5052.9 5095.2 5111.2 10454.9 10480.1 10480.5 10481.1 10506.9 5671.7 5673.3 5685.7 5694.5 5697.6 4476.4 4657.5 4929.5 4994.8 5039.4 3925.5 3995.9 4002.7 4051.1 4061.4 1319.9 1351.6 1354.0 1365.6 1372.2 1197.9 1347.3 1392.2 1399.8 1405.7 7929.4 8269.3 8275.6 8346.7 8348.8 1197.8 1200.5 1208.8 1211.2 1224.6 5910.4 6023.4 6358.4 6415.3 6462.4 10482.6 10866.8 10890.9 10979.8 10997.9 10711.3 10714.6 10716.9 10740.6 10810.2 8271.9 8423.0 8433.3 8448.7 8480.6 7646.7 7764.6 8003.3 8014.5 8093.7 9585.3 9689.2 9771.3 9883.9 9933.7 9842.0 10117.6 10224.4 10249.1 10285.6 6412.0 6416.1 6416.5 7040.9 7161.4 8293.9 8358.2 8366.8 8369.4 8374.1 7304.5 7375.5 7405.7 7514.6 7553.6 7241.1 7272.3 7379.8 7415.7 7426.6 6678.8 7716.7 7818.6 7871.5 7879.4 7066.3 7076.8 7118.4 7138.0 7151.7 7190.5 7192.4 7234.1 7259.2 7259.9 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5573.36 Median:6386.46 stddev:1808.92 (28.3%) stddev-sans-first:1770.10 20:42:54 INFO - PROCESS | 1672 | Values: 296.8 330.0 334.4 335.9 341.0 6377.6 6392.9 6447.2 6471.1 6475.5 5136.4 6348.4 6388.3 6397.4 6421.0 4586.4 4657.0 4663.3 4688.0 4817.4 3903.3 4282.3 4436.8 4791.0 4796.1 4705.5 4727.8 4738.6 4748.4 4764.3 4504.0 4693.7 4711.1 4732.1 4749.8 4074.4 4076.5 4081.6 4096.4 4105.5 4983.3 5896.4 6035.8 6087.6 6088.4 5568.1 5569.9 5580.8 5582.5 5588.8 6810.5 6821.8 6825.2 6831.5 6832.0 4247.7 4276.5 4488.6 4592.3 4592.5 7182.3 7190.0 7222.0 7251.3 7256.9 4529.4 4547.8 4554.4 4554.9 4569.2 4103.9 4622.9 4629.8 4630.3 4632.9 4237.8 5432.5 5459.3 5464.6 5468.5 4890.5 6576.9 6817.6 6879.6 6880.8 1508.9 1579.0 1600.7 1602.5 1607.4 882.2 1015.5 1019.6 1029.9 1042.9 5157.6 6183.1 6378.1 6488.6 6506.0 7114.9 7124.8 7141.9 7150.1 7163.0 6384.6 6406.7 6416.3 6417.4 6429.1 3699.7 3725.1 3730.9 3734.2 3758.2 7238.5 7430.3 7504.8 7509.4 7541.4 7360.3 7398.0 7405.1 7432.6 7438.0 6116.4 7468.7 7505.7 7511.1 7518.2 7138.8 7145.3 7150.2 7165.0 7181.4 5669.9 6745.0 6974.8 7095.8 7098.2 7453.2 7510.2 7522.4 7528.7 7548.0 3772.3 4567.9 4582.2 4586.7 4589.3 7120.3 7128.3 7139.2 7152.9 7162.7 6600.8 6827.6 6867.6 6870.3 6924.6 6846.7 6850.9 6913.9 6915.9 6922.9 5497.8 6730.0 6773.3 6775.2 6778.8 6896.2 6896.3 6902.5 6905.9 6909.8 5597.6 6462.6 6506.0 6682.9 6730.8 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17748.13 Median:32806.79 stddev:25061.63 (76.4%) stddev-sans-first:25099.09 20:42:54 INFO - PROCESS | 1672 | Values: 658.9 701.7 705.7 706.2 724.3 14770.4 15024.9 15027.5 15029.6 15065.0 13708.0 13787.4 13806.4 13813.1 13838.0 722.9 740.1 896.3 916.1 922.6 902.4 906.7 908.2 909.9 914.8 970.9 974.9 977.5 977.8 979.4 765.3 942.6 959.5 964.7 965.8 722.8 723.4 724.1 726.3 728.0 14634.1 14681.0 14683.6 14723.6 14739.9 12314.9 12709.9 12715.8 12761.3 12859.3 9944.2 10129.5 10147.6 10164.8 10653.5 3170.2 3435.9 3516.5 3529.2 3725.2 75372.0 75458.6 75571.6 75733.6 78568.6 9434.4 9437.3 9538.0 9558.1 9864.1 21524.2 21615.7 21617.2 21629.8 21632.6 7263.6 7494.7 7496.2 7553.9 7579.4 4054.3 4118.5 4124.6 4125.6 4128.1 3570.0 3623.7 3627.8 3629.0 3631.8 624.9 636.5 638.3 648.4 656.9 564.7 582.4 593.8 602.8 614.6 8028.2 8139.0 8200.8 8237.3 8327.1 504.2 531.5 582.7 599.9 626.6 3325.7 3651.0 3726.7 3797.6 3907.4 91590.6 93063.0 93867.1 93874.5 93898.5 72592.0 73657.0 76398.0 77910.0 78562.2 64582.0 64956.7 65770.3 66191.0 68680.7 7582.7 7608.8 7802.8 7842.9 8029.2 47005.5 47375.8 47513.0 48118.0 48965.3 60289.7 68315.0 68609.3 68822.0 69872.0 9773.7 10029.0 10129.3 10230.4 10239.7 10209.2 10609.6 10639.6 11040.4 11217.3 9553.8 9970.4 10061.8 10067.3 10411.9 9933.8 9992.1 10464.9 10524.6 10539.5 10026.4 10061.1 10315.3 10518.1 10949.3 9048.9 9108.3 9223.6 9375.2 9495.3 8945.4 8978.4 9334.0 9424.2 9499.4 20:42:54 INFO - PROCESS | 1672 | -------- Summary: end -------- 20:42:54 INFO - PROCESS | 1672 | 20:42:54 INFO - TEST-INFO | 1672: exit 0 20:42:54 INFO - TEST-OK | dromaeo_css | took 1113477ms 20:42:54 INFO - TEST-START | kraken 20:42:54 INFO - operating with platform_type : mac_ 20:42:54 INFO - Initialising browser for kraken test... 20:42:54 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpd33zut/profile http://localhost:49277/getInfo.html) 20:42:56 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 20:42:56 INFO - PROCESS | 1678 | colorDepth:24 20:42:56 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 20:42:56 INFO - PROCESS | 1678 | __metrics 20:42:56 INFO - PROCESS | 1678 | 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" 20:42:56 ERROR - PROCESS | 1678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:42:57 INFO - TEST-INFO | 1678: exit 0 20:42:57 INFO - Browser initialized. 20:42:57 INFO - Running cycle 1/1 for kraken test... 20:42:57 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpd33zut/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:43:09 INFO - PROCESS | 1680 | RSS: Main: 236597248 20:43:09 INFO - PROCESS | 1680 | 20:43:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 20:43:12 INFO - PROCESS | 1680 | RSS: Main: 282943488 20:43:12 INFO - PROCESS | 1680 | 20:43:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 20:43:15 INFO - PROCESS | 1680 | RSS: Main: 293351424 20:43:15 INFO - PROCESS | 1680 | 20:43:19 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 20:43:19 INFO - PROCESS | 1680 | RSS: Main: 279740416 20:43:19 INFO - PROCESS | 1680 | 20:43:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 20:43:22 INFO - PROCESS | 1680 | RSS: Main: 282411008 20:43:22 INFO - PROCESS | 1680 | 20:43:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:43:24 INFO - PROCESS | 1680 | RSS: Main: 283869184 20:43:24 INFO - PROCESS | 1680 | 20:43:27 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 20:43:28 INFO - PROCESS | 1680 | RSS: Main: 283754496 20:43:28 INFO - PROCESS | 1680 | 20:43:30 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 20:43:31 INFO - PROCESS | 1680 | RSS: Main: 284004352 20:43:31 INFO - PROCESS | 1680 | 20:43:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 20:43:34 INFO - PROCESS | 1680 | RSS: Main: 284372992 20:43:34 INFO - PROCESS | 1680 | 20:43:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:43:37 INFO - PROCESS | 1680 | RSS: Main: 315633664 20:43:37 INFO - PROCESS | 1680 | 20:43:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:43:39 INFO - PROCESS | 1680 | RSS: Main: 315232256 20:43:39 INFO - PROCESS | 1680 | 20:43:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:43:42 INFO - PROCESS | 1680 | RSS: Main: 323530752 20:43:42 INFO - PROCESS | 1680 | 20:43:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:43:45 INFO - PROCESS | 1680 | RSS: Main: 325320704 20:43:45 INFO - PROCESS | 1680 | 20:43:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:43:48 INFO - PROCESS | 1680 | RSS: Main: 324636672 20:43:48 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 20:43:50 INFO - PROCESS | 1680 | RSS: Main: 388149248 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | __start_tp_report 20:43:50 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 20:43:50 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 20:43:50 INFO - PROCESS | 1680 | |i|pagename|runs| 20:43:50 INFO - PROCESS | 1680 | |0;ai-astar;111;109;110;112;110;112;117;112;110;111 20:43:50 INFO - PROCESS | 1680 | |1;audio-beat-detection;177;155;176;147;137;172;164;123;161;120 20:43:50 INFO - PROCESS | 1680 | |2;audio-dft;185;185;186;187;186;186;184;182;181;185 20:43:50 INFO - PROCESS | 1680 | |3;audio-fft;73;72;86;80;57;58;58;74;80;82 20:43:50 INFO - PROCESS | 1680 | |4;audio-oscillator;93;100;129;81;78;81;114;79;81;111 20:43:50 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;87;84;87;84;87;83;87;84;87;83 20:43:50 INFO - PROCESS | 1680 | |6;imaging-darkroom;93;93;94;93;93;92;93;94;93;92 20:43:50 INFO - PROCESS | 1680 | |7;imaging-desaturate;92;90;91;87;91;90;92;90;89;90 20:43:50 INFO - PROCESS | 1680 | |8;json-parse-financial;54;55;54;55;55;55;53;63;54;52 20:43:50 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;64;76;74;73;70;68;67;66;67;69 20:43:50 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;94;84;84;83;84;83;83;83;86;96 20:43:50 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;134;124;122;125;137;133;131;107;134;140 20:43:50 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;140;128;139;140;139;126;138;140;139;137 20:43:50 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;64;65;66;67;67;66;66;67;66 20:43:50 INFO - PROCESS | 1680 | __end_tp_report 20:43:50 INFO - PROCESS | 1680 | __start_cc_report 20:43:50 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1329 20:43:50 INFO - PROCESS | 1680 | __end_cc_report 20:43:50 INFO - PROCESS | 1680 | __startTimestamp1459741430550__endTimestamp 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | ------- Summary: start ------- 20:43:50 INFO - PROCESS | 1680 | Number of tests: 14 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:2.22 (2.0%) stddev-sans-first:2.35 20:43:50 INFO - PROCESS | 1680 | Values: 111.0 109.0 110.0 112.0 110.0 112.0 117.0 112.0 110.0 111.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:162.50 stddev:20.91 (12.9%) stddev-sans-first:20.33 20:43:50 INFO - PROCESS | 1680 | Values: 177.0 155.0 176.0 147.0 137.0 172.0 164.0 123.0 161.0 120.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:1.89 (1.0%) stddev-sans-first:2.00 20:43:50 INFO - PROCESS | 1680 | Values: 185.0 185.0 186.0 187.0 186.0 186.0 184.0 182.0 181.0 185.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:72.00 Median:77.00 stddev:10.78 (14.0%) stddev-sans-first:11.43 20:43:50 INFO - PROCESS | 1680 | Values: 73.0 72.0 86.0 80.0 57.0 58.0 58.0 74.0 80.0 82.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:80.00 stddev:18.06 (22.6%) stddev-sans-first:19.14 20:43:50 INFO - PROCESS | 1680 | Values: 93.0 100.0 129.0 81.0 78.0 81.0 114.0 79.0 81.0 111.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.83 20:43:50 INFO - PROCESS | 1680 | Values: 87.0 84.0 87.0 84.0 87.0 83.0 87.0 84.0 87.0 83.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 20:43:50 INFO - PROCESS | 1680 | Values: 93.0 93.0 94.0 93.0 93.0 92.0 93.0 94.0 93.0 92.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:90.50 stddev:1.48 (1.6%) stddev-sans-first:1.41 20:43:50 INFO - PROCESS | 1680 | Values: 92.0 90.0 91.0 87.0 91.0 90.0 92.0 90.0 89.0 90.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.98 (5.4%) stddev-sans-first:3.14 20:43:50 INFO - PROCESS | 1680 | Values: 54.0 55.0 54.0 55.0 55.0 55.0 53.0 63.0 54.0 52.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:3.84 (5.5%) stddev-sans-first:3.54 20:43:50 INFO - PROCESS | 1680 | Values: 64.0 76.0 74.0 73.0 70.0 68.0 67.0 66.0 67.0 69.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:4.85 (5.8%) stddev-sans-first:4.20 20:43:50 INFO - PROCESS | 1680 | Values: 94.0 84.0 84.0 83.0 84.0 83.0 83.0 83.0 86.0 96.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:133.50 stddev:9.59 (7.2%) stddev-sans-first:9.98 20:43:50 INFO - PROCESS | 1680 | Values: 134.0 124.0 122.0 125.0 137.0 133.0 131.0 107.0 134.0 140.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:139.00 stddev:5.17 (3.7%) stddev-sans-first:5.33 20:43:50 INFO - PROCESS | 1680 | Values: 140.0 128.0 139.0 140.0 139.0 126.0 138.0 140.0 139.0 137.0 20:43:50 INFO - PROCESS | 1680 | 20:43:50 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 20:43:50 INFO - PROCESS | 1680 | Values: 67.0 64.0 65.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 20:43:50 INFO - PROCESS | 1680 | -------- Summary: end -------- 20:43:50 INFO - PROCESS | 1680 | 20:43:51 INFO - TEST-INFO | 1680: exit 0 20:43:51 INFO - TEST-OK | kraken | took 56754ms 20:43:51 INFO - SUITE-END | took 1170s 20:43:51 INFO - Completed test suite (00:19:30) 20:43:51 INFO - javascript benchmark 20:43:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3433.6394678558754, 3488.040788783083, 3517.56030496188, 3519.2785478976803, 3558.4128618777904, 5576.163575463683, 5612.69130197839, 5656.264685590872, 5658.830235092949, 5665.603407761453, 5602.691851948141, 5696.0, 5696.430356964302, 5709.514691251248, 5711.600187986843, 5099.617528685345, 5166.250893620423, 5194.8701282468055, 5222.686638801684, 5230.189320655304, 5126.846194614168, 5227.0, 5233.921491177616, 5235.188545775411, 5253.133233016548, 4405.515393306734, 5247.265382846385, 5254.710990895499, 5282.128448805943, 5318.867028324285, 5077.136886729228, 5104.719240441774, 5160.767765450564, 5201.661891977009, 5209.817656382046, 5135.3067335909545, 5140.177571588528, 5153.0466863630345, 5161.458046905096, 5224.294720212761, 5580.609357344987, 5581.944180558224, 5598.048331783607, 5615.719214039323, 5617.522510586564, 6057.727402266909, 6098.420650038239, 6129.846753831145, 6231.594946328474, 6235.781747638856, 5212.791488340462, 6230.408111229426, 6277.748890044393, 6303.842403939892, 6324.209473815773, 5780.104083867007, 5783.421657834183, 5803.245578074865, 5808.332041815203, 5845.532357411397, 6208.50331973441, 6231.345708700612, 6271.592346497463, 6272.2159730033745, 6320.841978950563, 6083.087536869417, 6084.11780291864, 6096.237970253718, 6102.908456373158, 6111.682900513584, 6138.416850399294, 6180.6600636965395, 6187.102870083902, 6225.315215326311, 6229.221347331583, 6043.214382130295, 6122.081687746873, 6144.262688477412, 6169.136320914986, 6174.753009879644, 6186.257649082139, 6189.690515474208, 6193.6903154842075, 6209.59637623553, 6228.906566401508, 4876.366072410564, 4879.268109783561, 4880.316755654211, 4886.975565122223, 4908.680935739166, 4328.394024836525, 4402.823887044482, 4436.0462500562535, 4439.733615983051, 4458.621017213508, 5563.165525171256, 5621.325440947031, 5644.435556444323, 5649.180868774087, 5649.491545760901, 6096.420840020191, 6118.527810132473, 6123.526657168203, 6130.122981477994, 6166.4758495527485, 5633.915491267634, 5634.957532856434, 5645.294338207724, 5676.772929082873, 5757.596968212185, 5331.493508116722, 5341.519263266325, 5346.545543628835, 5364.0, 5370.758315875795, 6270.655113968684, 6278.058291256348, 6290.0250461177675, 6293.685315734195, 6308.526860485574, 6118.314626315956, 6161.969190154021, 6243.656598887105, 6261.279952805486, 6281.685915704105, 6254.468370188585, 6262.060690896402, 6271.96864015677, 6278.277998030102, 6285.0, 5737.770489180553, 6071.848203794941, 6132.41742034506, 6147.231596050494, 6171.105189747551, 6106.389361064036, 6119.472088496418, 6184.0, 6261.436470717657, 6263.843403914756, 5961.2846458425265, 6061.818145455643, 6063.0, 6077.908831367445, 6082.847928801815, 4723.929141062956, 6049.78825741097, 6051.75792968294, 6055.636661800306, 6069.0592958091565, 5859.091840764689, 5912.674802885883, 5917.289925209003, 5940.732667030081, 5958.344582096052, 6025.276966764016, 6029.547783916136, 6061.848453788691, 6080.2399700037495, 6103.7253323601435, 5745.0, 5892.998190307572, 5903.763849445974, 5936.732847021981, 5954.0], "unit": "score", "name": "dojo.html", "value": 5657.336629681151}, {"lowerIsBetter": false, "replicates": [490.5192910947274, 543.418542159889, 574.6867956963457, 599.8365770316447, 631.4317114596862, 30651.0, 30810.0, 30969.0, 31025.0, 31045.844770776144, 40714.0, 40986.0, 41003.9749006275, 41015.35938562454, 41023.794881025555, 9538.284628652862, 9788.804223915517, 9789.07003834638, 9791.902080979205, 9799.265055120859, 9639.759006024835, 9762.511874406251, 9810.21518278536, 9813.558389872473, 9814.165795907356, 9750.414975101481, 9827.262955278347, 9835.70492885211, 9843.507824608776, 9844.950775246114, 9721.611135554569, 9810.21518278536, 9814.509274536316, 9815.067568580973, 9833.01669833018, 9589.082183563316, 9716.31985760997, 9825.312228144032, 9834.754131146707, 9837.803243935154, 41328.793356033326, 41713.1657366851, 41735.7913210432, 41855.581444185475, 41935.7903210485, 3284.1953721338186, 3421.367047096295, 3581.5702115746017, 3728.384816505273, 3865.594112618191, 28742.425151497064, 28790.424191516053, 29043.0, 29429.11712648624, 29438.67525961337, 2671.3455203475078, 2749.1477641930865, 2778.0, 2797.3560601909726, 2867.0, 484184.5790771059, 485151.1484885141, 486001.0, 487701.0, 487705.0, 46060.76969615131, 46690.766546167055, 46706.06587868224, 66922.0, 67741.0, 45497.545024549334, 45557.0, 45831.47926863988, 45868.77065614717, 45885.0, 15580.220988950507, 15752.842471575366, 15762.290696918666, 15774.211289435483, 15775.684486310209, 12740.745185096246, 12759.298238596966, 12759.489620415265, 12765.319282950684, 12779.105462617714, 13089.803652945213, 14915.254237288093, 14917.179555124572, 14961.72825309839, 14967.850321496646, 5407.675539467566, 6202.72087756052, 6339.4611458025665, 6396.936030639634, 6397.904031439532, 907.2379201470796, 945.8297506448905, 1054.536004158168, 1074.3929679730927, 1088.2436706489073, 26569.867150664122, 26617.600735988977, 29541.966031188804, 29891.850540747157, 30024.399512009637, 935.3359115028406, 1153.3425947210178, 1154.440096553171, 1160.7562411893427, 1186.163754553038, 14953.419699937242, 15075.39698412073, 15200.315985780666, 15209.239538023054, 15223.391064357524, 440131.0, 502405.0, 502993.0, 503143.0, 504091.0, 57978.0, 59669.10496342558, 59701.40298597045, 59753.701231493564, 59817.50456238542, 1330.9800352994712, 1359.2863746533149, 1443.1269082205115, 1465.5163795947312, 1487.6950225203807, 28433.715662843108, 28603.0, 28968.479253573427, 29110.7088929108, 29881.95413160529, 48003.75998119987, 48363.79090522765, 48703.78240544015, 48711.0, 48900.77748056327, 342788.0, 345641.2717936394, 346070.0, 346313.0, 346800.0, 28416.715832841408, 33301.16747081342, 34168.31663366669, 34174.0, 34188.974330770114, 41020.384694230204, 41737.79131104325, 42034.7898260519, 42078.737637870916, 42145.36781948212, 33996.66003339935, 35178.59285628546, 35618.821905890305, 36386.8180659095, 37234.813825930694, 35252.0, 35258.647413525534, 35828.64171358253, 36035.414510749826, 36080.27839443249, 29697.851510742308, 35759.82120089383, 35877.82061089678, 36294.91115266546, 36482.0, 31172.908948186705, 31929.8403507981, 31951.520727188647, 32068.83965580157, 32841.0, 20068.498287542927, 21268.893655532243, 24646.383840403418, 24695.62956555689, 24702.01191952374], "unit": "score", "name": "ext.html", "value": 18807.70823265485}, {"lowerIsBetter": false, "replicates": [361.9113317237277, 363.1520399866314, 368.3130960758186, 370.78123906894945, 373.5069707985457, 19102.426927192188, 19792.505187370323, 20555.280565180205, 21007.47481312968, 21014.0, 11882.702932426693, 12272.07959403044, 12276.447559859806, 12282.447289871954, 12303.446344914479, 4676.415448068991, 5130.51260130287, 5178.818741344054, 5402.162664786964, 5417.674939503642, 5319.601029922752, 5360.303160589118, 5382.1926710993275, 5385.865353366158, 5398.784048638069, 5256.237845512398, 5378.112611419111, 5387.19192121183, 5505.174223866412, 6377.42603165715, 5613.663180209201, 6346.079818426326, 6355.428011478943, 6408.166938298014, 6418.390252925965, 5506.03644362235, 5534.667919924817, 5583.190437386556, 5617.269754931874, 5628.577856660767, 13134.408951597201, 13151.342432878319, 17564.297428102862, 22971.736554489496, 23394.53210935772, 2044.6830741235133, 2097.674860396641, 2136.9893150534303, 2174.173813950689, 2223.49971256466, 9712.854307185398, 9815.558299876522, 9944.403335799803, 10241.590336386536, 10278.640247591298, 1690.3238704518292, 1694.74578813179, 1722.457425910834, 1786.3836976243176, 1853.1938606706126, 63390.38335016736, 87193.69209461863, 94682.52658736662, 96561.9999999993, 98450.52324215142, 10981.0, 11075.335479871233, 11093.223474356879, 11143.387113708824, 11231.989120979151, 12173.39133043362, 12502.3748812559, 12875.163114397534, 13833.446662133401, 13878.306084695725, 6480.611163330215, 6608.471322294205, 7517.361024312994, 7940.1265860755275, 8009.918660980809, 7169.749058782918, 8577.914220857712, 8664.09027052163, 8695.739127826175, 8781.07798681142, 3634.60019397866, 4370.661695992692, 4383.3424986251675, 4392.231359512072, 4427.6236519896165, 1771.6545273671768, 1858.3124244029796, 1863.9813601863807, 1901.847852171823, 1905.7046157845557, 745.0, 802.6027116577332, 992.5682328187262, 992.9453880036523, 1031.7626945802358, 16676.58308542296, 19004.42986710401, 19464.902675486814, 19556.902215489117, 19704.802951970585, 824.7834444194765, 893.2898345815092, 920.4707293306376, 961.6826447272383, 985.3496692183124, 9316.8602470963, 9387.779588653431, 10182.745431364276, 10560.366378017343, 10567.735806604742, 566238.0, 566917.0, 569831.0, 589180.0, 592885.0, 96280.0, 96451.31938125602, 98875.0, 100163.49591260277, 103455.4827225859, 982.3643633350534, 1033.8655974723238, 1047.8794938582162, 1050.7268110291227, 1051.7055224537141, 17243.482695519153, 17565.736513952044, 17650.91174544119, 17867.642647146724, 17935.282588696828, 37468.0, 37745.81127094347, 42438.51465198703, 49352.76618084576, 51150.48849511457, 44240.55759442493, 61071.389286108344, 62358.88205589793, 62452.0, 63357.366426335146, 6163.722632481638, 6947.826304342432, 7560.546367217985, 7605.847883042419, 7902.723404680809, 9773.755656108655, 11779.469923853618, 12124.272543647057, 12178.57374991871, 12226.816597751218, 10438.217133715154, 10684.679459616224, 10688.625898093529, 11071.723206919569, 11196.104311655212, 10729.195310351599, 10875.075618572193, 10995.505202265756, 11130.944345278222, 11228.55085796559, 9630.759231019281, 10877.347359158159, 11217.551297948317, 11289.943550282196, 11401.657950261506, 7770.10643775973, 7856.135825059353, 7898.210178982055, 8117.55353455542, 8158.265756081981, 10130.392176469435, 10771.46142692878, 10873.836892446778, 11188.888111118784, 11189.104871610089], "unit": "score", "name": "jquery.html", "value": 8747.680776242518}, {"lowerIsBetter": false, "replicates": [1437.942482300708, 1585.9762103568444, 1618.595351162209, 1899.7435346228256, 2021.3632705697705, 8139.104698483162, 8851.734447966563, 9013.819723605524, 9019.864702029476, 9022.54887255638, 8670.95664521678, 8909.242714369286, 8911.955440222806, 8918.509481978488, 8918.77703057424, 2202.4053505553493, 2438.341647755105, 2454.631805229212, 2471.369800700819, 2520.861352625605, 2521.18061629971, 2566.922992310234, 2569.730178331267, 2572.356910772307, 2573.202307284748, 2459.631055341695, 2524.8485090894515, 2528.987355063222, 2531.0635065025967, 2532.569463191253, 2469.148143890364, 2482.094035676974, 2525.3812815860047, 2531.227975467491, 2532.987335063331, 2258.570871534403, 2300.64340027296, 2427.526632306701, 2464.18681834994, 2467.198160597813, 8773.298136149093, 8779.429337093132, 8880.422772519765, 8881.33389995753, 8888.155625215659, 5500.092484740013, 5648.152777083429, 5666.348369937468, 5670.744816483269, 5681.062624666966, 3498.440249560058, 3604.387254166798, 3785.5646600641003, 3792.260509200707, 3792.7724336539895, 1053.5469748008354, 1065.0361422912276, 1076.580133747839, 1082.7942690888706, 1086.7772106718103, 11911.821322680167, 12136.33250171249, 12138.332391718452, 12144.271343719405, 12168.81746773799, 4939.160342741742, 4971.37857767779, 5052.898942021213, 5095.159298715745, 5111.207762796698, 10454.895451045544, 10480.109190718722, 10480.47597620116, 10481.056704896597, 10506.949305069586, 5671.6597004179885, 5673.3475650299915, 5685.658860468385, 5694.515966142924, 5697.572682048863, 4476.395686582335, 4657.464391594942, 4929.457759646436, 4994.8251811187165, 5039.370078740158, 3925.4700615417123, 3995.9400608990886, 4002.7198096133575, 4051.0682543015273, 4061.3907913812573, 1319.8680131986916, 1351.5877657314418, 1353.9729205415836, 1365.6381059019368, 1372.19726460022, 1197.8921897029309, 1347.3128704360847, 1392.1507880193074, 1399.846016938136, 1405.7329107469548, 7929.405294602928, 8269.338452923752, 8275.62759675816, 8346.66613335472, 8348.833023339499, 1197.7903866823272, 1200.5257923120319, 1208.8005479096028, 1211.2429731417865, 1224.5530381410722, 5910.379410161957, 6023.427774361428, 6358.43589807082, 6415.262244841903, 6462.386073323027, 10482.633107841342, 10866.782664346669, 10890.945545272223, 10979.780404391868, 10997.945010274898, 10711.25021248505, 10714.571417143226, 10716.928307169377, 10740.624078157227, 10810.243282970274, 8271.917280827234, 8423.031351394668, 8433.28317093054, 8448.746537603882, 8480.575971201415, 7646.694132234871, 7764.5729484878875, 8003.279704826594, 8014.479058861155, 8093.716719914774, 9585.329026968046, 9689.176420004096, 9771.267154963549, 9883.901160988586, 9933.65232216869, 9842.015798420101, 10117.59529618807, 10224.386536807815, 10249.12882405004, 10285.588576457158, 6412.0, 6416.13382193398, 6416.45460135875, 7040.929590704028, 7161.4270858330165, 8293.875591866248, 8358.205970432798, 8366.790830229293, 8369.372297077865, 8374.120717324593, 7304.4886857921565, 7375.520591161558, 7405.666744996596, 7514.586697731677, 7553.5845528494265, 7241.058662373857, 7272.345488905812, 7379.778606641809, 7415.740449084256, 7426.554406735613, 6678.76624318166, 7716.652750626123, 7818.648160832662, 7871.48835325702, 7879.448438609243, 7066.293370662893, 7076.752313668997, 7118.394936430254, 7138.0, 7151.713931442684, 7190.496665233383, 7192.42460603161, 7234.131904171533, 7259.165196002316, 7259.854802904018], "unit": "score", "name": "mootools.html", "value": 5028.492167969198}, {"lowerIsBetter": false, "replicates": [296.8011432340332, 329.9935197647177, 334.37471927495585, 335.8606178435949, 340.962494125646, 6377.553571250009, 6392.936070639293, 6447.2263328400595, 6471.1263979362775, 6475.481961443085, 5136.409312929014, 6348.428641422271, 6388.297287298405, 6397.3602639736, 6421.004744264646, 4586.4266966629175, 4657.0, 4663.277192035223, 4687.976560117212, 4817.445993710724, 3903.2583809076327, 4282.29342158545, 4436.8464199308255, 4790.952090479085, 4796.064767370364, 4705.4823969363515, 4727.81088756451, 4738.620910327183, 4748.4301883774, 4764.285357196413, 4504.0, 4693.741844198567, 4711.057788442326, 4732.100900828848, 4749.810007599692, 4074.449949256842, 4076.4700588923547, 4081.551029386765, 4096.446979657768, 4105.4662893823615, 4983.277424773424, 5896.351401345849, 6035.849103772397, 6087.634741915499, 6088.360722124202, 5568.081266591008, 5569.8607534811545, 5580.776768929238, 5582.497575218209, 5588.804391846306, 6810.4892133089725, 6821.829454263633, 6825.215100263484, 6831.521793474459, 6831.965840170817, 4247.723897946624, 4276.5295817460055, 4488.640908727294, 4592.311153326994, 4592.540745925381, 7182.281771822776, 7189.964050179716, 7221.963890180516, 7251.311125443074, 7256.891146632752, 4529.38853254813, 4547.8180872764715, 4554.43069616298, 4554.908901821945, 4569.200389931749, 4103.938440923389, 4622.884427889329, 4629.837955671535, 4630.32860235264, 4632.930506042412, 4237.766922819274, 5432.456754324536, 5459.29029226206, 5464.590155738336, 5468.507834294933, 4890.486498917562, 6576.86846263072, 6817.5568588041615, 6879.58722476653, 6880.759173428906, 1508.8943773935719, 1579.0367875595878, 1600.6878658661683, 1602.5192442267273, 1607.3811582540807, 882.2280504558511, 1015.4973288222229, 1019.6023550815188, 1029.8506716526213, 1042.9374237545771, 5157.613179011589, 6183.134361189437, 6378.138951241615, 6488.578242414228, 6505.967470162619, 7114.857702845914, 7124.786256412316, 7141.89287160693, 7150.10623672041, 7162.961370601338, 6384.6169229846355, 6406.711697973602, 6416.294207637156, 6417.358264173546, 6429.099926010363, 3699.7040236780995, 3725.0873535983314, 3730.8880733578035, 3734.178480734234, 3758.1544152565452, 7238.457115716343, 7430.256974302634, 7504.812379690442, 7509.399248060142, 7541.35898448638, 7360.33756961876, 7397.963010184914, 7405.074365704287, 7432.5878083164025, 7438.0, 6116.449519543174, 7468.701251949969, 7505.737299194502, 7511.136219334737, 7518.248175182438, 7138.821529461805, 7145.321194486515, 7150.249223831631, 7165.0, 7181.389581885389, 5669.886602268014, 6744.966275168593, 6974.79075627732, 7095.82260443493, 7098.219195888551, 7453.180150183584, 7510.211427800003, 7522.435817313614, 7528.736494222676, 7547.962260188664, 3772.2832661794173, 4567.87593768899, 4582.175208462509, 4586.72479651222, 4589.2657174851865, 7120.287971203045, 7128.28717128283, 7139.21468638439, 7152.892706609301, 7162.7493037743425, 6600.8349791255605, 6827.590344579341, 6867.587944723333, 6870.27862074475, 6924.619145947021, 6846.691898864464, 6850.862982740417, 6913.896291555731, 6915.861682766216, 6922.930770692228, 5497.752601133038, 6729.966350168218, 6773.254941956479, 6775.1531058617675, 6778.796636100925, 6896.241413444617, 6896.310368963063, 6902.516823822284, 6905.861882762216, 6909.792706218822, 5597.552195824405, 6462.612243265419, 6506.02409638539, 6682.9331706682315, 6730.831729206613], "unit": "score", "name": "prototype.html", "value": 4974.388061675215}, {"lowerIsBetter": false, "replicates": [658.9143411356523, 701.6772284749015, 705.7036044861161, 706.2443185791199, 724.2974314914533, 14770.409183632655, 15024.924875375607, 15027.474038408658, 15029.62425939352, 15065.0, 13708.0, 13787.379567919443, 13806.378712957916, 13813.102148360349, 13838.0, 722.8734971380001, 740.097081560498, 896.318797713739, 916.083916083916, 922.5617831530037, 902.363833497386, 906.7007887397143, 908.1735620585268, 909.8908131024286, 914.826183025223, 970.9320347575673, 974.9122578967891, 977.5454413697629, 977.8239916814971, 979.4025644356936, 765.315043036482, 942.5852624845046, 959.4579062829549, 964.744342749172, 965.7682156282511, 722.8048426924753, 723.3959643697519, 724.0659549181602, 726.2809818279865, 727.9990013731119, 14634.121952682874, 14681.04573202749, 14683.63290917725, 14723.631909202248, 14739.852601473955, 12314.876851231553, 12709.93645031769, 12715.809262861065, 12761.298128602923, 12859.292738899358, 9944.154746846527, 10129.493525323704, 10147.64483243083, 10164.847527287096, 10653.467326633714, 3170.239142605758, 3435.934860193348, 3516.5428494295834, 3529.170644898447, 3725.1990821973136, 75372.0, 75458.62270688666, 75571.62214188949, 75733.621331893, 78568.60715696384, 9434.386764860263, 9437.292203084797, 9537.952310238543, 9558.139767420966, 9864.062914023156, 21524.24665136744, 21615.67576486354, 21617.243396481048, 21629.78370216309, 21632.567348653254, 7263.636818159071, 7494.6627401767055, 7496.212897645778, 7553.924460755322, 7579.446213526214, 4054.3310353791294, 4118.546959834416, 4124.649404800625, 4125.587441255911, 4128.091819799639, 3570.0, 3623.7282203834816, 3627.764195327295, 3629.038304849217, 3631.763935344194, 624.9031400132986, 636.4590098416309, 638.2787450181265, 648.4034688086876, 656.9047488114293, 564.7204633706259, 582.3681305783273, 593.7535922592076, 602.8071017274518, 614.6066517428849, 8028.157043510348, 8139.0, 8200.753977380688, 8237.258646721824, 8327.084020757711, 504.17063929835217, 531.4924247343778, 582.7494177503629, 599.8800239952027, 626.5833220908045, 3325.7362202362947, 3650.9817450912574, 3726.7391282609956, 3797.5632802227547, 3907.374820028782, 91590.62614060794, 93063.0, 93867.0613293872, 93874.53062734779, 93898.53050734839, 72592.0, 73657.0, 76398.0, 77910.0, 78562.21437785664, 64582.03126953099, 64956.67521662456, 65770.34229657738, 66191.0, 68680.6565967167, 7582.734604288823, 7608.8478230433975, 7802.843943121219, 7842.921570784448, 8029.197080291924, 47005.529944700116, 47375.76312118417, 47513.0, 48118.0, 48965.26552101793, 60289.69855150696, 68315.0, 68609.2847678812, 68821.96767048398, 69872.0, 9773.657921972697, 10029.0, 10129.341592796445, 10230.405671524164, 10239.7440063999, 10209.183265338903, 10609.620749302541, 10639.627613033506, 11040.392778396945, 11217.270877392943, 9553.808923821623, 9970.40177589347, 10061.849072263776, 10067.345622534513, 10411.895881041395, 9933.801323973335, 9992.050755178247, 10464.895351046393, 10524.579016839241, 10539.525721342712, 10026.448545329786, 10061.094501494901, 10315.329503582243, 10518.105960993402, 10949.288296260718, 9048.866272543539, 9108.271338293052, 9223.631054757734, 9375.203107735919, 9495.287853410884, 8945.37382383253, 8978.371513993958, 9333.953330233306, 9424.198943089914, 9499.43003419797], "unit": "score", "name": "yui.html", "value": 6725.210967975631}], "name": "dromaeo_css", "value": 7341.635735907033}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 112.0, 110.0, 112.0, 117.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [177.0, 155.0, 176.0, 147.0, 137.0, 172.0, 164.0, 123.0, 161.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 153.2}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 187.0, 186.0, 186.0, 184.0, 182.0, 181.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 86.0, 80.0, 57.0, 58.0, 58.0, 74.0, 80.0, 82.0], "unit": "score", "name": "audio-fft", "value": 72.0}, {"lowerIsBetter": true, "replicates": [93.0, 100.0, 129.0, 81.0, 78.0, 81.0, 114.0, 79.0, 81.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 92.0, 93.0, 94.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [92.0, 90.0, 91.0, 87.0, 91.0, 90.0, 92.0, 90.0, 89.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 90.2}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 53.0, 63.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [64.0, 76.0, 74.0, 73.0, 70.0, 68.0, 67.0, 66.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [94.0, 84.0, 84.0, 83.0, 84.0, 83.0, 83.0, 83.0, 86.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [134.0, 124.0, 122.0, 125.0, 137.0, 133.0, 131.0, 107.0, 134.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [140.0, 128.0, 139.0, 140.0, 139.0, 126.0, 138.0, 140.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1426.3}]} 20:43:51 INFO - Return code: 0 20:43:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:43:51 ERROR - # TBPL SUCCESS # 20:43:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:43:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:43:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:43:51 INFO - 2016-04-03 20:43:51.843 screenresolution[1684:10160] starting screenresolution argv=screenresolution get 20:43:51 INFO - 2016-04-03 20:43:51.845 screenresolution[1684:10160] Display 0: 1600x1200x32@60 20:43:51 INFO - 2016-04-03 20:43:51.850 screenresolution[1685:10164] starting screenresolution argv=screenresolution list 20:43:51 INFO - Available Modes on Display 0 20:43:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:43:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:43:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:43:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:43:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:43:52 INFO - Intel Iris: 20:43:52 INFO - Chipset Model: Intel Iris 20:43:52 INFO - Type: GPU 20:43:52 INFO - Bus: Built-In 20:43:52 INFO - VRAM (Dynamic, Max): 1536 MB 20:43:52 INFO - Vendor: Intel (0x8086) 20:43:52 INFO - Device ID: 0x0a2e 20:43:52 INFO - Revision ID: 0x0009 20:43:52 INFO - Displays: 20:43:52 INFO - Display: 20:43:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:43:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:43:52 INFO - Display Serial Number: 1600x1200 60 20:43:52 INFO - Main Display: Yes 20:43:52 INFO - Mirror: Off 20:43:52 INFO - Online: Yes 20:43:52 INFO - Rotation: Supported 20:43:52 INFO - Return code: 0 20:43:52 INFO - Running post-action listener: _resource_record_post_action 20:43:52 INFO - Running post-run listener: _resource_record_post_run 20:43:53 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 31821312; Write bytes: 708392960; Read time: 327; Write time: 1858 20:43:53 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 384571904; Write bytes: 378656256; Read time: 28401; Write time: 630 20:43:53 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 30862848; Write bytes: 300050944; Read time: 311; Write time: 1105 20:43:53 INFO - Running post-run listener: _upload_blobber_files 20:43:53 INFO - Blob upload gear active. 20:43:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:43:53 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 20:43:53 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'] 20:43:53 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 20:43:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:43:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:54 INFO - (blobuploader) - INFO - Done attempting. 20:43:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:43:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:43:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:43:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:43:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:43:55 INFO - (blobuploader) - INFO - Done attempting. 20:43:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:43:55 INFO - Return code: 0 20:43:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:43:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:43:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8536235f1f08e4977dd15549bc904a8748409c82e6c487716fc1052f3b65064e7b29091d73e68ec90271e5f05303dbf58a027ac7f57b212ef8b16734883c6c69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d25aef0275bec76bf2cf8571a4ccf26d3975f21318f00c15b123aa1faae56f62ea17098e8be4cdb1223eece32d76ca73f4599c3ae3bf792ecbe5b6ed3dbc176d"} 20:43:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:43:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:43:55 INFO - Contents: 20:43:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8536235f1f08e4977dd15549bc904a8748409c82e6c487716fc1052f3b65064e7b29091d73e68ec90271e5f05303dbf58a027ac7f57b212ef8b16734883c6c69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d25aef0275bec76bf2cf8571a4ccf26d3975f21318f00c15b123aa1faae56f62ea17098e8be4cdb1223eece32d76ca73f4599c3ae3bf792ecbe5b6ed3dbc176d"} 20:43:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:43:55 INFO - Copying logs to upload dir... 20:43:55 INFO - mkdir: /builds/slave/test/build/upload/logs 20:43:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.937071 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-04-03 20:43:55.910664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 20:43:55.914272) ========= 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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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/8536235f1f08e4977dd15549bc904a8748409c82e6c487716fc1052f3b65064e7b29091d73e68ec90271e5f05303dbf58a027ac7f57b212ef8b16734883c6c69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d25aef0275bec76bf2cf8571a4ccf26d3975f21318f00c15b123aa1faae56f62ea17098e8be4cdb1223eece32d76ca73f4599c3ae3bf792ecbe5b6ed3dbc176d"} build_url:https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011000 build_url: 'https://queue.taskcluster.net/v1/task/bmyQxZxjS7eXQvTuScyJhw/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/8536235f1f08e4977dd15549bc904a8748409c82e6c487716fc1052f3b65064e7b29091d73e68ec90271e5f05303dbf58a027ac7f57b212ef8b16734883c6c69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d25aef0275bec76bf2cf8571a4ccf26d3975f21318f00c15b123aa1faae56f62ea17098e8be4cdb1223eece32d76ca73f4599c3ae3bf792ecbe5b6ed3dbc176d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 20:43:55.945770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:43:55.946355) ========= 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.gstFTeQoSs/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.bRLBki6FmQ/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.005178 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 20:43:55.999423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 20:43:56.000156) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 20:43:56.001011) ========= ========= Total master_lag: 0.34 =========