builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0050 starttime: 1458287987.63 results: success (0) buildid: 20160318000913 builduid: 8a917d5d8c0c4d109ec09add4e47f6f2 revision: 0e729ba9f2bf518876ce87959ae4a95827f68935 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.634910) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.635332) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.635612) ========= 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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005503 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.661416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.661979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.680039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.680368) ========= 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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.728593) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.728900) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.729291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:47.729591) ========= 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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-18 00:59:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.87M=0.001s 2016-03-18 00:59:47 (9.87 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103163 ========= master_lag: 0.37 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:48.201639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:48.201964) ========= 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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.025598 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:48.243881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 00:59:48.244228) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e729ba9f2bf518876ce87959ae4a95827f68935 --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 0e729ba9f2bf518876ce87959ae4a95827f68935 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-18 00:59:48,313 truncating revision to first 12 chars 2016-03-18 00:59:48,313 Setting DEBUG logging. 2016-03-18 00:59:48,313 attempt 1/10 2016-03-18 00:59:48,313 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e729ba9f2bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 00:59:49,356 unpacking tar archive at: fx-team-0e729ba9f2bf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.284817 ========= master_lag: 0.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 00:59:50.107162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:50.107517) ========= echo 0e729ba9f2bf518876ce87959ae4a95827f68935 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0e729ba9f2bf518876ce87959ae4a95827f68935'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 0e729ba9f2bf518876ce87959ae4a95827f68935 program finished with exit code 0 elapsedTime=0.005781 script_repo_revision: '0e729ba9f2bf518876ce87959ae4a95827f68935' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:50.131284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:50.131564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 00:59:50.147402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-18 00:59:50.147758) ========= /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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 00:59:50 INFO - MultiFileLogger online at 20160318 00:59:50 in /builds/slave/test 00:59:50 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 00:59:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:59:50 INFO - {'append_to_log': False, 00:59:50 INFO - 'base_work_dir': '/builds/slave/test', 00:59:50 INFO - 'blob_upload_branch': 'Fx-Team', 00:59:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:59:50 INFO - 'branch': 'Fx-Team', 00:59:50 INFO - 'buildbot_json_path': 'buildprops.json', 00:59:50 INFO - 'config_files': ('talos/mac_config.py',), 00:59:50 INFO - 'default_actions': ('clobber', 00:59:50 INFO - 'read-buildbot-config', 00:59:50 INFO - 'download-and-extract', 00:59:50 INFO - 'populate-webroot', 00:59:50 INFO - 'create-virtualenv', 00:59:50 INFO - 'install', 00:59:50 INFO - 'run-tests'), 00:59:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:59:50 INFO - 'download_minidump_stackwalk': True, 00:59:50 INFO - 'download_symbols': 'ondemand', 00:59:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:59:50 INFO - 'tooltool.py': '/tools/tooltool.py', 00:59:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:59:50 INFO - '/tools/misc-python/virtualenv.py')}, 00:59:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:59:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:59:50 INFO - 'installer_path': 'installer.exe', 00:59:50 INFO - 'log_level': 'info', 00:59:50 INFO - 'log_name': 'talos', 00:59:50 INFO - 'log_to_console': True, 00:59:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:59:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:59:50 INFO - 'opt_config_files': (), 00:59:50 INFO - 'pip_index': False, 00:59:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:59:50 INFO - 'cmd': ('bash', 00:59:50 INFO - '-c', 00:59:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:59:50 INFO - 'enabled': True, 00:59:50 INFO - 'halt_on_failure': False, 00:59:50 INFO - 'name': 'check_screen_resolution'},), 00:59:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:59:50 INFO - 'cmd': ('bash', 00:59:50 INFO - '-c', 00:59:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:59:50 INFO - 'enabled': True, 00:59:50 INFO - 'halt_on_failure': False, 00:59:50 INFO - 'name': 'check_screen_resolution'},), 00:59:50 INFO - 'run_cmd_checks_enabled': True, 00:59:50 INFO - 'sps_profile': False, 00:59:50 INFO - 'sps_profile_interval': 0, 00:59:50 INFO - 'suite': 'dromaeojs', 00:59:50 INFO - 'system_bits': '32', 00:59:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:59:50 INFO - 'title': 't-yosemite-r7-0050', 00:59:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:59:50 INFO - 'use_talos_json': True, 00:59:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:59:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:59:50 INFO - 'work_dir': 'build'} 00:59:50 INFO - ##### 00:59:50 INFO - ##### Running clobber step. 00:59:50 INFO - ##### 00:59:50 INFO - Running pre-action listener: _resource_record_pre_action 00:59:50 INFO - Running main action method: clobber 00:59:50 INFO - rmtree: /builds/slave/test/build 00:59:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:59:51 INFO - Running post-action listener: _resource_record_post_action 00:59:51 INFO - ##### 00:59:51 INFO - ##### Running read-buildbot-config step. 00:59:51 INFO - ##### 00:59:51 INFO - Running pre-action listener: _resource_record_pre_action 00:59:51 INFO - Running main action method: read_buildbot_config 00:59:51 INFO - Using buildbot properties: 00:59:51 INFO - { 00:59:51 INFO - "project": "", 00:59:51 INFO - "product": "firefox", 00:59:51 INFO - "script_repo_revision": "production", 00:59:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:59:51 INFO - "repository": "", 00:59:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:59:51 INFO - "buildid": "20160318000913", 00:59:51 INFO - "pgo_build": "False", 00:59:51 INFO - "basedir": "/builds/slave/test", 00:59:51 INFO - "buildnumber": 526, 00:59:51 INFO - "slavename": "t-yosemite-r7-0050", 00:59:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:59:51 INFO - "platform": "yosemite_r7", 00:59:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:59:51 INFO - "branch": "fx-team", 00:59:51 INFO - "repo_path": "integration/fx-team", 00:59:51 INFO - "revision": "0e729ba9f2bf518876ce87959ae4a95827f68935", 00:59:51 INFO - "stage_platform": "macosx64", 00:59:51 INFO - "builduid": "8a917d5d8c0c4d109ec09add4e47f6f2", 00:59:51 INFO - "slavebuilddir": "test" 00:59:51 INFO - } 00:59:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 00:59:51 INFO - Running post-action listener: _resource_record_post_action 00:59:51 INFO - ##### 00:59:51 INFO - ##### Running download-and-extract step. 00:59:51 INFO - ##### 00:59:51 INFO - Running pre-action listener: _resource_record_pre_action 00:59:51 INFO - Running main action method: download_and_extract 00:59:51 INFO - mkdir: /builds/slave/test/build/tests 00:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:51 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 00:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 00:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 00:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 00:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 00:59:53 INFO - Downloaded 1199 bytes. 00:59:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 00:59:53 INFO - Using the following test package requirements: 00:59:53 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 00:59:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 00:59:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 00:59:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'jsshell-mac.zip'], 00:59:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 00:59:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 00:59:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 00:59:53 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 00:59:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 00:59:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:59:53 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 00:59:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:53 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 00:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 00:59:54 INFO - Downloaded 17870538 bytes. 00:59:54 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'] 00:59:54 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 00:59:57 INFO - Return code: 0 00:59:57 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 00:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:57 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:59:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:59:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:59:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 00:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 00:59:58 INFO - Downloaded 17870538 bytes. 00:59:58 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'] 00:59:58 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 01:00:02 INFO - Return code: 0 01:00:02 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')]} 01:00:02 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 01:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 01:00:03 INFO - Downloaded 10846565 bytes. 01:00:03 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'] 01:00:03 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 01:00:03 INFO - Return code: 0 01:00: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')]} 01:00:03 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:00:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:00:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:00:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/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 01:00:06 INFO - Downloaded 111172516 bytes. 01:00:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:00:06 INFO - mkdir: /builds/slave/test/properties 01:00:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:00:06 INFO - Writing to file /builds/slave/test/properties/build_url 01:00:06 INFO - Contents: 01:00:06 INFO - build_url:https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:00:07 INFO - Running post-action listener: _resource_record_post_action 01:00:07 INFO - Running post-action listener: set_extra_try_arguments 01:00:07 INFO - ##### 01:00:07 INFO - ##### Running populate-webroot step. 01:00:07 INFO - ##### 01:00:07 INFO - Running pre-action listener: _resource_record_pre_action 01:00:07 INFO - Running main action method: populate_webroot 01:00:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:00:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:00:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:00:07 INFO - '--tppagecycles', 01:00:07 INFO - '7'], 01:00:07 INFO - 'tests': ['tsvgm']}}, 01:00:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:00:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:00:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:00:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:00:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'tests': ['damp', 'tps']}, 01:00:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['damp', 'tps']}, 01:00:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:00:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:00:07 INFO - 'other': {'tests': ['a11yr', 01:00:07 INFO - 'ts_paint', 01:00:07 INFO - 'tpaint', 01:00:07 INFO - 'sessionrestore', 01:00:07 INFO - 'sessionrestore_no_auto_restore', 01:00:07 INFO - 'tabpaint']}, 01:00:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['a11yr', 01:00:07 INFO - 'ts_paint', 01:00:07 INFO - 'tpaint', 01:00:07 INFO - 'sessionrestore', 01:00:07 INFO - 'sessionrestore_no_auto_restore', 01:00:07 INFO - 'tabpaint']}, 01:00:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['a11yr', 01:00:07 INFO - 'ts_paint', 01:00:07 INFO - 'tpaint', 01:00:07 INFO - 'sessionrestore', 01:00:07 INFO - 'sessionrestore_no_auto_restore', 01:00:07 INFO - 'tabpaint']}, 01:00:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['a11yr', 01:00:07 INFO - 'ts_paint', 01:00:07 INFO - 'tpaint', 01:00:07 INFO - 'sessionrestore', 01:00:07 INFO - 'sessionrestore_no_auto_restore', 01:00:07 INFO - 'tabpaint']}, 01:00:07 INFO - 'other_l64': {'tests': ['a11yr', 01:00:07 INFO - 'ts_paint', 01:00:07 INFO - 'tpaint', 01:00:07 INFO - 'sessionrestore', 01:00:07 INFO - 'sessionrestore_no_auto_restore', 01:00:07 INFO - 'tabpaint']}, 01:00:07 INFO - 'other_nol64': {'tests': ['a11yr', 01:00:07 INFO - 'ts_paint', 01:00:07 INFO - 'tpaint', 01:00:07 INFO - 'sessionrestore', 01:00:07 INFO - 'sessionrestore_no_auto_restore', 01:00:07 INFO - 'tabpaint']}, 01:00:07 INFO - 'svgr': {'tests': ['tsvgx', 01:00:07 INFO - 'tsvgr_opacity', 01:00:07 INFO - 'tart', 01:00:07 INFO - 'tscrollx', 01:00:07 INFO - 'cart']}, 01:00:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['tsvgx', 01:00:07 INFO - 'tsvgr_opacity', 01:00:07 INFO - 'tart', 01:00:07 INFO - 'tscrollx', 01:00:07 INFO - 'cart']}, 01:00:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'tests': ['tp5o']}, 01:00:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'talos_options': ['--e10s'], 01:00:07 INFO - 'tests': ['tp5o']}, 01:00:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'talos_options': ['--xperf_path', 01:00:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:07 INFO - 'tests': ['tp5n']}, 01:00:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:07 INFO - 'talos_options': ['--e10s', 01:00:07 INFO - '--xperf_path', 01:00:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:07 INFO - 'tests': ['tp5n']}}, 01:00:07 INFO - 'talos.zip': {'path': '', 01:00:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:00:07 INFO - Running post-action listener: _resource_record_post_action 01:00:07 INFO - ##### 01:00:07 INFO - ##### Running create-virtualenv step. 01:00:07 INFO - ##### 01:00:07 INFO - Running pre-action listener: _resource_record_pre_action 01:00:07 INFO - Running main action method: create_virtualenv 01:00:07 INFO - Creating virtualenv /builds/slave/test/build/venv 01:00:07 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 01:00:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:00:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:00:08 INFO - Using real prefix '/tools/python27' 01:00:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:00:08 INFO - Installing distribute.............................................................................................................................................................................................done. 01:00:11 INFO - Installing pip.................done. 01:00:11 INFO - Return code: 0 01:00:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:11 INFO - 'HOME': '/Users/cltbld', 01:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:11 INFO - 'LOGNAME': 'cltbld', 01:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:11 INFO - 'MOZ_NO_REMOTE': '1', 01:00:11 INFO - 'NO_EM_RESTART': '1', 01:00:11 INFO - 'PAGER': '/bin/cat', 01:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:11 INFO - 'PWD': '/builds/slave/test', 01:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:11 INFO - 'SHELL': '/bin/bash', 01:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:11 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:11 INFO - 'USER': 'cltbld', 01:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:11 INFO - 'XPC_FLAGS': '0x0', 01:00:11 INFO - 'XPC_SERVICE_NAME': '0', 01:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:12 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 01:00:12 INFO - Cleaning up... 01:00:12 INFO - Return code: 0 01:00:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:12 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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:12 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 01:00:12 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 01:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:12 INFO - 'HOME': '/Users/cltbld', 01:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:12 INFO - 'LOGNAME': 'cltbld', 01:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:12 INFO - 'MOZ_NO_REMOTE': '1', 01:00:12 INFO - 'NO_EM_RESTART': '1', 01:00:12 INFO - 'PAGER': '/bin/cat', 01:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:12 INFO - 'PWD': '/builds/slave/test', 01:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:12 INFO - 'SHELL': '/bin/bash', 01:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:12 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:12 INFO - 'USER': 'cltbld', 01:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:12 INFO - 'XPC_FLAGS': '0x0', 01:00:12 INFO - 'XPC_SERVICE_NAME': '0', 01:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:12 INFO - Downloading/unpacking psutil>=0.7.1 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:12 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 01:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:00:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:15 INFO - Installing collected packages: psutil 01:00:15 INFO - Running setup.py install for psutil 01:00:15 INFO - building 'psutil._psutil_osx' extension 01:00:15 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 01:00:15 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 01:00:15 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 01:00:16 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 01:00:16 INFO - building 'psutil._psutil_posix' extension 01:00:16 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 01:00:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:00:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:00:16 INFO - ^ 01:00:16 INFO - 1 warning generated. 01:00:16 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 01:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:16 INFO - Successfully installed psutil 01:00:16 INFO - Cleaning up... 01:00:16 INFO - Return code: 0 01:00:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:16 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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:16 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 01:00:16 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 01:00:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:16 INFO - 'HOME': '/Users/cltbld', 01:00:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:16 INFO - 'LOGNAME': 'cltbld', 01:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:16 INFO - 'MOZ_NO_REMOTE': '1', 01:00:16 INFO - 'NO_EM_RESTART': '1', 01:00:16 INFO - 'PAGER': '/bin/cat', 01:00:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:16 INFO - 'PWD': '/builds/slave/test', 01:00:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:16 INFO - 'SHELL': '/bin/bash', 01:00:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:16 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:16 INFO - 'USER': 'cltbld', 01:00:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:16 INFO - 'XPC_FLAGS': '0x0', 01:00:16 INFO - 'XPC_SERVICE_NAME': '0', 01:00:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:00:16 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 01:00:16 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 01:00:16 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 01:00:16 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 01:00:16 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 01:00:16 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 01:00:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:00:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:00:19 INFO - Installing collected packages: mozsystemmonitor 01:00:19 INFO - Running setup.py install for mozsystemmonitor 01:00:19 INFO - Successfully installed mozsystemmonitor 01:00:19 INFO - Cleaning up... 01:00:19 INFO - Return code: 0 01:00:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:00: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')]} 01:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00: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')]} 01:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:19 INFO - 'HOME': '/Users/cltbld', 01:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:19 INFO - 'LOGNAME': 'cltbld', 01:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:19 INFO - 'MOZ_NO_REMOTE': '1', 01:00:19 INFO - 'NO_EM_RESTART': '1', 01:00:19 INFO - 'PAGER': '/bin/cat', 01:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:19 INFO - 'PWD': '/builds/slave/test', 01:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:19 INFO - 'SHELL': '/bin/bash', 01:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:19 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:19 INFO - 'USER': 'cltbld', 01:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:19 INFO - 'XPC_FLAGS': '0x0', 01:00:19 INFO - 'XPC_SERVICE_NAME': '0', 01:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:19 INFO - Downloading/unpacking blobuploader==1.2.4 01:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - Downloading blobuploader-1.2.4.tar.gz 01:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:00:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:22 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 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:00:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:22 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 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:23 INFO - Downloading docopt-0.6.1.tar.gz 01:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:00:23 INFO - Installing collected packages: blobuploader, requests, docopt 01:00:23 INFO - Running setup.py install for blobuploader 01:00:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:00:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:00:23 INFO - Running setup.py install for requests 01:00:24 INFO - Running setup.py install for docopt 01:00:24 INFO - Successfully installed blobuploader requests docopt 01:00:24 INFO - Cleaning up... 01:00:24 INFO - Return code: 0 01:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:24 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')]} 01:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:24 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')]} 01:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:24 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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:24 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 01:00:24 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 01:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:24 INFO - 'HOME': '/Users/cltbld', 01:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:24 INFO - 'LOGNAME': 'cltbld', 01:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:24 INFO - 'MOZ_NO_REMOTE': '1', 01:00:24 INFO - 'NO_EM_RESTART': '1', 01:00:24 INFO - 'PAGER': '/bin/cat', 01:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:24 INFO - 'PWD': '/builds/slave/test', 01:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:24 INFO - 'SHELL': '/bin/bash', 01:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:24 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:24 INFO - 'USER': 'cltbld', 01:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:24 INFO - 'XPC_FLAGS': '0x0', 01:00:24 INFO - 'XPC_SERVICE_NAME': '0', 01:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:24 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-f4xAQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:24 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-UGnr4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:24 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-kIQkfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:24 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-gEiauj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:24 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-yTLooD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-LUsCB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-9LpiLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-fTGziS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-XqZ_86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-XrBew2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-02j708-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-NC0uOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-5H1Obd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:25 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-hCr1TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:26 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-9d7YFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:26 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-KfMHES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:26 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-xLl3rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:00:26 INFO - Running setup.py install for manifestparser 01:00:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Running setup.py install for mozcrash 01:00:26 INFO - Running setup.py install for mozdebug 01:00:26 INFO - Running setup.py install for mozdevice 01:00:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Running setup.py install for mozfile 01:00:27 INFO - Running setup.py install for mozhttpd 01:00:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Running setup.py install for mozinfo 01:00:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Running setup.py install for mozInstall 01:00:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Running setup.py install for mozleak 01:00:27 INFO - Running setup.py install for mozlog 01:00:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Running setup.py install for moznetwork 01:00:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:27 INFO - Running setup.py install for mozprocess 01:00:28 INFO - Running setup.py install for mozprofile 01:00:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:28 INFO - Running setup.py install for mozrunner 01:00:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:28 INFO - Running setup.py install for mozscreenshot 01:00:28 INFO - Running setup.py install for moztest 01:00:28 INFO - Running setup.py install for mozversion 01:00:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:28 INFO - Cleaning up... 01:00:28 INFO - Return code: 0 01:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:28 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')]} 01:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:28 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')]} 01:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:28 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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:28 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 01:00:28 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 01:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:28 INFO - 'HOME': '/Users/cltbld', 01:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:28 INFO - 'LOGNAME': 'cltbld', 01:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:28 INFO - 'MOZ_NO_REMOTE': '1', 01:00:28 INFO - 'NO_EM_RESTART': '1', 01:00:28 INFO - 'PAGER': '/bin/cat', 01:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:28 INFO - 'PWD': '/builds/slave/test', 01:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:28 INFO - 'SHELL': '/bin/bash', 01:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:28 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:28 INFO - 'USER': 'cltbld', 01:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:28 INFO - 'XPC_FLAGS': '0x0', 01:00:28 INFO - 'XPC_SERVICE_NAME': '0', 01:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-0uCfk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-7k_soC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-FtSFRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ZUVIbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-LHHeNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-u13ARX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-yOhmxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-8V4kU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:29 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)) 01:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:29 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-sO2kLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-8gMWBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-PuSXP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-bCoCVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-8l0jMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-LzugPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-jgiuxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-bHFTBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:30 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)) 01:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:30 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-sb5CqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:30 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)) 01:00:30 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)) 01:00:30 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)) 01:00:30 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)) 01:00:30 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)) 01:00:30 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)) 01:00:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:33 INFO - Downloading blessings-1.6.tar.gz 01:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:33 INFO - Installing collected packages: blessings 01:00:33 INFO - Running setup.py install for blessings 01:00:33 INFO - Successfully installed blessings 01:00:33 INFO - Cleaning up... 01:00:33 INFO - Return code: 0 01:00:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:34 INFO - Reading from file tmpfile_stdout 01:00:34 INFO - Current package versions: 01:00:34 INFO - blessings == 1.6 01:00:34 INFO - blobuploader == 1.2.4 01:00:34 INFO - docopt == 0.6.1 01:00:34 INFO - manifestparser == 1.1 01:00:34 INFO - mozInstall == 1.12 01:00:34 INFO - mozcrash == 0.17 01:00:34 INFO - mozdebug == 0.1 01:00:34 INFO - mozdevice == 0.48 01:00:34 INFO - mozfile == 1.2 01:00:34 INFO - mozhttpd == 0.7 01:00:34 INFO - mozinfo == 0.9 01:00:34 INFO - mozleak == 0.1 01:00:34 INFO - mozlog == 3.1 01:00:34 INFO - moznetwork == 0.27 01:00:34 INFO - mozprocess == 0.22 01:00:34 INFO - mozprofile == 0.28 01:00:34 INFO - mozrunner == 6.11 01:00:34 INFO - mozscreenshot == 0.1 01:00:34 INFO - mozsystemmonitor == 0.0 01:00:34 INFO - moztest == 0.7 01:00:34 INFO - mozversion == 1.4 01:00:34 INFO - psutil == 3.1.1 01:00:34 INFO - requests == 1.2.3 01:00:34 INFO - wsgiref == 0.1.2 01:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:34 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')]} 01:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:34 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')]} 01:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:34 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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:34 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 01:00:34 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 01:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:34 INFO - 'HOME': '/Users/cltbld', 01:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:34 INFO - 'LOGNAME': 'cltbld', 01:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:34 INFO - 'MOZ_NO_REMOTE': '1', 01:00:34 INFO - 'NO_EM_RESTART': '1', 01:00:34 INFO - 'PAGER': '/bin/cat', 01:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:34 INFO - 'PWD': '/builds/slave/test', 01:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:34 INFO - 'SHELL': '/bin/bash', 01:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:34 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:34 INFO - 'USER': 'cltbld', 01:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:34 INFO - 'XPC_FLAGS': '0x0', 01:00:34 INFO - 'XPC_SERVICE_NAME': '0', 01:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 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)) 01:00:34 INFO - Cleaning up... 01:00:34 INFO - Return code: 0 01:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:00:34 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')]} 01:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:34 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')]} 01:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:34 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 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00:34 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 01:00:34 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 01:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:34 INFO - 'HOME': '/Users/cltbld', 01:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:34 INFO - 'LOGNAME': 'cltbld', 01:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:34 INFO - 'MOZ_NO_REMOTE': '1', 01:00:34 INFO - 'NO_EM_RESTART': '1', 01:00:34 INFO - 'PAGER': '/bin/cat', 01:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:34 INFO - 'PWD': '/builds/slave/test', 01:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:34 INFO - 'SHELL': '/bin/bash', 01:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:34 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:34 INFO - 'USER': 'cltbld', 01:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:34 INFO - 'XPC_FLAGS': '0x0', 01:00:34 INFO - 'XPC_SERVICE_NAME': '0', 01:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:34 INFO - Downloading/unpacking jsonschema 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:00:36 INFO - Downloading/unpacking functools32 (from jsonschema) 01:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:37 INFO - Downloading functools32-3.2.3-2.tar.gz 01:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:00:37 INFO - warning: no files found matching '*.txt' 01:00:37 INFO - no previously-included directories found matching 'build' 01:00:37 INFO - no previously-included directories found matching 'dist' 01:00:37 INFO - no previously-included directories found matching '.git*' 01:00:37 INFO - Installing collected packages: jsonschema, functools32 01:00:37 INFO - Running setup.py install for functools32 01:00:37 INFO - warning: no files found matching '*.txt' 01:00:37 INFO - no previously-included directories found matching 'build' 01:00:37 INFO - no previously-included directories found matching 'dist' 01:00:37 INFO - no previously-included directories found matching '.git*' 01:00:37 INFO - Successfully installed jsonschema functools32 01:00:37 INFO - Cleaning up... 01:00:37 INFO - Return code: 0 01:00:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:00: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')]} 01:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00: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')]} 01:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b56420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff242d63c60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, '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.BfyI35DCVd/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.j6eyOP4wdE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 01:00: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', 'flake8'] in /builds/slave/test/build 01:00: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 flake8 01:00:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:00:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:37 INFO - 'HOME': '/Users/cltbld', 01:00:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:37 INFO - 'LOGNAME': 'cltbld', 01:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:37 INFO - 'MOZ_NO_REMOTE': '1', 01:00:37 INFO - 'NO_EM_RESTART': '1', 01:00:37 INFO - 'PAGER': '/bin/cat', 01:00:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:37 INFO - 'PWD': '/builds/slave/test', 01:00:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:37 INFO - 'SHELL': '/bin/bash', 01:00:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:00:37 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:00:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:37 INFO - 'USER': 'cltbld', 01:00:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:37 INFO - 'XPC_FLAGS': '0x0', 01:00:37 INFO - 'XPC_SERVICE_NAME': '0', 01:00:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:37 INFO - Downloading/unpacking flake8 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:00:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:00:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:00:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:41 INFO - no previously-included directories found matching 'docs/_build' 01:00:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:00:41 INFO - Running setup.py install for pep8 01:00:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:41 INFO - no previously-included directories found matching 'docs/_build' 01:00:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:00:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:00:41 INFO - Cleaning up... 01:00:42 INFO - Return code: 0 01:00:42 INFO - Running post-action listener: _resource_record_post_action 01:00:42 INFO - Running post-action listener: _start_resource_monitoring 01:00:42 INFO - Starting resource monitoring. 01:00:42 INFO - ##### 01:00:42 INFO - ##### Running install step. 01:00:42 INFO - ##### 01:00:42 INFO - Running pre-action listener: _resource_record_pre_action 01:00:42 INFO - Running main action method: install 01:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:42 INFO - Reading from file tmpfile_stdout 01:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:00:42 INFO - Reading from file tmpfile_stdout 01:00:42 INFO - Output received: 01:00:42 INFO - Usage: mozinstall [options] installer 01:00:42 INFO - Options: 01:00:42 INFO - -h, --help show this help message and exit 01:00:42 INFO - -d DEST, --destination=DEST 01:00:42 INFO - Directory to install application into. [default: 01:00:42 INFO - "/builds/slave/test"] 01:00:42 INFO - --app=APP Application being installed. [default: firefox] 01:00:42 INFO - mkdir: /builds/slave/test/build/application 01:00:42 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'] 01:00:42 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 01:01:16 INFO - Reading from file tmpfile_stdout 01:01:16 INFO - Output received: 01:01:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:01:16 INFO - Running post-action listener: _resource_record_post_action 01:01:16 INFO - ##### 01:01:16 INFO - ##### Running run-tests step. 01:01:16 INFO - ##### 01:01:16 INFO - Running pre-action listener: _resource_record_pre_action 01:01:16 INFO - Running main action method: run_tests 01:01:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:01:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:01:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:01:16 INFO - 2016-03-18 01:01:16.471 screenresolution[1640:7332] starting screenresolution argv=screenresolution get 01:01:16 INFO - 2016-03-18 01:01:16.474 screenresolution[1640:7332] Display 0: 1600x1200x32@60 01:01:16 INFO - 2016-03-18 01:01:16.479 screenresolution[1641:7334] starting screenresolution argv=screenresolution list 01:01:16 INFO - Available Modes on Display 0 01:01:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:01:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:01:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:01:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:01:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:01:16 INFO - Intel Iris: 01:01:16 INFO - Chipset Model: Intel Iris 01:01:16 INFO - Type: GPU 01:01:16 INFO - Bus: Built-In 01:01:16 INFO - VRAM (Dynamic, Max): 1536 MB 01:01:16 INFO - Vendor: Intel (0x8086) 01:01:16 INFO - Device ID: 0x0a2e 01:01:16 INFO - Revision ID: 0x0009 01:01:16 INFO - Displays: 01:01:16 INFO - Display: 01:01:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:01:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:01:16 INFO - Display Serial Number: 1600x1200 60 01:01:16 INFO - Main Display: Yes 01:01:16 INFO - Mirror: Off 01:01:16 INFO - Online: Yes 01:01:16 INFO - Rotation: Supported 01:01:16 INFO - Return code: 0 01:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:01:16 INFO - Python 2.7.3 01:01:16 INFO - Return code: 0 01:01:16 INFO - grabbing minidump binary from tooltool 01:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:16 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 0x1079e5e00>, '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 0x10780edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:01:16 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 01:01:16 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 01:01:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:01:16 INFO - Return code: 0 01:01:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:01:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:01:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:01:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:01:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:01:18 INFO - Return code: 0 01:01:18 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/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 01:01:18 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/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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 01:01:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BfyI35DCVd/Render', 01:01:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:18 INFO - 'HOME': '/Users/cltbld', 01:01:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:18 INFO - 'LOGNAME': 'cltbld', 01:01:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:01:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:18 INFO - 'MOZ_NO_REMOTE': '1', 01:01:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:01:18 INFO - 'NO_EM_RESTART': '1', 01:01:18 INFO - 'PAGER': '/bin/cat', 01:01:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:18 INFO - 'PWD': '/builds/slave/test', 01:01:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:01:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:18 INFO - 'SHELL': '/bin/bash', 01:01:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j6eyOP4wdE/Listeners', 01:01:18 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 01:01:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:18 INFO - 'USER': 'cltbld', 01:01:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:18 INFO - 'XPC_FLAGS': '0x0', 01:01:18 INFO - 'XPC_SERVICE_NAME': '0', 01:01:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:18 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/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 01:01:18 INFO - mozversion application_buildid: 20160318000913 01:01:18 INFO - mozversion application_changeset: 0e729ba9f2bf518876ce87959ae4a95827f68935 01:01:18 INFO - mozversion application_display_name: Nightly 01:01:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:01:18 INFO - mozversion application_name: Firefox 01:01:18 INFO - mozversion application_remotingname: firefox 01:01:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:01:18 INFO - mozversion application_vendor: Mozilla 01:01:18 INFO - mozversion application_version: 48.0a1 01:01:18 INFO - mozversion platform_buildid: 20160318000913 01:01:18 INFO - mozversion platform_changeset: 0e729ba9f2bf518876ce87959ae4a95827f68935 01:01:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:01:18 INFO - mozversion platform_version: 48.0a1 01:01:18 INFO - using testdate: 1458288078 01:01:18 INFO - actual date: 1458288078 01:01:18 INFO - starting webserver on 'localhost:49270' 01:01:18 INFO - SUITE-START | Running 2 tests 01:01:18 INFO - TEST-START | dromaeo_css 01:01:18 INFO - operating with platform_type : mac_ 01:01:18 INFO - Initialising browser for dromaeo_css test... 01:01:18 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpCabOMg/profile http://localhost:49270/getInfo.html) 01:01:20 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 01:01:20 INFO - PROCESS | 1659 | colorDepth:24 01:01:20 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 01:01:20 INFO - PROCESS | 1659 | __metrics 01:01:20 INFO - PROCESS | 1659 | 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" 01:01:20 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:01:21 INFO - TEST-INFO | 1659: exit 0 01:01:21 INFO - Browser initialized. 01:01:21 INFO - Running cycle 1/1 for dromaeo_css test... 01:01:21 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpCabOMg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:33 INFO - PROCESS | 1662 | RSS: Main: 243625984 01:01:33 INFO - PROCESS | 1662 | 01:02:24 INFO - PROCESS | 1662 | 1458288144617 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] 01:04:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 01:04:35 INFO - PROCESS | 1662 | RSS: Main: 352706560 01:04:35 INFO - PROCESS | 1662 | 01:07:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 01:07:38 INFO - PROCESS | 1662 | RSS: Main: 379195392 01:07:38 INFO - PROCESS | 1662 | 01:10:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 01:10:41 INFO - PROCESS | 1662 | RSS: Main: 373260288 01:10:41 INFO - PROCESS | 1662 | 01:13:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 01:13:44 INFO - PROCESS | 1662 | RSS: Main: 337076224 01:13:44 INFO - PROCESS | 1662 | 01:16:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 01:16:47 INFO - PROCESS | 1662 | RSS: Main: 336318464 01:16:47 INFO - PROCESS | 1662 | 01:19:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 01:19:51 INFO - PROCESS | 1662 | RSS: Main: 441004032 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | __start_tp_report 01:19:51 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 01:19:51 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 01:19:51 INFO - PROCESS | 1662 | |i|pagename|runs| 01:19:51 INFO - PROCESS | 1662 | |0;dojo.html;3384.2892992471584;3441.6042155152163;3470.7570470067076;3486.4944583035463;3532.5584301962253;5456.317960254968;5532.3914369419335;5532.972335138329;5577.470140336672;5582.358028826686;5477.561795056396;5573.191887176357;5575.358833734122;5588.6646801191955;5594.776208951647;5002.499750024996;5042.596592272627;5078.1874900016;5124.461931497195;5144.331236939192;5090.134677104901;5149.948500515003;5152.278680984665;5153.123968925273;5156.149235376159;5086.41506226785;5111.258867464216;5115.2327150927285;5155;5161.612879034087;5131.897362052757;5154.896902061975;5155.690658560498;5162.5095615916425;5211.661242019257;5002.849914502571;5020.849374518771;5078.46676099008;5080.644354895159;5086.262491938685;4725.716457012556;5363.383210930754;5424.996375670474;5462.5083742462975;5483.314585676791;6041.124037014608;6043.848903777397;6055.031195008777;6057.727402266864;6062.393760623946;4890.486498917598;5107.361579802525;6033.155358249848;6133.754649814002;6144.41628045335;5684.261046064068;5684.34630017545;5684.886302273972;5687.544996400319;5713.571482138815;6232.56372053961;6248.4376406123665;6279.843003924939;6280.623162610258;6293.30773614902;4684.625229981593;5821.94178058214;5959.821205363846;6034.879302414015;6076.665783381956;6129.101075098094;6175.073738939105;6175.320714721377;6183.134361189437;6189.535784816067;6063.28811806358;6090.086487026982;6092.261904761905;6105.247473116927;6119.21717045962;5922.407759224043;6063.9090413643835;6089.086637004485;6129.358790882686;6132.600268413531;4727.763611819395;4818.494058123917;4823.662343635911;4866.489018653061;4870.732109733999;4356.825726970949;4367.606915377632;4392.494863090722;4418.116376724668;4425.822967081281;5431.2396264522995;5484.341878974548;5541.251930989345;5547.11246200606;5554.722263886871;6099.24925446448;6100.490342048281;6102.125716101218;6110.01202914832;6123.908141377883;4750.61995040396;5371.221172929982;5534.889302213933;5538.806141785019;5542.944570554243;5254.500822421864;5255.369355677343;5296.443873393238;5310.070737620901;5334.253204551366;6273.592216505913;6285.025820997753;6289.056641503811;6293.968530157412;6305.180326557518;6059.151718759465;6210.782622608187;6213.813585592439;6215.9378406215355;6233.812985610439;6243.7814676486105;6276.435120839146;6301.936980630135;6305.621662700252;6313.589616674902;5968.8806223876145;5977.551683623658;6007.279126504847;6044.576879618385;6057.394260573908;6026.578139530191;6108.827782940854;6159.538034647509;6168.660723660242;6179.721912514037;5896.115582662635;5930.28836539618;5981.983062879234;5998.040313549811;6059.3334733178435;5741.74162162712;5938.61399009063;5955.642661440327;5958.880822383615;5968.820935371946;5654.3497497788285;5771.163181338767;5792.710364481674;5803.65178089316;5935.436133567304;5906.940930590639;5917.615355002084;5925.703714814156;5930.970345148246;5949.91075133882;5128.102582048052;5655.688937108499;5784;5796.072628379439;5842.415758424124 01:19:51 INFO - PROCESS | 1662 | |1;ext.html;495.3387228050552;574.9252597162366;592.4401440638595;623.8159742875852;637.4772686397154;29692.40615187695;30290.697093029063;30322.545161822563;38180;38670.80664596673;41507;42032.73901782952;42052.94867628311;42064.94837629061;42226.94432639186;9458.810823783537;9675.903240967606;9684.03159684033;9691.370060946016;9704.805903881954;9430.29272804539;9448.57481413338;9528.42829430233;9591.040895910388;9600.279979001569;9446;9560.856587151198;9621.663241786538;9725.173360264385;9733.610655573768;9616.038396160398;9690.951545242298;9711.223102151846;9724.708258752178;9737.026297370277;9569.473678947656;9695.612175512972;9704.51477426133;9705.90294097057;9707.708768736878;39801.40297895534;40091.19817603661;40201;40207.59792402068;40249.798751006354;3242.5946756655417;3298.307355455357;3345.481450375196;3485.6514348565192;3495.2135769451925;27780.58329125065;28095.157145285673;28096.578551321745;28520.85739571289;28639.28401789951;2713.7693296069856;2726.1003868723274;2747.2719729271757;2863.4130003349264;2889.393227422244;476775;481459;481465;481971.9999999965;482839;66682;66947;67404.3259567398;67458;67717.66141169262;71088.64455677792;71979.56040879257;72053.63973180206;72190.91713624299;72192;16913.98516089014;17139.828601714074;17145.314187432614;17149.57126071858;17165.82834171667;13035.674108147183;13049.869501305055;13067.803982940264;13073.280969546766;13094.934525327313;21047.368578942656;21309;21364.038618262217;21386.78613213879;21642.783572164393;9272.860907086264;9556.426614403159;9568.808623827485;9591.568379422943;9768.706938791705;791.4380789639421;935.9859602105973;941.0665752430988;1017.9236557258236;1060.8833028366873;21641.56716865654;28474.85762571174;28643.713562864523;28691;29429.117126485813;1056.3556230699267;1099.2085698297212;1104.5029736618394;1167.3812879174052;1208.9274643521417;14024;14638.707225855636;14850.2574871256;14947.626309342137;15051.924740376227;411544;478419;478912;479397;479860;56912;57115;57388.71305643445;57477.71261143668;57962.420375796544;1107.6676996900896;1354.7222819322014;1473.9041962272418;1485.5097817720343;1514.9318280677396;23152.958116884445;27340;28786.992455264804;29190.854045729637;29361.85319073391;46963.765181173876;47161.52838471571;47355.28967065566;47357.52642473531;47472;345941;348370;349010;349114;349465;32162;33602.327953440305;33718.49422258619;33731.325373491905;33740.49389259212;44270;44686.3297050551;45081;45175.09649807051;46268.768656156506;36377;36454.8177259112;36537.81731091328;37302;37606.24787504289;36280.772942079246;36287.64548254226;36676;36726.63273367232;37489.81255093707;35848.4622730654;36237;36512.452313214795;37013;37203.813980929925;31437;32380.83809580937;32527.674723252465;32654;32797.50803737898;24239;24261.27216183517;24374.87812560926;24797.87601061983;24811.50376992486 01:19:51 INFO - PROCESS | 1662 | |2;jquery.html;306.37499501017925;357.8032082354706;359.9094742928925;366.8459247116211;367.8436664417622;19164;19486.805131948677;20224.69662955057;20510.384688459333;20539.281125160585;18822.905885470554;19512.024398780075;19954;19965.301214457497;19967.400977970647;5724.685142317171;5874.88250234995;5928.88142237155;5938.673372964486;5941.435563621449;4162.354835000579;4337.392765012901;5826.854328641775;6176.8455788605415;6458.644774537399;6365.713542890558;6381.489480841522;6386.201724784402;6389.393007664287;6393.136926514931;6239.906401403982;6249.937500625004;6362.840928976766;6423.967880160616;6445.742170313182;3678.5953545110015;5251.291075704769;5477.3427188737605;5481.561475081984;5514.862128446781;23188.76811231883;23697.763022369727;23863.880680596485;24282.635760463607;24285.514289714283;2061.051916118587;2182.454386403399;2483.913063042785;2942.2203116174232;2942.3526824098876;9130.452172869582;9392.29557783169;9650.951745241298;9667.516624168833;14730.70538589233;1642.8357164283595;1709.8119206887231;1816.6548355812486;1833.5232839461703;1875.2780179630804;94155.63769325522;99155;100308;102684;102696.99999999926;11143.275687080313;11220.887791121984;11281.435928203557;11315.20793544444;11448.885511144948;13542.661433464242;13616.387262573207;13664;13685.24731139777;13707.520236791665;8327.375446841512;8601.22588966996;8607.69100186739;8682.30541556674;8699.565021748887;7250;8760.167784060504;8775.297976161892;8778.209961103532;8894.911050889537;4354.085642015212;4433.224185767478;4439.844605438794;4486.080353527519;4502;1737.7654016707584;1788.7227479740661;1789.8031216566167;1799.34323971752;1804.5398423402212;861.8190180062257;868.3053557154377;951.0822056715303;1005.3615953869199;1080.9189310801564;15592.376304947675;18138.727919081226;19091.85448873072;19570.80429195718;19989;923.9214666753267;928.6239073175375;962.3888830592624;973.2311473935512;1036.2435422141878;10240.070318079503;10561.735956601147;10564.735881603021;10576.52405641748;10734.194935379877;620824;629300;637994;642622;649889;112095.43952280187;115515;120431.59136817214;122212.38893805652;123613;1011.2971484818128;1041.1774697988656;1060.4485667453037;1061.1457776489844;1061.2253055269696;17268.74096888573;17332.133393330536;17600.73598896043;17858.642827143125;17904.731429028314;43380;45197.54802451933;46098.76950615225;47048.529514705784;50295.74260643513;64915.67542162259;65950.01074983976;65970;65972.68054638784;66469.66765166144;7401.8149546261775;7549.584772837327;7622.2758837910305;7711.305982461606;7865.646045927832;10892.292001019909;12132.454039568063;12185.586340334667;12359.196652217577;12428;9695.030496950249;10249.282550221413;10332.873783691874;10599.735006624896;10799.946000269949;10362.740931476774;10364.015418535228;10585.788284234426;10655.57377704883;10732.302400344264;10441;10547.050765431148;10679.46602669848;10903.400312982545;10933.18001149933;6345.7144428499905;7460.66427010775;7528.397728181622;7611.3530349920875;7682.577458239851;8098.797530061795;8378.748637540884;10546.8417973732;10986.395748233925;11000.724981875517 01:19:51 INFO - PROCESS | 1662 | |3;mootools.html;1439.251589173629;1566.6161790361364;1604.3502381535475;1873.9906300468504;2007.2272175212538;7941.642626081826;8626.094260102693;8778.56107194641;8784;8785.868211976825;8300.252977232049;8529.872051919227;8550.486970781742;8562.785930351729;8570.95714521428;2121.893905304736;2373.371056669984;2391.6771235883107;2426.4297889995837;2440.2801173653725;2405.518896220763;2410.3974006498374;2415.758424157579;2419.2258477287273;2420.636904464327;2364.148906393697;2397.6043952747777;2414.082648593541;2416.6979127609047;2421.0436877433403;2391.557561851063;2428.4657375377387;2431.7081950166007;2445.8532488050773;2445.8899349529315;2387.474755553793;2390.079819269594;2394.2218778896754;2394.4133687246735;2452.6811514503;8783.692570759993;8881.023087460375;8886.155815197546;8887.844580204597;8895.955520222422;5294.867628309285;5406.135018397038;5420.268263784378;5448.809291674812;5451.727413629343;3561.715062794996;3653.3058718843336;3700.148965737895;3714.758540694846;3736.6076561961145;828.2462958707607;1050.1598721023227;1071.9410432426214;1074.8387741838708;1079.3577821196375;11956.402179891058;11959.103067269989;11965.948683085757;11981.700457488545;12048.33734144613;4750.168720473903;4751.881202969954;4789.544993225638;4831.130396528659;4839.274108883696;10111.494425278706;10115.696529104138;10128.189744820396;10137.64518241858;10137.949310253549;5368.409474957752;5385.892282154335;5423.566114710814;5424.321959755031;5424.755885985141;3689.760165589228;3985.501812273466;4487.820487180476;4539.477960034638;4543.954560454353;3858.151206734514;3914.178022615226;3961.2473630010204;3964.9801750991637;3978.900527486836;1286.0740267007739;1309.4173092973535;1312.5734136405706;1319.4985905356095;1321.0884489702075;1368.6167872995577;1374.3609221711952;1406.7116241170536;1409.3657853965756;1409.4150927365029;8108.108108108104;8309.37679674027;8309.626066826886;8313.833723325499;8313.916860831314;497.64169797745564;501.4433978284102;507.8730317420645;508.9440161582223;512.3416409913318;6229.719662615103;6238.906416403757;6295.213098362705;6308.337624549448;6313.463355614732;10421.270511064304;10789.136869050457;10897;10903.29128606638;10915.345079295268;10506.369617822955;10570.471476426303;10587.100096491731;10653.786924261627;10787.514561844735;8384.496930184208;8404.747857564284;8500.70247541333;8505.10696376884;8516.44643098209;7774.067111946602;7959.442839001214;7963.522188668699;8014.238647328494;8021.63902624395;9377.718668439958;9590.808183836423;9600.75998100053;9716.805663886542;9829.655962041294;9656.9034309656;9877.55551000221;9982.550785214538;10111.898881011095;10194.643187488402;7484.625768711651;7493.250674932463;7511.910772937784;7555.055618047744;7586.203448637813;8236.464629799044;8248.092709802037;8290.834183316421;8313.043999940084;8329.458585191944;7395;7528.171901090986;7541.5475071495885;7646.923530764621;7677.769666910001;7324.743633972786;7384.409247260099;7409.481336306407;7427.517211381243;7563.092428908566;7805.492642978188;7841.960790196013;7911.248431399008;7912.28789408956;7913.010873640795;7003.824904377431;7103.325184107502;7125.1093613298335;7187.2453392393045;7187.353138217585;7175.103112110986;7191.280871912767;7229;7250.984862119202;7260.89108663381 01:19:51 INFO - PROCESS | 1662 | |4;prototype.html;292.7862660258013;322.2411221573195;322.6257541252147;333.26681301137506;334.47654420831395;6556.541042127053;6687.465002799777;6690.431313338372;6696.933030669698;6725.495587830907;5041.924371134427;6608;6610.933890661092;6637.834054148649;6662.367075127867;4700.905981880361;4725.598324142452;4801.519848015206;4910.459849416561;4946.431160416544;4833.758312084382;4847.5394837490385;4849.903001939959;4850.6362022848425;4882.731449770261;4783.521647835223;4809.196551293265;4809.831655892044;4816.470188279304;4837.443693975185;4623.884402889955;4694.95305046952;4801.087793319276;4819.51804819517;4825.20384136617;4104;4131.049858532554;4132.690048246363;4136.937945930814;4145.191687620915;6367.681615919186;6384.648844313561;6387.616742995435;6395.744170233185;6398.744050237985;5752.395998420189;5772.567057470665;5791.333996590404;5792.565557583198;5795.565332600072;7005.54463959841;7006.824829379255;7023.648817559101;7033.050538177383;7033.577985320897;4532.660050496226;4670.509596492388;4702.412198475191;4729.716217026989;4731.266653668687;7310.52481588695;7454.776356709307;7460.104787425489;7481.476296659236;7491.9625401872645;4816.8073277069225;4822.132016237111;4824.6863953842885;4831.710097394168;4835.709857408567;4880.341153944243;4887.315775791392;4893.73084480357;4902.852914412573;4925.9014819704125;5785.739641716133;5791;5799.3620701722775;5808.215890854765;5823.708814559255;6756.358145976124;6764.932350676529;6880.662878503922;6990.126234220723;7099.609521476368;1690.8647308215313;1696.550414140254;1709.5555155659617;1710.2389436700548;1715.3395942562204;1052.578968412641;1113.4544073403974;1119.149446420726;1134.4214450630238;1147.9827802582968;6370.267419246753;6515.348465153542;6675.599464032173;6694;6703.463722902254;7417.406607471389;7421.332080112816;7428;7434;7438.5536867788105;5719.170720245625;5794.971025144847;6661.1007513985;6661.533692641468;6696.799096027127;3838.7696738195796;3892.5134358205223;3894.668953139015;3905.5313362396696;3913.941290880639;6624.966875165594;7324.2309557496765;7694.115176754633;7730.536167829948;7749.070111586646;7580.1661817200065;7598.582077985653;7613.771586852404;7615.314621684075;7631.580263085472;6172.969135154385;7700;7706;7714.997050383414;7727.227277272115;7092.787216383516;7364.484486085923;7383.852322953619;7386.187519372972;7395.223501532261;7215.927840721735;7225.24134965842;7243.818904527429;7254.16577093641;7254.455915806441;7572.507786994048;7638.770836874903;7645.273698998586;7656.081270247606;7659.348955338859;3938.232044751246;4835.178019736723;4849.005953779396;4849.684770489906;4859.125357435695;7031.40233080194;7280.490365674564;7290.781276561712;7298.124225093023;7300.780976570712;6050.45545900871;6540.084388185753;6787.389134977876;7084.114485689289;7091.964540177266;6161.599496032743;6241.500679945502;6647.268800431852;7063.434925205868;7070.929290707027;6872.931270687429;6878.933765266392;6886.345797149263;6894.896816509335;6903.723851046103;5719.542436604978;6788.694508747217;6956.234814170539;7025.789226323219;7053.470989675898;6702.329767023259;6730.899036514554;6843.315668433117;6914.274001229798;6920.688569014305 01:19:51 INFO - PROCESS | 1662 | |5;yui.html;648.7502311610028;694.4722011271434;736.9778906632799;759.3583422008401;764.2892110337384;14818.703625927503;14822.96239263252;14968.85031149691;15000.174990375539;15007.624809379771;13792.172469651829;14115.223662698572;14138.929305353484;14170.929145354285;14177.362018709156;710.9537880037794;722.4220623501204;737.1412304665059;884.385352180235;895.292718752185;886.6497733395305;903.5798353765498;903.6972614174259;907.2923119966437;907.4963395315597;951.3816019587289;953.9904600954005;954.7899462118323;958.2477754962356;958.4249450329816;763.9159692433827;932.1238036245907;947.5357075033253;950.7385468996013;957.1816097236832;696.6203419136583;704.1620471638734;707.695690852933;709.8544798316333;710.4032612605437;14898.925505372405;14970.401183952628;14975.176365299903;14976.700465990729;14982.550523484313;12448.377581120907;12467.064970127187;12523;12619.495220191182;12728.936355318257;9537.2370210383;9996;10068.244881633833;10629.5216715248;10810.567577296899;3526.6825985661158;3609.927801443983;3618.6200448952745;3627.564692236922;3633.927321453556;78570.60714696447;78809;79209.99999999942;79424.80862787063;84846.72729909056;8989.820203595891;9202;9350.438973661601;9354.111359420844;10203.38779673222;20023.29918452847;20290.289839855534;20323.18707251723;20345.389638310873;20355.287564935155;7496.62516874165;7503.399728021745;7677.539347639159;7769.456138070281;7898.328642065489;4113.218488487238;4136.379543068504;4172.70791044624;4180.393842892824;4247.086876321606;3361;3405.216800135983;3428.280061187129;3436.106612280825;3437.3297207044884;622.0762168180248;627.2222444169197;628.7830698409042;635.6916895305773;647.4949539359308;521.8877941242652;578.5949835115437;597.1967703438954;606.7209083821404;614.1064750787593;8060.39547033963;8062.516249025077;8108.594570271581;8196.8360632787;8306.08633050364;573.6013470637866;584.7251791657914;588.5056552495925;598.2163365990566;610.1793088296234;3687.9815600921825;3757;3770.245950809849;3852.3451013327804;3863.36254518007;94061;95793.52103239439;97313.51343243239;97328.51335743276;97544.56138596592;82618.58690706508;83905.58047209725;84174;85045;85146;68504.3149568508;69349.30650693428;69817.30182698109;71772;73315;7589.886151707618;7943.285104340637;8210.876836847332;8213.671453141807;8514.910834707176;45360.546394536956;46467;47237.81905452254;47256.52743472521;47372.289415659485;62636.68681656563;63290.41773955688;63414;63416.68291658512;64845;10969.616063437741;10981.945090274818;11026.669199924016;11097.778044438905;11345.262557933707;11955.222910510789;12054.939725301318;12227.87772122303;12322.445489953154;12583.685407864876;11364.566182707245;11448.255863368855;11571.016463600688;11758.88241117612;12451.190672606252;10938.386926516287;11028.849875450263;11093.667189984313;11215.495302711235;11287.430518199579;11091.168162388014;11180.608678696206;11305.208635395444;11632.88367116318;12024.624417716315;9542.284328675516;9635.518224088908;9648.75878103053;9785.510724463606;10380.083352489311;8039.261509698509;8776.91223087761;9099.317551183556;9304.674336398193;9857.901420985698 01:19:51 INFO - PROCESS | 1662 | __end_tp_report 01:19:51 INFO - PROCESS | 1662 | __start_cc_report 01:19:51 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,997 01:19:51 INFO - PROCESS | 1662 | __end_cc_report 01:19:51 INFO - PROCESS | 1662 | __startTimestamp1458289191031__endTimestamp 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | ------- Summary: start ------- 01:19:51 INFO - PROCESS | 1662 | Number of tests: 6 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5598.60 Median:5771.16 stddev:624.97 (10.8%) stddev-sans-first:602.26 01:19:51 INFO - PROCESS | 1662 | Values: 3384.3 3441.6 3470.8 3486.5 3532.6 5456.3 5532.4 5533.0 5577.5 5582.4 5477.6 5573.2 5575.4 5588.7 5594.8 5002.5 5042.6 5078.2 5124.5 5144.3 5090.1 5149.9 5152.3 5153.1 5156.1 5086.4 5111.3 5115.2 5155.0 5161.6 5131.9 5154.9 5155.7 5162.5 5211.7 5002.8 5020.8 5078.5 5080.6 5086.3 4725.7 5363.4 5425.0 5462.5 5483.3 6041.1 6043.8 6055.0 6057.7 6062.4 4890.5 5107.4 6033.2 6133.8 6144.4 5684.3 5684.3 5684.9 5687.5 5713.6 6232.6 6248.4 6279.8 6280.6 6293.3 4684.6 5821.9 5959.8 6034.9 6076.7 6129.1 6175.1 6175.3 6183.1 6189.5 6063.3 6090.1 6092.3 6105.2 6119.2 5922.4 6063.9 6089.1 6129.4 6132.6 4727.8 4818.5 4823.7 4866.5 4870.7 4356.8 4367.6 4392.5 4418.1 4425.8 5431.2 5484.3 5541.3 5547.1 5554.7 6099.2 6100.5 6102.1 6110.0 6123.9 4750.6 5371.2 5534.9 5538.8 5542.9 5254.5 5255.4 5296.4 5310.1 5334.3 6273.6 6285.0 6289.1 6294.0 6305.2 6059.2 6210.8 6213.8 6215.9 6233.8 6243.8 6276.4 6301.9 6305.6 6313.6 5968.9 5977.6 6007.3 6044.6 6057.4 6026.6 6108.8 6159.5 6168.7 6179.7 5896.1 5930.3 5982.0 5998.0 6059.3 5741.7 5938.6 5955.6 5958.9 5968.8 5654.3 5771.2 5792.7 5803.7 5935.4 5906.9 5917.6 5925.7 5931.0 5949.9 5128.1 5655.7 5784.0 5796.1 5842.4 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:58804.46 Median:37108.41 stddev:115585.64 (311.5%) stddev-sans-first:115826.98 01:19:51 INFO - PROCESS | 1662 | Values: 495.3 574.9 592.4 623.8 637.5 29692.4 30290.7 30322.5 38180.0 38670.8 41507.0 42032.7 42052.9 42064.9 42226.9 9458.8 9675.9 9684.0 9691.4 9704.8 9430.3 9448.6 9528.4 9591.0 9600.3 9446.0 9560.9 9621.7 9725.2 9733.6 9616.0 9691.0 9711.2 9724.7 9737.0 9569.5 9695.6 9704.5 9705.9 9707.7 39801.4 40091.2 40201.0 40207.6 40249.8 3242.6 3298.3 3345.5 3485.7 3495.2 27780.6 28095.2 28096.6 28520.9 28639.3 2713.8 2726.1 2747.3 2863.4 2889.4 476775.0 481459.0 481465.0 481972.0 482839.0 66682.0 66947.0 67404.3 67458.0 67717.7 71088.6 71979.6 72053.6 72190.9 72192.0 16914.0 17139.8 17145.3 17149.6 17165.8 13035.7 13049.9 13067.8 13073.3 13094.9 21047.4 21309.0 21364.0 21386.8 21642.8 9272.9 9556.4 9568.8 9591.6 9768.7 791.4 936.0 941.1 1017.9 1060.9 21641.6 28474.9 28643.7 28691.0 29429.1 1056.4 1099.2 1104.5 1167.4 1208.9 14024.0 14638.7 14850.3 14947.6 15051.9 411544.0 478419.0 478912.0 479397.0 479860.0 56912.0 57115.0 57388.7 57477.7 57962.4 1107.7 1354.7 1473.9 1485.5 1514.9 23153.0 27340.0 28787.0 29190.9 29361.9 46963.8 47161.5 47355.3 47357.5 47472.0 345941.0 348370.0 349010.0 349114.0 349465.0 32162.0 33602.3 33718.5 33731.3 33740.5 44270.0 44686.3 45081.0 45175.1 46268.8 36377.0 36454.8 36537.8 37302.0 37606.2 36280.8 36287.6 36676.0 36726.6 37489.8 35848.5 36237.0 36512.5 37013.0 37203.8 31437.0 32380.8 32527.7 32654.0 32797.5 24239.0 24261.3 24374.9 24797.9 24811.5 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34467.52 Median:13384.71 stddev:105196.18 (785.9%) stddev-sans-first:105460.01 01:19:51 INFO - PROCESS | 1662 | Values: 306.4 357.8 359.9 366.8 367.8 19164.0 19486.8 20224.7 20510.4 20539.3 18822.9 19512.0 19954.0 19965.3 19967.4 5724.7 5874.9 5928.9 5938.7 5941.4 4162.4 4337.4 5826.9 6176.8 6458.6 6365.7 6381.5 6386.2 6389.4 6393.1 6239.9 6249.9 6362.8 6424.0 6445.7 3678.6 5251.3 5477.3 5481.6 5514.9 23188.8 23697.8 23863.9 24282.6 24285.5 2061.1 2182.5 2483.9 2942.2 2942.4 9130.5 9392.3 9651.0 9667.5 14730.7 1642.8 1709.8 1816.7 1833.5 1875.3 94155.6 99155.0 100308.0 102684.0 102697.0 11143.3 11220.9 11281.4 11315.2 11448.9 13542.7 13616.4 13664.0 13685.2 13707.5 8327.4 8601.2 8607.7 8682.3 8699.6 7250.0 8760.2 8775.3 8778.2 8894.9 4354.1 4433.2 4439.8 4486.1 4502.0 1737.8 1788.7 1789.8 1799.3 1804.5 861.8 868.3 951.1 1005.4 1080.9 15592.4 18138.7 19091.9 19570.8 19989.0 923.9 928.6 962.4 973.2 1036.2 10240.1 10561.7 10564.7 10576.5 10734.2 620824.0 629300.0 637994.0 642622.0 649889.0 112095.4 115515.0 120431.6 122212.4 123613.0 1011.3 1041.2 1060.4 1061.1 1061.2 17268.7 17332.1 17600.7 17858.6 17904.7 43380.0 45197.5 46098.8 47048.5 50295.7 64915.7 65950.0 65970.0 65972.7 66469.7 7401.8 7549.6 7622.3 7711.3 7865.6 10892.3 12132.5 12185.6 12359.2 12428.0 9695.0 10249.3 10332.9 10599.7 10799.9 10362.7 10364.0 10585.8 10655.6 10732.3 10441.0 10547.1 10679.5 10903.4 10933.2 6345.7 7460.7 7528.4 7611.4 7682.6 8098.8 8378.7 10546.8 10986.4 11000.7 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6066.96 Median:2903.60 stddev:3245.70 (111.8%) stddev-sans-first:3236.17 01:19:51 INFO - PROCESS | 1662 | Values: 1439.3 1566.6 1604.4 1874.0 2007.2 7941.6 8626.1 8778.6 8784.0 8785.9 8300.3 8529.9 8550.5 8562.8 8571.0 2121.9 2373.4 2391.7 2426.4 2440.3 2405.5 2410.4 2415.8 2419.2 2420.6 2364.1 2397.6 2414.1 2416.7 2421.0 2391.6 2428.5 2431.7 2445.9 2445.9 2387.5 2390.1 2394.2 2394.4 2452.7 8783.7 8881.0 8886.2 8887.8 8896.0 5294.9 5406.1 5420.3 5448.8 5451.7 3561.7 3653.3 3700.1 3714.8 3736.6 828.2 1050.2 1071.9 1074.8 1079.4 11956.4 11959.1 11965.9 11981.7 12048.3 4750.2 4751.9 4789.5 4831.1 4839.3 10111.5 10115.7 10128.2 10137.6 10137.9 5368.4 5385.9 5423.6 5424.3 5424.8 3689.8 3985.5 4487.8 4539.5 4544.0 3858.2 3914.2 3961.2 3965.0 3978.9 1286.1 1309.4 1312.6 1319.5 1321.1 1368.6 1374.4 1406.7 1409.4 1409.4 8108.1 8309.4 8309.6 8313.8 8313.9 497.6 501.4 507.9 508.9 512.3 6229.7 6238.9 6295.2 6308.3 6313.5 10421.3 10789.1 10897.0 10903.3 10915.3 10506.4 10570.5 10587.1 10653.8 10787.5 8384.5 8404.7 8500.7 8505.1 8516.4 7774.1 7959.4 7963.5 8014.2 8021.6 9377.7 9590.8 9600.8 9716.8 9829.7 9656.9 9877.6 9982.6 10111.9 10194.6 7484.6 7493.3 7511.9 7555.1 7586.2 8236.5 8248.1 8290.8 8313.0 8329.5 7395.0 7528.2 7541.5 7646.9 7677.8 7324.7 7384.4 7409.5 7427.5 7563.1 7805.5 7842.0 7911.2 7912.3 7913.0 7003.8 7103.3 7125.1 7187.2 7187.4 7175.1 7191.3 7229.0 7251.0 7260.9 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5770.41 Median:6548.31 stddev:1819.81 (27.8%) stddev-sans-first:1777.87 01:19:51 INFO - PROCESS | 1662 | Values: 292.8 322.2 322.6 333.3 334.5 6556.5 6687.5 6690.4 6696.9 6725.5 5041.9 6608.0 6610.9 6637.8 6662.4 4700.9 4725.6 4801.5 4910.5 4946.4 4833.8 4847.5 4849.9 4850.6 4882.7 4783.5 4809.2 4809.8 4816.5 4837.4 4623.9 4695.0 4801.1 4819.5 4825.2 4104.0 4131.0 4132.7 4136.9 4145.2 6367.7 6384.6 6387.6 6395.7 6398.7 5752.4 5772.6 5791.3 5792.6 5795.6 7005.5 7006.8 7023.6 7033.1 7033.6 4532.7 4670.5 4702.4 4729.7 4731.3 7310.5 7454.8 7460.1 7481.5 7492.0 4816.8 4822.1 4824.7 4831.7 4835.7 4880.3 4887.3 4893.7 4902.9 4925.9 5785.7 5791.0 5799.4 5808.2 5823.7 6756.4 6764.9 6880.7 6990.1 7099.6 1690.9 1696.6 1709.6 1710.2 1715.3 1052.6 1113.5 1119.1 1134.4 1148.0 6370.3 6515.3 6675.6 6694.0 6703.5 7417.4 7421.3 7428.0 7434.0 7438.6 5719.2 5795.0 6661.1 6661.5 6696.8 3838.8 3892.5 3894.7 3905.5 3913.9 6625.0 7324.2 7694.1 7730.5 7749.1 7580.2 7598.6 7613.8 7615.3 7631.6 6173.0 7700.0 7706.0 7715.0 7727.2 7092.8 7364.5 7383.9 7386.2 7395.2 7215.9 7225.2 7243.8 7254.2 7254.5 7572.5 7638.8 7645.3 7656.1 7659.3 3938.2 4835.2 4849.0 4849.7 4859.1 7031.4 7280.5 7290.8 7298.1 7300.8 6050.5 6540.1 6787.4 7084.1 7092.0 6161.6 6241.5 6647.3 7063.4 7070.9 6872.9 6878.9 6886.3 6894.9 6903.7 5719.5 6788.7 6956.2 7025.8 7053.5 6702.3 6730.9 6843.3 6914.3 6920.7 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18335.16 Median:31629.38 stddev:26115.51 (82.6%) stddev-sans-first:26155.00 01:19:51 INFO - PROCESS | 1662 | Values: 648.8 694.5 737.0 759.4 764.3 14818.7 14823.0 14968.9 15000.2 15007.6 13792.2 14115.2 14138.9 14170.9 14177.4 711.0 722.4 737.1 884.4 895.3 886.6 903.6 903.7 907.3 907.5 951.4 954.0 954.8 958.2 958.4 763.9 932.1 947.5 950.7 957.2 696.6 704.2 707.7 709.9 710.4 14898.9 14970.4 14975.2 14976.7 14982.6 12448.4 12467.1 12523.0 12619.5 12728.9 9537.2 9996.0 10068.2 10629.5 10810.6 3526.7 3609.9 3618.6 3627.6 3633.9 78570.6 78809.0 79210.0 79424.8 84846.7 8989.8 9202.0 9350.4 9354.1 10203.4 20023.3 20290.3 20323.2 20345.4 20355.3 7496.6 7503.4 7677.5 7769.5 7898.3 4113.2 4136.4 4172.7 4180.4 4247.1 3361.0 3405.2 3428.3 3436.1 3437.3 622.1 627.2 628.8 635.7 647.5 521.9 578.6 597.2 606.7 614.1 8060.4 8062.5 8108.6 8196.8 8306.1 573.6 584.7 588.5 598.2 610.2 3688.0 3757.0 3770.2 3852.3 3863.4 94061.0 95793.5 97313.5 97328.5 97544.6 82618.6 83905.6 84174.0 85045.0 85146.0 68504.3 69349.3 69817.3 71772.0 73315.0 7589.9 7943.3 8210.9 8213.7 8514.9 45360.5 46467.0 47237.8 47256.5 47372.3 62636.7 63290.4 63414.0 63416.7 64845.0 10969.6 10981.9 11026.7 11097.8 11345.3 11955.2 12054.9 12227.9 12322.4 12583.7 11364.6 11448.3 11571.0 11758.9 12451.2 10938.4 11028.8 11093.7 11215.5 11287.4 11091.2 11180.6 11305.2 11632.9 12024.6 9542.3 9635.5 9648.8 9785.5 10380.1 8039.3 8776.9 9099.3 9304.7 9857.9 01:19:51 INFO - PROCESS | 1662 | -------- Summary: end -------- 01:19:51 INFO - PROCESS | 1662 | 01:19:51 INFO - TEST-INFO | 1662: exit 0 01:19:51 INFO - TEST-OK | dromaeo_css | took 1113355ms 01:19:51 INFO - TEST-START | kraken 01:19:51 INFO - operating with platform_type : mac_ 01:19:51 INFO - Initialising browser for kraken test... 01:19:51 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpdaN4Rl/profile http://localhost:49270/getInfo.html) 01:19:53 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 01:19:53 INFO - PROCESS | 1672 | colorDepth:24 01:19:53 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 01:19:53 INFO - PROCESS | 1672 | __metrics 01:19:53 INFO - PROCESS | 1672 | 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" 01:19:53 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:19:54 INFO - TEST-INFO | 1672: exit 0 01:19:54 INFO - Browser initialized. 01:19:54 INFO - Running cycle 1/1 for kraken test... 01:19:54 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpdaN4Rl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:06 INFO - PROCESS | 1674 | RSS: Main: 243691520 01:20:06 INFO - PROCESS | 1674 | 01:20:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 01:20:09 INFO - PROCESS | 1674 | RSS: Main: 289509376 01:20:09 INFO - PROCESS | 1674 | 01:20:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 01:20:12 INFO - PROCESS | 1674 | RSS: Main: 301555712 01:20:12 INFO - PROCESS | 1674 | 01:20:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 01:20:16 INFO - PROCESS | 1674 | RSS: Main: 287494144 01:20:16 INFO - PROCESS | 1674 | 01:20:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 01:20:19 INFO - PROCESS | 1674 | RSS: Main: 290848768 01:20:19 INFO - PROCESS | 1674 | 01:20:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:20:21 INFO - PROCESS | 1674 | RSS: Main: 290021376 01:20:21 INFO - PROCESS | 1674 | 01:20:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 01:20:24 INFO - PROCESS | 1674 | RSS: Main: 290619392 01:20:24 INFO - PROCESS | 1674 | 01:20:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 01:20:28 INFO - PROCESS | 1674 | RSS: Main: 289492992 01:20:28 INFO - PROCESS | 1674 | 01:20:31 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 01:20:31 INFO - PROCESS | 1674 | RSS: Main: 290463744 01:20:31 INFO - PROCESS | 1674 | 01:20:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:20:33 INFO - PROCESS | 1674 | RSS: Main: 323096576 01:20:33 INFO - PROCESS | 1674 | 01:20:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:20:36 INFO - PROCESS | 1674 | RSS: Main: 323575808 01:20:36 INFO - PROCESS | 1674 | 01:20:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:20:39 INFO - PROCESS | 1674 | RSS: Main: 332992512 01:20:39 INFO - PROCESS | 1674 | 01:20:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:20:42 INFO - PROCESS | 1674 | RSS: Main: 335142912 01:20:42 INFO - PROCESS | 1674 | 01:20:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:20:45 INFO - PROCESS | 1674 | RSS: Main: 334307328 01:20:45 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 01:20:47 INFO - PROCESS | 1674 | RSS: Main: 394706944 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | __start_tp_report 01:20:47 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 01:20:47 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 01:20:47 INFO - PROCESS | 1674 | |i|pagename|runs| 01:20:47 INFO - PROCESS | 1674 | |0;ai-astar;111;104;111;110;111;112;116;112;109;112 01:20:47 INFO - PROCESS | 1674 | |1;audio-beat-detection;176;144;171;166;117;143;139;115;159;118 01:20:47 INFO - PROCESS | 1674 | |2;audio-dft;185;182;183;184;184;184;186;184;181;179 01:20:47 INFO - PROCESS | 1674 | |3;audio-fft;74;74;81;76;55;68;57;77;75;55 01:20:47 INFO - PROCESS | 1674 | |4;audio-oscillator;96;94;131;81;79;90;113;77;80;111 01:20:47 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;88;85;88;86;87;85;89;85;88;84 01:20:47 INFO - PROCESS | 1674 | |6;imaging-darkroom;116;93;93;94;108;150;93;94;92;93 01:20:47 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;87;87;86;94;104;85;83;85;87 01:20:47 INFO - PROCESS | 1674 | |8;json-parse-financial;55;55;55;53;55;55;53;63;55;53 01:20:47 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;71;65;72;71;66;66;65;66;68 01:20:47 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;82;83;83;84;82;82;79;83;85;81 01:20:47 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;128;118;140;136;120;123;124;134;115;129 01:20:47 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;138;139;139;134;137;125;140;136;168;134 01:20:47 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;68;66;68;67;68;67;69;66;66 01:20:47 INFO - PROCESS | 1674 | __end_tp_report 01:20:47 INFO - PROCESS | 1674 | __start_cc_report 01:20:47 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1234 01:20:47 INFO - PROCESS | 1674 | __end_cc_report 01:20:47 INFO - PROCESS | 1674 | __startTimestamp1458289247327__endTimestamp 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | ------- Summary: start ------- 01:20:47 INFO - PROCESS | 1674 | Number of tests: 14 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:3.01 (2.7%) stddev-sans-first:3.19 01:20:47 INFO - PROCESS | 1674 | Values: 111.0 104.0 111.0 110.0 111.0 112.0 116.0 112.0 109.0 112.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:151.50 stddev:22.92 (15.1%) stddev-sans-first:21.35 01:20:47 INFO - PROCESS | 1674 | Values: 176.0 144.0 171.0 166.0 117.0 143.0 139.0 115.0 159.0 118.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:2.04 (1.1%) stddev-sans-first:2.06 01:20:47 INFO - PROCESS | 1674 | Values: 185.0 182.0 183.0 184.0 184.0 184.0 186.0 184.0 181.0 179.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:69.20 Median:74.50 stddev:9.89 (13.3%) stddev-sans-first:10.33 01:20:47 INFO - PROCESS | 1674 | Values: 74.0 74.0 81.0 76.0 55.0 68.0 57.0 77.0 75.0 55.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:80.50 stddev:17.96 (22.3%) stddev-sans-first:19.05 01:20:47 INFO - PROCESS | 1674 | Values: 96.0 94.0 131.0 81.0 79.0 90.0 113.0 77.0 80.0 111.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:1.72 (2.0%) stddev-sans-first:1.73 01:20:47 INFO - PROCESS | 1674 | Values: 88.0 85.0 88.0 86.0 87.0 85.0 89.0 85.0 88.0 84.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:18.51 (19.9%) stddev-sans-first:18.99 01:20:47 INFO - PROCESS | 1674 | Values: 116.0 93.0 93.0 94.0 108.0 150.0 93.0 94.0 92.0 93.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:88.30 Median:86.50 stddev:6.24 (7.2%) stddev-sans-first:6.50 01:20:47 INFO - PROCESS | 1674 | Values: 85.0 87.0 87.0 86.0 94.0 104.0 85.0 83.0 85.0 87.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.90 (5.3%) stddev-sans-first:3.07 01:20:47 INFO - PROCESS | 1674 | Values: 55.0 55.0 55.0 53.0 55.0 55.0 53.0 63.0 55.0 53.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:3.06 (4.6%) stddev-sans-first:2.82 01:20:47 INFO - PROCESS | 1674 | Values: 63.0 71.0 65.0 72.0 71.0 66.0 66.0 65.0 66.0 68.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.65 (2.0%) stddev-sans-first:1.74 01:20:47 INFO - PROCESS | 1674 | Values: 82.0 83.0 83.0 84.0 82.0 82.0 79.0 83.0 85.0 81.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:128.50 stddev:8.18 (6.4%) stddev-sans-first:8.66 01:20:47 INFO - PROCESS | 1674 | Values: 128.0 118.0 140.0 136.0 120.0 123.0 124.0 134.0 115.0 129.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:138.50 stddev:11.07 (8.0%) stddev-sans-first:11.73 01:20:47 INFO - PROCESS | 1674 | Values: 138.0 139.0 139.0 134.0 137.0 125.0 140.0 136.0 168.0 134.0 01:20:47 INFO - PROCESS | 1674 | 01:20:47 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 01:20:47 INFO - PROCESS | 1674 | Values: 67.0 68.0 66.0 68.0 67.0 68.0 67.0 69.0 66.0 66.0 01:20:47 INFO - PROCESS | 1674 | -------- Summary: end -------- 01:20:47 INFO - PROCESS | 1674 | 01:20:48 INFO - TEST-INFO | 1674: exit 0 01:20:48 INFO - TEST-OK | kraken | took 56497ms 01:20:48 INFO - SUITE-END | took 1169s 01:20:48 INFO - Completed test suite (00:19:30) 01:20:48 INFO - javascript benchmark 01:20:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3384.2892992471584, 3441.6042155152163, 3470.7570470067076, 3486.4944583035463, 3532.5584301962253, 5456.317960254968, 5532.3914369419335, 5532.972335138329, 5577.470140336672, 5582.358028826686, 5477.561795056396, 5573.191887176357, 5575.358833734122, 5588.6646801191955, 5594.776208951647, 5002.499750024996, 5042.596592272627, 5078.1874900016, 5124.461931497195, 5144.331236939192, 5090.134677104901, 5149.948500515003, 5152.278680984665, 5153.123968925273, 5156.149235376159, 5086.41506226785, 5111.258867464216, 5115.2327150927285, 5155.0, 5161.612879034087, 5131.897362052757, 5154.896902061975, 5155.690658560498, 5162.5095615916425, 5211.661242019257, 5002.849914502571, 5020.849374518771, 5078.46676099008, 5080.644354895159, 5086.262491938685, 4725.716457012556, 5363.383210930754, 5424.996375670474, 5462.5083742462975, 5483.314585676791, 6041.124037014608, 6043.848903777397, 6055.031195008777, 6057.727402266864, 6062.393760623946, 4890.486498917598, 5107.361579802525, 6033.155358249848, 6133.754649814002, 6144.41628045335, 5684.261046064068, 5684.34630017545, 5684.886302273972, 5687.544996400319, 5713.571482138815, 6232.56372053961, 6248.4376406123665, 6279.843003924939, 6280.623162610258, 6293.30773614902, 4684.625229981593, 5821.94178058214, 5959.821205363846, 6034.879302414015, 6076.665783381956, 6129.101075098094, 6175.073738939105, 6175.320714721377, 6183.134361189437, 6189.535784816067, 6063.28811806358, 6090.086487026982, 6092.261904761905, 6105.247473116927, 6119.21717045962, 5922.407759224043, 6063.9090413643835, 6089.086637004485, 6129.358790882686, 6132.600268413531, 4727.763611819395, 4818.494058123917, 4823.662343635911, 4866.489018653061, 4870.732109733999, 4356.825726970949, 4367.606915377632, 4392.494863090722, 4418.116376724668, 4425.822967081281, 5431.2396264522995, 5484.341878974548, 5541.251930989345, 5547.11246200606, 5554.722263886871, 6099.24925446448, 6100.490342048281, 6102.125716101218, 6110.01202914832, 6123.908141377883, 4750.61995040396, 5371.221172929982, 5534.889302213933, 5538.806141785019, 5542.944570554243, 5254.500822421864, 5255.369355677343, 5296.443873393238, 5310.070737620901, 5334.253204551366, 6273.592216505913, 6285.025820997753, 6289.056641503811, 6293.968530157412, 6305.180326557518, 6059.151718759465, 6210.782622608187, 6213.813585592439, 6215.9378406215355, 6233.812985610439, 6243.7814676486105, 6276.435120839146, 6301.936980630135, 6305.621662700252, 6313.589616674902, 5968.8806223876145, 5977.551683623658, 6007.279126504847, 6044.576879618385, 6057.394260573908, 6026.578139530191, 6108.827782940854, 6159.538034647509, 6168.660723660242, 6179.721912514037, 5896.115582662635, 5930.28836539618, 5981.983062879234, 5998.040313549811, 6059.3334733178435, 5741.74162162712, 5938.61399009063, 5955.642661440327, 5958.880822383615, 5968.820935371946, 5654.3497497788285, 5771.163181338767, 5792.710364481674, 5803.65178089316, 5935.436133567304, 5906.940930590639, 5917.615355002084, 5925.703714814156, 5930.970345148246, 5949.91075133882, 5128.102582048052, 5655.688937108499, 5784.0, 5796.072628379439, 5842.415758424124], "unit": "score", "name": "dojo.html", "value": 5561.543596495756}, {"lowerIsBetter": false, "replicates": [495.3387228050552, 574.9252597162366, 592.4401440638595, 623.8159742875852, 637.4772686397154, 29692.40615187695, 30290.697093029063, 30322.545161822563, 38180.0, 38670.80664596673, 41507.0, 42032.73901782952, 42052.94867628311, 42064.94837629061, 42226.94432639186, 9458.810823783537, 9675.903240967606, 9684.03159684033, 9691.370060946016, 9704.805903881954, 9430.29272804539, 9448.57481413338, 9528.42829430233, 9591.040895910388, 9600.279979001569, 9446.0, 9560.856587151198, 9621.663241786538, 9725.173360264385, 9733.610655573768, 9616.038396160398, 9690.951545242298, 9711.223102151846, 9724.708258752178, 9737.026297370277, 9569.473678947656, 9695.612175512972, 9704.51477426133, 9705.90294097057, 9707.708768736878, 39801.40297895534, 40091.19817603661, 40201.0, 40207.59792402068, 40249.798751006354, 3242.5946756655417, 3298.307355455357, 3345.481450375196, 3485.6514348565192, 3495.2135769451925, 27780.58329125065, 28095.157145285673, 28096.578551321745, 28520.85739571289, 28639.28401789951, 2713.7693296069856, 2726.1003868723274, 2747.2719729271757, 2863.4130003349264, 2889.393227422244, 476775.0, 481459.0, 481465.0, 481971.9999999965, 482839.0, 66682.0, 66947.0, 67404.3259567398, 67458.0, 67717.66141169262, 71088.64455677792, 71979.56040879257, 72053.63973180206, 72190.91713624299, 72192.0, 16913.98516089014, 17139.828601714074, 17145.314187432614, 17149.57126071858, 17165.82834171667, 13035.674108147183, 13049.869501305055, 13067.803982940264, 13073.280969546766, 13094.934525327313, 21047.368578942656, 21309.0, 21364.038618262217, 21386.78613213879, 21642.783572164393, 9272.860907086264, 9556.426614403159, 9568.808623827485, 9591.568379422943, 9768.706938791705, 791.4380789639421, 935.9859602105973, 941.0665752430988, 1017.9236557258236, 1060.8833028366873, 21641.56716865654, 28474.85762571174, 28643.713562864523, 28691.0, 29429.117126485813, 1056.3556230699267, 1099.2085698297212, 1104.5029736618394, 1167.3812879174052, 1208.9274643521417, 14024.0, 14638.707225855636, 14850.2574871256, 14947.626309342137, 15051.924740376227, 411544.0, 478419.0, 478912.0, 479397.0, 479860.0, 56912.0, 57115.0, 57388.71305643445, 57477.71261143668, 57962.420375796544, 1107.6676996900896, 1354.7222819322014, 1473.9041962272418, 1485.5097817720343, 1514.9318280677396, 23152.958116884445, 27340.0, 28786.992455264804, 29190.854045729637, 29361.85319073391, 46963.765181173876, 47161.52838471571, 47355.28967065566, 47357.52642473531, 47472.0, 345941.0, 348370.0, 349010.0, 349114.0, 349465.0, 32162.0, 33602.327953440305, 33718.49422258619, 33731.325373491905, 33740.49389259212, 44270.0, 44686.3297050551, 45081.0, 45175.09649807051, 46268.768656156506, 36377.0, 36454.8177259112, 36537.81731091328, 37302.0, 37606.24787504289, 36280.772942079246, 36287.64548254226, 36676.0, 36726.63273367232, 37489.81255093707, 35848.4622730654, 36237.0, 36512.452313214795, 37013.0, 37203.813980929925, 31437.0, 32380.83809580937, 32527.674723252465, 32654.0, 32797.50803737898, 24239.0, 24261.27216183517, 24374.87812560926, 24797.87601061983, 24811.50376992486], "unit": "score", "name": "ext.html", "value": 19595.742569619775}, {"lowerIsBetter": false, "replicates": [306.37499501017925, 357.8032082354706, 359.9094742928925, 366.8459247116211, 367.8436664417622, 19164.0, 19486.805131948677, 20224.69662955057, 20510.384688459333, 20539.281125160585, 18822.905885470554, 19512.024398780075, 19954.0, 19965.301214457497, 19967.400977970647, 5724.685142317171, 5874.88250234995, 5928.88142237155, 5938.673372964486, 5941.435563621449, 4162.354835000579, 4337.392765012901, 5826.854328641775, 6176.8455788605415, 6458.644774537399, 6365.713542890558, 6381.489480841522, 6386.201724784402, 6389.393007664287, 6393.136926514931, 6239.906401403982, 6249.937500625004, 6362.840928976766, 6423.967880160616, 6445.742170313182, 3678.5953545110015, 5251.291075704769, 5477.3427188737605, 5481.561475081984, 5514.862128446781, 23188.76811231883, 23697.763022369727, 23863.880680596485, 24282.635760463607, 24285.514289714283, 2061.051916118587, 2182.454386403399, 2483.913063042785, 2942.2203116174232, 2942.3526824098876, 9130.452172869582, 9392.29557783169, 9650.951745241298, 9667.516624168833, 14730.70538589233, 1642.8357164283595, 1709.8119206887231, 1816.6548355812486, 1833.5232839461703, 1875.2780179630804, 94155.63769325522, 99155.0, 100308.0, 102684.0, 102696.99999999926, 11143.275687080313, 11220.887791121984, 11281.435928203557, 11315.20793544444, 11448.885511144948, 13542.661433464242, 13616.387262573207, 13664.0, 13685.24731139777, 13707.520236791665, 8327.375446841512, 8601.22588966996, 8607.69100186739, 8682.30541556674, 8699.565021748887, 7250.0, 8760.167784060504, 8775.297976161892, 8778.209961103532, 8894.911050889537, 4354.085642015212, 4433.224185767478, 4439.844605438794, 4486.080353527519, 4502.0, 1737.7654016707584, 1788.7227479740661, 1789.8031216566167, 1799.34323971752, 1804.5398423402212, 861.8190180062257, 868.3053557154377, 951.0822056715303, 1005.3615953869199, 1080.9189310801564, 15592.376304947675, 18138.727919081226, 19091.85448873072, 19570.80429195718, 19989.0, 923.9214666753267, 928.6239073175375, 962.3888830592624, 973.2311473935512, 1036.2435422141878, 10240.070318079503, 10561.735956601147, 10564.735881603021, 10576.52405641748, 10734.194935379877, 620824.0, 629300.0, 637994.0, 642622.0, 649889.0, 112095.43952280187, 115515.0, 120431.59136817214, 122212.38893805652, 123613.0, 1011.2971484818128, 1041.1774697988656, 1060.4485667453037, 1061.1457776489844, 1061.2253055269696, 17268.74096888573, 17332.133393330536, 17600.73598896043, 17858.642827143125, 17904.731429028314, 43380.0, 45197.54802451933, 46098.76950615225, 47048.529514705784, 50295.74260643513, 64915.67542162259, 65950.01074983976, 65970.0, 65972.68054638784, 66469.66765166144, 7401.8149546261775, 7549.584772837327, 7622.2758837910305, 7711.305982461606, 7865.646045927832, 10892.292001019909, 12132.454039568063, 12185.586340334667, 12359.196652217577, 12428.0, 9695.030496950249, 10249.282550221413, 10332.873783691874, 10599.735006624896, 10799.946000269949, 10362.740931476774, 10364.015418535228, 10585.788284234426, 10655.57377704883, 10732.302400344264, 10441.0, 10547.050765431148, 10679.46602669848, 10903.400312982545, 10933.18001149933, 6345.7144428499905, 7460.66427010775, 7528.397728181622, 7611.3530349920875, 7682.577458239851, 8098.797530061795, 8378.748637540884, 10546.8417973732, 10986.395748233925, 11000.724981875517], "unit": "score", "name": "jquery.html", "value": 9215.480902431198}, {"lowerIsBetter": false, "replicates": [1439.251589173629, 1566.6161790361364, 1604.3502381535475, 1873.9906300468504, 2007.2272175212538, 7941.642626081826, 8626.094260102693, 8778.56107194641, 8784.0, 8785.868211976825, 8300.252977232049, 8529.872051919227, 8550.486970781742, 8562.785930351729, 8570.95714521428, 2121.893905304736, 2373.371056669984, 2391.6771235883107, 2426.4297889995837, 2440.2801173653725, 2405.518896220763, 2410.3974006498374, 2415.758424157579, 2419.2258477287273, 2420.636904464327, 2364.148906393697, 2397.6043952747777, 2414.082648593541, 2416.6979127609047, 2421.0436877433403, 2391.557561851063, 2428.4657375377387, 2431.7081950166007, 2445.8532488050773, 2445.8899349529315, 2387.474755553793, 2390.079819269594, 2394.2218778896754, 2394.4133687246735, 2452.6811514503, 8783.692570759993, 8881.023087460375, 8886.155815197546, 8887.844580204597, 8895.955520222422, 5294.867628309285, 5406.135018397038, 5420.268263784378, 5448.809291674812, 5451.727413629343, 3561.715062794996, 3653.3058718843336, 3700.148965737895, 3714.758540694846, 3736.6076561961145, 828.2462958707607, 1050.1598721023227, 1071.9410432426214, 1074.8387741838708, 1079.3577821196375, 11956.402179891058, 11959.103067269989, 11965.948683085757, 11981.700457488545, 12048.33734144613, 4750.168720473903, 4751.881202969954, 4789.544993225638, 4831.130396528659, 4839.274108883696, 10111.494425278706, 10115.696529104138, 10128.189744820396, 10137.64518241858, 10137.949310253549, 5368.409474957752, 5385.892282154335, 5423.566114710814, 5424.321959755031, 5424.755885985141, 3689.760165589228, 3985.501812273466, 4487.820487180476, 4539.477960034638, 4543.954560454353, 3858.151206734514, 3914.178022615226, 3961.2473630010204, 3964.9801750991637, 3978.900527486836, 1286.0740267007739, 1309.4173092973535, 1312.5734136405706, 1319.4985905356095, 1321.0884489702075, 1368.6167872995577, 1374.3609221711952, 1406.7116241170536, 1409.3657853965756, 1409.4150927365029, 8108.108108108104, 8309.37679674027, 8309.626066826886, 8313.833723325499, 8313.916860831314, 497.64169797745564, 501.4433978284102, 507.8730317420645, 508.9440161582223, 512.3416409913318, 6229.719662615103, 6238.906416403757, 6295.213098362705, 6308.337624549448, 6313.463355614732, 10421.270511064304, 10789.136869050457, 10897.0, 10903.29128606638, 10915.345079295268, 10506.369617822955, 10570.471476426303, 10587.100096491731, 10653.786924261627, 10787.514561844735, 8384.496930184208, 8404.747857564284, 8500.70247541333, 8505.10696376884, 8516.44643098209, 7774.067111946602, 7959.442839001214, 7963.522188668699, 8014.238647328494, 8021.63902624395, 9377.718668439958, 9590.808183836423, 9600.75998100053, 9716.805663886542, 9829.655962041294, 9656.9034309656, 9877.55551000221, 9982.550785214538, 10111.898881011095, 10194.643187488402, 7484.625768711651, 7493.250674932463, 7511.910772937784, 7555.055618047744, 7586.203448637813, 8236.464629799044, 8248.092709802037, 8290.834183316421, 8313.043999940084, 8329.458585191944, 7395.0, 7528.171901090986, 7541.5475071495885, 7646.923530764621, 7677.769666910001, 7324.743633972786, 7384.409247260099, 7409.481336306407, 7427.517211381243, 7563.092428908566, 7805.492642978188, 7841.960790196013, 7911.248431399008, 7912.28789408956, 7913.010873640795, 7003.824904377431, 7103.325184107502, 7125.1093613298335, 7187.2453392393045, 7187.353138217585, 7175.103112110986, 7191.280871912767, 7229.0, 7250.984862119202, 7260.89108663381], "unit": "score", "name": "mootools.html", "value": 4845.167281204846}, {"lowerIsBetter": false, "replicates": [292.7862660258013, 322.2411221573195, 322.6257541252147, 333.26681301137506, 334.47654420831395, 6556.541042127053, 6687.465002799777, 6690.431313338372, 6696.933030669698, 6725.495587830907, 5041.924371134427, 6608.0, 6610.933890661092, 6637.834054148649, 6662.367075127867, 4700.905981880361, 4725.598324142452, 4801.519848015206, 4910.459849416561, 4946.431160416544, 4833.758312084382, 4847.5394837490385, 4849.903001939959, 4850.6362022848425, 4882.731449770261, 4783.521647835223, 4809.196551293265, 4809.831655892044, 4816.470188279304, 4837.443693975185, 4623.884402889955, 4694.95305046952, 4801.087793319276, 4819.51804819517, 4825.20384136617, 4104.0, 4131.049858532554, 4132.690048246363, 4136.937945930814, 4145.191687620915, 6367.681615919186, 6384.648844313561, 6387.616742995435, 6395.744170233185, 6398.744050237985, 5752.395998420189, 5772.567057470665, 5791.333996590404, 5792.565557583198, 5795.565332600072, 7005.54463959841, 7006.824829379255, 7023.648817559101, 7033.050538177383, 7033.577985320897, 4532.660050496226, 4670.509596492388, 4702.412198475191, 4729.716217026989, 4731.266653668687, 7310.52481588695, 7454.776356709307, 7460.104787425489, 7481.476296659236, 7491.9625401872645, 4816.8073277069225, 4822.132016237111, 4824.6863953842885, 4831.710097394168, 4835.709857408567, 4880.341153944243, 4887.315775791392, 4893.73084480357, 4902.852914412573, 4925.9014819704125, 5785.739641716133, 5791.0, 5799.3620701722775, 5808.215890854765, 5823.708814559255, 6756.358145976124, 6764.932350676529, 6880.662878503922, 6990.126234220723, 7099.609521476368, 1690.8647308215313, 1696.550414140254, 1709.5555155659617, 1710.2389436700548, 1715.3395942562204, 1052.578968412641, 1113.4544073403974, 1119.149446420726, 1134.4214450630238, 1147.9827802582968, 6370.267419246753, 6515.348465153542, 6675.599464032173, 6694.0, 6703.463722902254, 7417.406607471389, 7421.332080112816, 7428.0, 7434.0, 7438.5536867788105, 5719.170720245625, 5794.971025144847, 6661.1007513985, 6661.533692641468, 6696.799096027127, 3838.7696738195796, 3892.5134358205223, 3894.668953139015, 3905.5313362396696, 3913.941290880639, 6624.966875165594, 7324.2309557496765, 7694.115176754633, 7730.536167829948, 7749.070111586646, 7580.1661817200065, 7598.582077985653, 7613.771586852404, 7615.314621684075, 7631.580263085472, 6172.969135154385, 7700.0, 7706.0, 7714.997050383414, 7727.227277272115, 7092.787216383516, 7364.484486085923, 7383.852322953619, 7386.187519372972, 7395.223501532261, 7215.927840721735, 7225.24134965842, 7243.818904527429, 7254.16577093641, 7254.455915806441, 7572.507786994048, 7638.770836874903, 7645.273698998586, 7656.081270247606, 7659.348955338859, 3938.232044751246, 4835.178019736723, 4849.005953779396, 4849.684770489906, 4859.125357435695, 7031.40233080194, 7280.490365674564, 7290.781276561712, 7298.124225093023, 7300.780976570712, 6050.45545900871, 6540.084388185753, 6787.389134977876, 7084.114485689289, 7091.964540177266, 6161.599496032743, 6241.500679945502, 6647.268800431852, 7063.434925205868, 7070.929290707027, 6872.931270687429, 6878.933765266392, 6886.345797149263, 6894.896816509335, 6903.723851046103, 5719.542436604978, 6788.694508747217, 6956.234814170539, 7025.789226323219, 7053.470989675898, 6702.329767023259, 6730.899036514554, 6843.315668433117, 6914.274001229798, 6920.688569014305], "unit": "score", "name": "prototype.html", "value": 5164.699242389328}, {"lowerIsBetter": false, "replicates": [648.7502311610028, 694.4722011271434, 736.9778906632799, 759.3583422008401, 764.2892110337384, 14818.703625927503, 14822.96239263252, 14968.85031149691, 15000.174990375539, 15007.624809379771, 13792.172469651829, 14115.223662698572, 14138.929305353484, 14170.929145354285, 14177.362018709156, 710.9537880037794, 722.4220623501204, 737.1412304665059, 884.385352180235, 895.292718752185, 886.6497733395305, 903.5798353765498, 903.6972614174259, 907.2923119966437, 907.4963395315597, 951.3816019587289, 953.9904600954005, 954.7899462118323, 958.2477754962356, 958.4249450329816, 763.9159692433827, 932.1238036245907, 947.5357075033253, 950.7385468996013, 957.1816097236832, 696.6203419136583, 704.1620471638734, 707.695690852933, 709.8544798316333, 710.4032612605437, 14898.925505372405, 14970.401183952628, 14975.176365299903, 14976.700465990729, 14982.550523484313, 12448.377581120907, 12467.064970127187, 12523.0, 12619.495220191182, 12728.936355318257, 9537.2370210383, 9996.0, 10068.244881633833, 10629.5216715248, 10810.567577296899, 3526.6825985661158, 3609.927801443983, 3618.6200448952745, 3627.564692236922, 3633.927321453556, 78570.60714696447, 78809.0, 79209.99999999942, 79424.80862787063, 84846.72729909056, 8989.820203595891, 9202.0, 9350.438973661601, 9354.111359420844, 10203.38779673222, 20023.29918452847, 20290.289839855534, 20323.18707251723, 20345.389638310873, 20355.287564935155, 7496.62516874165, 7503.399728021745, 7677.539347639159, 7769.456138070281, 7898.328642065489, 4113.218488487238, 4136.379543068504, 4172.70791044624, 4180.393842892824, 4247.086876321606, 3361.0, 3405.216800135983, 3428.280061187129, 3436.106612280825, 3437.3297207044884, 622.0762168180248, 627.2222444169197, 628.7830698409042, 635.6916895305773, 647.4949539359308, 521.8877941242652, 578.5949835115437, 597.1967703438954, 606.7209083821404, 614.1064750787593, 8060.39547033963, 8062.516249025077, 8108.594570271581, 8196.8360632787, 8306.08633050364, 573.6013470637866, 584.7251791657914, 588.5056552495925, 598.2163365990566, 610.1793088296234, 3687.9815600921825, 3757.0, 3770.245950809849, 3852.3451013327804, 3863.36254518007, 94061.0, 95793.52103239439, 97313.51343243239, 97328.51335743276, 97544.56138596592, 82618.58690706508, 83905.58047209725, 84174.0, 85045.0, 85146.0, 68504.3149568508, 69349.30650693428, 69817.30182698109, 71772.0, 73315.0, 7589.886151707618, 7943.285104340637, 8210.876836847332, 8213.671453141807, 8514.910834707176, 45360.546394536956, 46467.0, 47237.81905452254, 47256.52743472521, 47372.289415659485, 62636.68681656563, 63290.41773955688, 63414.0, 63416.68291658512, 64845.0, 10969.616063437741, 10981.945090274818, 11026.669199924016, 11097.778044438905, 11345.262557933707, 11955.222910510789, 12054.939725301318, 12227.87772122303, 12322.445489953154, 12583.685407864876, 11364.566182707245, 11448.255863368855, 11571.016463600688, 11758.88241117612, 12451.190672606252, 10938.386926516287, 11028.849875450263, 11093.667189984313, 11215.495302711235, 11287.430518199579, 11091.168162388014, 11180.608678696206, 11305.208635395444, 11632.88367116318, 12024.624417716315, 9542.284328675516, 9635.518224088908, 9648.75878103053, 9785.510724463606, 10380.083352489311, 8039.261509698509, 8776.91223087761, 9099.317551183556, 9304.674336398193, 9857.901420985698], "unit": "score", "name": "yui.html", "value": 6859.192161072737}], "name": "dromaeo_css", "value": 7460.29779143689}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 110.0, 111.0, 112.0, 116.0, 112.0, 109.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [176.0, 144.0, 171.0, 166.0, 117.0, 143.0, 139.0, 115.0, 159.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [185.0, 182.0, 183.0, 184.0, 184.0, 184.0, 186.0, 184.0, 181.0, 179.0], "unit": "score", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 81.0, 76.0, 55.0, 68.0, 57.0, 77.0, 75.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.2}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 131.0, 81.0, 79.0, 90.0, 113.0, 77.0, 80.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 95.2}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 86.0, 87.0, 85.0, 89.0, 85.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.5}, {"lowerIsBetter": true, "replicates": [116.0, 93.0, 93.0, 94.0, 108.0, 150.0, 93.0, 94.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 102.6}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 86.0, 94.0, 104.0, 85.0, 83.0, 85.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 88.3}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 53.0, 55.0, 55.0, 53.0, 63.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [63.0, 71.0, 65.0, 72.0, 71.0, 66.0, 66.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 84.0, 82.0, 82.0, 79.0, 83.0, 85.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [128.0, 118.0, 140.0, 136.0, 120.0, 123.0, 124.0, 134.0, 115.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [138.0, 139.0, 139.0, 134.0, 137.0, 125.0, 140.0, 136.0, 168.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 69.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1418.4}]} 01:20:48 INFO - Return code: 0 01:20:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:20:48 ERROR - # TBPL SUCCESS # 01:20:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:20:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:20:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:20:48 INFO - 2016-03-18 01:20:48.667 screenresolution[1678:9602] starting screenresolution argv=screenresolution get 01:20:48 INFO - 2016-03-18 01:20:48.670 screenresolution[1678:9602] Display 0: 1600x1200x32@60 01:20:48 INFO - 2016-03-18 01:20:48.676 screenresolution[1679:9605] starting screenresolution argv=screenresolution list 01:20:48 INFO - Available Modes on Display 0 01:20:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:20:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:20:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:20:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:20:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:20:48 INFO - Intel Iris: 01:20:48 INFO - Chipset Model: Intel Iris 01:20:48 INFO - Type: GPU 01:20:48 INFO - Bus: Built-In 01:20:48 INFO - VRAM (Dynamic, Max): 1536 MB 01:20:48 INFO - Vendor: Intel (0x8086) 01:20:48 INFO - Device ID: 0x0a2e 01:20:48 INFO - Revision ID: 0x0009 01:20:48 INFO - Displays: 01:20:48 INFO - Display: 01:20:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:20:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:20:48 INFO - Display Serial Number: 1600x1200 60 01:20:48 INFO - Main Display: Yes 01:20:48 INFO - Mirror: Off 01:20:48 INFO - Online: Yes 01:20:48 INFO - Rotation: Supported 01:20:48 INFO - Return code: 0 01:20:48 INFO - Running post-action listener: _resource_record_post_action 01:20:48 INFO - Running post-run listener: _resource_record_post_run 01:20:49 INFO - Total resource usage - Wall time: 1206s; CPU: 52.0%; Read bytes: 40977920; Write bytes: 710044160; Read time: 463; Write time: 2220 01:20:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395696640; Write bytes: 389580288; Read time: 29986; Write time: 683 01:20:49 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 39147008; Write bytes: 305292288; Read time: 442; Write time: 1497 01:20:49 INFO - Running post-run listener: _upload_blobber_files 01:20:49 INFO - Blob upload gear active. 01:20:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:20:49 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 01:20:49 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'] 01:20:49 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 01:20:50 INFO - (blobuploader) - INFO - Open directory for files ... 01:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:52 INFO - (blobuploader) - INFO - Done attempting. 01:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:20:53 INFO - (blobuploader) - INFO - Done attempting. 01:20:53 INFO - (blobuploader) - INFO - Iteration through files over. 01:20:53 INFO - Return code: 0 01:20:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:20:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:20:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/550ccfc63374582d00171e4f1fc98a2367a08dd44da324307aec7ac67c23389a7f2e45b3990980c0ae33ee130a8f9dee55a238dc162da82ff20e79ea66d06b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc60bb7917d144b7b45a2731e400d341f757bcbc37dc4bcc6e8432cb9ce28d4902392f331b5367bbfceb403083f05ccf5ab6e562f59a4e8c7a89b0d3641af69"} 01:20:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:20:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:20:53 INFO - Contents: 01:20:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/550ccfc63374582d00171e4f1fc98a2367a08dd44da324307aec7ac67c23389a7f2e45b3990980c0ae33ee130a8f9dee55a238dc162da82ff20e79ea66d06b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc60bb7917d144b7b45a2731e400d341f757bcbc37dc4bcc6e8432cb9ce28d4902392f331b5367bbfceb403083f05ccf5ab6e562f59a4e8c7a89b0d3641af69"} 01:20:53 INFO - Running post-run listener: copy_logs_to_upload_dir 01:20:53 INFO - Copying logs to upload dir... 01:20:53 INFO - mkdir: /builds/slave/test/build/upload/logs 01:20:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.039450 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-18 01:20:53.256405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 01:20:53.261288) ========= 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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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/550ccfc63374582d00171e4f1fc98a2367a08dd44da324307aec7ac67c23389a7f2e45b3990980c0ae33ee130a8f9dee55a238dc162da82ff20e79ea66d06b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc60bb7917d144b7b45a2731e400d341f757bcbc37dc4bcc6e8432cb9ce28d4902392f331b5367bbfceb403083f05ccf5ab6e562f59a4e8c7a89b0d3641af69"} build_url:https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/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/550ccfc63374582d00171e4f1fc98a2367a08dd44da324307aec7ac67c23389a7f2e45b3990980c0ae33ee130a8f9dee55a238dc162da82ff20e79ea66d06b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfc60bb7917d144b7b45a2731e400d341f757bcbc37dc4bcc6e8432cb9ce28d4902392f331b5367bbfceb403083f05ccf5ab6e562f59a4e8c7a89b0d3641af69"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 01:20:53.289673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:20:53.293029) ========= 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.BfyI35DCVd/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.j6eyOP4wdE/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005233 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:20:53.341771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 01:20:53.345122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 01:20:53.345535) ========= ========= Total master_lag: 1.17 =========