builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0018 starttime: 1457562275.35 results: success (0) buildid: 20160309121625 builduid: 7481ff3522a7431e9a7939eb77c8aaa8 revision: 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.349928) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.350387) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.350696) ========= 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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005515 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.374774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.375110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.392520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.393037) ========= 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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005491 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.441772) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.442113) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.442476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.442760) ========= 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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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-09 14:24:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2016-03-09 14:24:35 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.626629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.630001) ========= 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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.026328 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.678667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:35.682058) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f --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 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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-09 14:24:35,759 truncating revision to first 12 chars 2016-03-09 14:24:35,760 Setting DEBUG logging. 2016-03-09 14:24:35,760 attempt 1/10 2016-03-09 14:24:35,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2c9d4c7e3d2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 14:24:36,420 unpacking tar archive at: fx-team-2c9d4c7e3d2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:36.596437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:36.596785) ========= echo 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f program finished with exit code 0 elapsedTime=0.005363 script_repo_revision: '2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:36.652703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:36.653047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 14:24:36.668091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-09 14:24:36.668428) ========= /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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:24:36 INFO - MultiFileLogger online at 20160309 14:24:36 in /builds/slave/test 14:24:36 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 14:24:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:24:36 INFO - {'append_to_log': False, 14:24:36 INFO - 'base_work_dir': '/builds/slave/test', 14:24:36 INFO - 'blob_upload_branch': 'Fx-Team', 14:24:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:24:36 INFO - 'branch': 'Fx-Team', 14:24:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:24:36 INFO - 'config_files': ('talos/mac_config.py',), 14:24:36 INFO - 'default_actions': ('clobber', 14:24:36 INFO - 'read-buildbot-config', 14:24:36 INFO - 'download-and-extract', 14:24:36 INFO - 'populate-webroot', 14:24:36 INFO - 'create-virtualenv', 14:24:36 INFO - 'install', 14:24:36 INFO - 'run-tests'), 14:24:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:24:36 INFO - 'download_minidump_stackwalk': True, 14:24:36 INFO - 'download_symbols': 'ondemand', 14:24:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:24:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:24:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:24:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:24:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:24:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:24:36 INFO - 'installer_path': 'installer.exe', 14:24:36 INFO - 'log_level': 'info', 14:24:36 INFO - 'log_name': 'talos', 14:24:36 INFO - 'log_to_console': True, 14:24:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:24:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:24:36 INFO - 'opt_config_files': (), 14:24:36 INFO - 'pip_index': False, 14:24:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:24:36 INFO - 'cmd': ('bash', 14:24:36 INFO - '-c', 14:24:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:24:36 INFO - 'enabled': True, 14:24:36 INFO - 'halt_on_failure': False, 14:24:36 INFO - 'name': 'check_screen_resolution'},), 14:24:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:24:36 INFO - 'cmd': ('bash', 14:24:36 INFO - '-c', 14:24:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:24:36 INFO - 'enabled': True, 14:24:36 INFO - 'halt_on_failure': False, 14:24:36 INFO - 'name': 'check_screen_resolution'},), 14:24:36 INFO - 'run_cmd_checks_enabled': True, 14:24:36 INFO - 'sps_profile': False, 14:24:36 INFO - 'sps_profile_interval': 0, 14:24:36 INFO - 'suite': 'dromaeojs', 14:24:36 INFO - 'system_bits': '32', 14:24:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:24:36 INFO - 'title': 't-yosemite-r7-0018', 14:24:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:24:36 INFO - 'use_talos_json': True, 14:24:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:24:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:24:36 INFO - 'work_dir': 'build'} 14:24:36 INFO - ##### 14:24:36 INFO - ##### Running clobber step. 14:24:36 INFO - ##### 14:24:36 INFO - Running pre-action listener: _resource_record_pre_action 14:24:36 INFO - Running main action method: clobber 14:24:36 INFO - rmtree: /builds/slave/test/build 14:24:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:24:38 INFO - Running post-action listener: _resource_record_post_action 14:24:38 INFO - ##### 14:24:38 INFO - ##### Running read-buildbot-config step. 14:24:38 INFO - ##### 14:24:38 INFO - Running pre-action listener: _resource_record_pre_action 14:24:38 INFO - Running main action method: read_buildbot_config 14:24:38 INFO - Using buildbot properties: 14:24:38 INFO - { 14:24:38 INFO - "project": "", 14:24:38 INFO - "product": "firefox", 14:24:38 INFO - "script_repo_revision": "production", 14:24:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:24:38 INFO - "repository": "", 14:24:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:24:38 INFO - "buildid": "20160309121625", 14:24:38 INFO - "pgo_build": "False", 14:24:38 INFO - "basedir": "/builds/slave/test", 14:24:38 INFO - "buildnumber": 476, 14:24:38 INFO - "slavename": "t-yosemite-r7-0018", 14:24:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:24:38 INFO - "platform": "yosemite_r7", 14:24:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:24:38 INFO - "branch": "fx-team", 14:24:38 INFO - "repo_path": "integration/fx-team", 14:24:38 INFO - "revision": "2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f", 14:24:38 INFO - "stage_platform": "macosx64", 14:24:38 INFO - "builduid": "7481ff3522a7431e9a7939eb77c8aaa8", 14:24:38 INFO - "slavebuilddir": "test" 14:24:38 INFO - } 14:24:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:24:38 INFO - Running post-action listener: _resource_record_post_action 14:24:38 INFO - ##### 14:24:38 INFO - ##### Running download-and-extract step. 14:24:38 INFO - ##### 14:24:38 INFO - Running pre-action listener: _resource_record_pre_action 14:24:38 INFO - Running main action method: download_and_extract 14:24:38 INFO - mkdir: /builds/slave/test/build/tests 14:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:38 INFO - https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:39 INFO - Downloaded 1199 bytes. 14:24:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:24:39 INFO - Using the following test package requirements: 14:24:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:24:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:24:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:24:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'jsshell-mac.zip'], 14:24:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:24:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:24:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:24:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:24:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:24:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:24:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:24:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:39 INFO - https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:40 INFO - Downloaded 17866285 bytes. 14:24:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:24:43 INFO - Return code: 0 14:24:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:43 INFO - https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:44 INFO - Downloaded 17866285 bytes. 14:24:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:24:48 INFO - Return code: 0 14:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:48 INFO - https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:49 INFO - Downloaded 10845161 bytes. 14:24:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:24:50 INFO - Return code: 0 14:24:50 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')]} 14:24:50 INFO - https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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 14:24:53 INFO - Downloaded 110928026 bytes. 14:24:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:24:53 INFO - mkdir: /builds/slave/test/properties 14:24:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:53 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:53 INFO - Contents: 14:24:53 INFO - build_url:https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:24:54 INFO - Running post-action listener: _resource_record_post_action 14:24:54 INFO - Running post-action listener: set_extra_try_arguments 14:24:54 INFO - ##### 14:24:54 INFO - ##### Running populate-webroot step. 14:24:54 INFO - ##### 14:24:54 INFO - Running pre-action listener: _resource_record_pre_action 14:24:54 INFO - Running main action method: populate_webroot 14:24:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:54 INFO - '--tppagecycles', 14:24:54 INFO - '7'], 14:24:54 INFO - 'tests': ['tsvgm']}}, 14:24:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:24:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:24:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'tests': ['damp', 'tps']}, 14:24:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['damp', 'tps']}, 14:24:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:24:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:54 INFO - 'other': {'tests': ['a11yr', 14:24:54 INFO - 'ts_paint', 14:24:54 INFO - 'tpaint', 14:24:54 INFO - 'sessionrestore', 14:24:54 INFO - 'sessionrestore_no_auto_restore', 14:24:54 INFO - 'tabpaint']}, 14:24:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['a11yr', 14:24:54 INFO - 'ts_paint', 14:24:54 INFO - 'tpaint', 14:24:54 INFO - 'sessionrestore', 14:24:54 INFO - 'sessionrestore_no_auto_restore', 14:24:54 INFO - 'tabpaint']}, 14:24:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['a11yr', 14:24:54 INFO - 'ts_paint', 14:24:54 INFO - 'tpaint', 14:24:54 INFO - 'sessionrestore', 14:24:54 INFO - 'sessionrestore_no_auto_restore', 14:24:54 INFO - 'tabpaint']}, 14:24:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['a11yr', 14:24:54 INFO - 'ts_paint', 14:24:54 INFO - 'tpaint', 14:24:54 INFO - 'sessionrestore', 14:24:54 INFO - 'sessionrestore_no_auto_restore', 14:24:54 INFO - 'tabpaint']}, 14:24:54 INFO - 'other_l64': {'tests': ['a11yr', 14:24:54 INFO - 'ts_paint', 14:24:54 INFO - 'tpaint', 14:24:54 INFO - 'sessionrestore', 14:24:54 INFO - 'sessionrestore_no_auto_restore', 14:24:54 INFO - 'tabpaint']}, 14:24:54 INFO - 'other_nol64': {'tests': ['a11yr', 14:24:54 INFO - 'ts_paint', 14:24:54 INFO - 'tpaint', 14:24:54 INFO - 'sessionrestore', 14:24:54 INFO - 'sessionrestore_no_auto_restore', 14:24:54 INFO - 'tabpaint']}, 14:24:54 INFO - 'svgr': {'tests': ['tsvgx', 14:24:54 INFO - 'tsvgr_opacity', 14:24:54 INFO - 'tart', 14:24:54 INFO - 'tscrollx', 14:24:54 INFO - 'cart']}, 14:24:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['tsvgx', 14:24:54 INFO - 'tsvgr_opacity', 14:24:54 INFO - 'tart', 14:24:54 INFO - 'tscrollx', 14:24:54 INFO - 'cart']}, 14:24:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'tests': ['tp5o']}, 14:24:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'talos_options': ['--e10s'], 14:24:54 INFO - 'tests': ['tp5o']}, 14:24:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'talos_options': ['--xperf_path', 14:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:54 INFO - 'tests': ['tp5n']}, 14:24:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:24:54 INFO - 'talos_options': ['--e10s', 14:24:54 INFO - '--xperf_path', 14:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:54 INFO - 'tests': ['tp5n']}}, 14:24:54 INFO - 'talos.zip': {'path': '', 14:24:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:54 INFO - Running post-action listener: _resource_record_post_action 14:24:54 INFO - ##### 14:24:54 INFO - ##### Running create-virtualenv step. 14:24:54 INFO - ##### 14:24:54 INFO - Running pre-action listener: _resource_record_pre_action 14:24:54 INFO - Running main action method: create_virtualenv 14:24:54 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:54 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 14:24:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:54 INFO - Using real prefix '/tools/python27' 14:24:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:58 INFO - Installing pip.................done. 14:24:58 INFO - Return code: 0 14:24:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:24:58 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 14:24:58 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 14:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:58 INFO - 'HOME': '/Users/cltbld', 14:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:58 INFO - 'LOGNAME': 'cltbld', 14:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:58 INFO - 'MOZ_NO_REMOTE': '1', 14:24:58 INFO - 'NO_EM_RESTART': '1', 14:24:58 INFO - 'PAGER': '/bin/cat', 14:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:58 INFO - 'PWD': '/builds/slave/test', 14:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:58 INFO - 'SHELL': '/bin/bash', 14:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:24:58 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:58 INFO - 'USER': 'cltbld', 14:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:58 INFO - 'XPC_FLAGS': '0x0', 14:24:58 INFO - 'XPC_SERVICE_NAME': '0', 14:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 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 14:24:58 INFO - Cleaning up... 14:24:58 INFO - Return code: 0 14:24:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:58 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:24:58 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 14:24:58 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 14:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:58 INFO - 'HOME': '/Users/cltbld', 14:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:58 INFO - 'LOGNAME': 'cltbld', 14:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:58 INFO - 'MOZ_NO_REMOTE': '1', 14:24:58 INFO - 'NO_EM_RESTART': '1', 14:24:58 INFO - 'PAGER': '/bin/cat', 14:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:58 INFO - 'PWD': '/builds/slave/test', 14:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:58 INFO - 'SHELL': '/bin/bash', 14:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:24:58 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:58 INFO - 'USER': 'cltbld', 14:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:58 INFO - 'XPC_FLAGS': '0x0', 14:24:58 INFO - 'XPC_SERVICE_NAME': '0', 14:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:58 INFO - Downloading/unpacking psutil>=0.7.1 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:25:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:01 INFO - Installing collected packages: psutil 14:25:01 INFO - Running setup.py install for psutil 14:25:01 INFO - building 'psutil._psutil_osx' extension 14:25:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:25:02 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 14:25:02 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 14:25:02 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 14:25:02 INFO - building 'psutil._psutil_posix' extension 14:25:02 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 14:25:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:25:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:25:02 INFO - ^ 14:25:02 INFO - 1 warning generated. 14:25:02 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 14:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:02 INFO - Successfully installed psutil 14:25:02 INFO - Cleaning up... 14:25:02 INFO - Return code: 0 14:25:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:25: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')]} 14:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25: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')]} 14:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:02 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:02 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 14:25:02 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 14:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:02 INFO - 'HOME': '/Users/cltbld', 14:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:02 INFO - 'LOGNAME': 'cltbld', 14:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:02 INFO - 'MOZ_NO_REMOTE': '1', 14:25:02 INFO - 'NO_EM_RESTART': '1', 14:25:02 INFO - 'PAGER': '/bin/cat', 14:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:02 INFO - 'PWD': '/builds/slave/test', 14:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:02 INFO - 'SHELL': '/bin/bash', 14:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:02 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:02 INFO - 'USER': 'cltbld', 14:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:02 INFO - 'XPC_FLAGS': '0x0', 14:25:02 INFO - 'XPC_SERVICE_NAME': '0', 14:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:25:03 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 14:25:03 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 14:25:03 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 14:25:03 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 14:25:03 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 14:25:03 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 14:25:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:25:05 INFO - Installing collected packages: mozsystemmonitor 14:25:05 INFO - Running setup.py install for mozsystemmonitor 14:25:05 INFO - Successfully installed mozsystemmonitor 14:25:05 INFO - Cleaning up... 14:25:05 INFO - Return code: 0 14:25:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:25:05 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')]} 14:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:05 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')]} 14:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:05 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:05 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 14:25:05 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 14:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:05 INFO - 'HOME': '/Users/cltbld', 14:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:05 INFO - 'LOGNAME': 'cltbld', 14:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:05 INFO - 'MOZ_NO_REMOTE': '1', 14:25:05 INFO - 'NO_EM_RESTART': '1', 14:25:05 INFO - 'PAGER': '/bin/cat', 14:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:05 INFO - 'PWD': '/builds/slave/test', 14:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:05 INFO - 'SHELL': '/bin/bash', 14:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:05 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:05 INFO - 'USER': 'cltbld', 14:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:05 INFO - 'XPC_FLAGS': '0x0', 14:25:05 INFO - 'XPC_SERVICE_NAME': '0', 14:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:25:06 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 14:25:06 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 14:25:06 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 14:25:06 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 14:25:06 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 14:25:06 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 14:25:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:25:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:25:08 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 14:25:08 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 14:25:08 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 14:25:08 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 14:25:08 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 14:25:08 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 14:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:25:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:25:09 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 14:25:09 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 14:25:09 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 14:25:09 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 14:25:09 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 14:25:09 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 14:25:09 INFO - Downloading docopt-0.6.1.tar.gz 14:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:25:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:25:09 INFO - Running setup.py install for blobuploader 14:25:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:25:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:25:09 INFO - Running setup.py install for requests 14:25:10 INFO - Running setup.py install for docopt 14:25:10 INFO - Successfully installed blobuploader requests docopt 14:25:10 INFO - Cleaning up... 14:25:10 INFO - Return code: 0 14:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:10 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:10 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 14:25:10 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 14:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:10 INFO - 'HOME': '/Users/cltbld', 14:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:10 INFO - 'LOGNAME': 'cltbld', 14:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:10 INFO - 'MOZ_NO_REMOTE': '1', 14:25:10 INFO - 'NO_EM_RESTART': '1', 14:25:10 INFO - 'PAGER': '/bin/cat', 14:25:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:10 INFO - 'PWD': '/builds/slave/test', 14:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:10 INFO - 'SHELL': '/bin/bash', 14:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:10 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:10 INFO - 'USER': 'cltbld', 14:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:10 INFO - 'XPC_FLAGS': '0x0', 14:25:10 INFO - 'XPC_SERVICE_NAME': '0', 14:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:25:10 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-ubFSVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:25:10 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-o5RIFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:25:10 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-4tLF3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-ej7VmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-GIwHRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-lNmZD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-PSW9nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-A8cEx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-o8KvrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-kmq88M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-5h1CjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LdtsxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:25:11 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-SM89Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:25:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-iMuQfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-9stKxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:25:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-oyisia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:25:12 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-2RDgvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:25:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:25:12 INFO - Running setup.py install for manifestparser 14:25:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:25:12 INFO - Running setup.py install for mozcrash 14:25:12 INFO - Running setup.py install for mozdebug 14:25:12 INFO - Running setup.py install for mozdevice 14:25:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Running setup.py install for mozfile 14:25:13 INFO - Running setup.py install for mozhttpd 14:25:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Running setup.py install for mozinfo 14:25:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Running setup.py install for mozInstall 14:25:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Running setup.py install for mozleak 14:25:13 INFO - Running setup.py install for mozlog 14:25:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:25:13 INFO - Running setup.py install for moznetwork 14:25:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:25:14 INFO - Running setup.py install for mozprocess 14:25:14 INFO - Running setup.py install for mozprofile 14:25:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:25:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:25:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:25:14 INFO - Running setup.py install for mozrunner 14:25:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:25:14 INFO - Running setup.py install for mozscreenshot 14:25:14 INFO - Running setup.py install for moztest 14:25:14 INFO - Running setup.py install for mozversion 14:25:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:25:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:25:15 INFO - Cleaning up... 14:25:15 INFO - Return code: 0 14:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:15 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:15 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 14:25:15 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 14:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:15 INFO - 'HOME': '/Users/cltbld', 14:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:15 INFO - 'LOGNAME': 'cltbld', 14:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:15 INFO - 'MOZ_NO_REMOTE': '1', 14:25:15 INFO - 'NO_EM_RESTART': '1', 14:25:15 INFO - 'PAGER': '/bin/cat', 14:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:15 INFO - 'PWD': '/builds/slave/test', 14:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:15 INFO - 'SHELL': '/bin/bash', 14:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:15 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:15 INFO - 'USER': 'cltbld', 14:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:15 INFO - 'XPC_FLAGS': '0x0', 14:25:15 INFO - 'XPC_SERVICE_NAME': '0', 14:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-h7p0dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:25:15 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)) 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-D3LCLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:25:15 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)) 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-OpQ9Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:25:15 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)) 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-R5d9jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:25:15 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)) 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-8nj9Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:25:15 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)) 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Iv5utq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:25:15 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)) 14:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:25:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-kSvGWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-XUCWud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-R6LuM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-srgRRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-oLbQEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Ao2SnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-onyt6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LhFH7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Fch4HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:16 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)) 14:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:25:16 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-jsuUEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:25:17 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)) 14:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:25:17 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LiwZV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:25:17 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)) 14:25:17 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)) 14:25:17 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)) 14:25:17 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)) 14:25:17 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)) 14:25:17 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)) 14:25:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:25:17 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 14:25:17 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 14:25:17 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 14:25:17 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 14:25:17 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 14:25:17 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 14:25:19 INFO - Downloading blessings-1.6.tar.gz 14:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:25:19 INFO - Installing collected packages: blessings 14:25:19 INFO - Running setup.py install for blessings 14:25:19 INFO - Successfully installed blessings 14:25:19 INFO - Cleaning up... 14:25:19 INFO - Return code: 0 14:25:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:20 INFO - Reading from file tmpfile_stdout 14:25:20 INFO - Current package versions: 14:25:20 INFO - blessings == 1.6 14:25:20 INFO - blobuploader == 1.2.4 14:25:20 INFO - docopt == 0.6.1 14:25:20 INFO - manifestparser == 1.1 14:25:20 INFO - mozInstall == 1.12 14:25:20 INFO - mozcrash == 0.17 14:25:20 INFO - mozdebug == 0.1 14:25:20 INFO - mozdevice == 0.48 14:25:20 INFO - mozfile == 1.2 14:25:20 INFO - mozhttpd == 0.7 14:25:20 INFO - mozinfo == 0.9 14:25:20 INFO - mozleak == 0.1 14:25:20 INFO - mozlog == 3.1 14:25:20 INFO - moznetwork == 0.27 14:25:20 INFO - mozprocess == 0.22 14:25:20 INFO - mozprofile == 0.28 14:25:20 INFO - mozrunner == 6.11 14:25:20 INFO - mozscreenshot == 0.1 14:25:20 INFO - mozsystemmonitor == 0.0 14:25:20 INFO - moztest == 0.7 14:25:20 INFO - mozversion == 1.4 14:25:20 INFO - psutil == 3.1.1 14:25:20 INFO - requests == 1.2.3 14:25:20 INFO - wsgiref == 0.1.2 14:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:20 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 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:20 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 14:25:20 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 14:25:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:20 INFO - 'HOME': '/Users/cltbld', 14:25:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:20 INFO - 'LOGNAME': 'cltbld', 14:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:20 INFO - 'MOZ_NO_REMOTE': '1', 14:25:20 INFO - 'NO_EM_RESTART': '1', 14:25:20 INFO - 'PAGER': '/bin/cat', 14:25:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:20 INFO - 'PWD': '/builds/slave/test', 14:25:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:20 INFO - 'SHELL': '/bin/bash', 14:25:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:20 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:20 INFO - 'USER': 'cltbld', 14:25:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:20 INFO - 'XPC_FLAGS': '0x0', 14:25:20 INFO - 'XPC_SERVICE_NAME': '0', 14:25:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 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)) 14:25:20 INFO - Cleaning up... 14:25:20 INFO - Return code: 0 14:25:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:25:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:20 INFO - 'HOME': '/Users/cltbld', 14:25:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:20 INFO - 'LOGNAME': 'cltbld', 14:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:20 INFO - 'MOZ_NO_REMOTE': '1', 14:25:20 INFO - 'NO_EM_RESTART': '1', 14:25:20 INFO - 'PAGER': '/bin/cat', 14:25:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:20 INFO - 'PWD': '/builds/slave/test', 14:25:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:20 INFO - 'SHELL': '/bin/bash', 14:25:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:20 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:20 INFO - 'USER': 'cltbld', 14:25:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:20 INFO - 'XPC_FLAGS': '0x0', 14:25:20 INFO - 'XPC_SERVICE_NAME': '0', 14:25:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:20 INFO - Downloading/unpacking jsonschema 14:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:25:23 INFO - Downloading/unpacking functools32 (from jsonschema) 14:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:23 INFO - Downloading functools32-3.2.3-2.tar.gz 14:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:25:23 INFO - warning: no files found matching '*.txt' 14:25:23 INFO - no previously-included directories found matching 'build' 14:25:23 INFO - no previously-included directories found matching 'dist' 14:25:23 INFO - no previously-included directories found matching '.git*' 14:25:23 INFO - Installing collected packages: jsonschema, functools32 14:25:23 INFO - Running setup.py install for functools32 14:25:23 INFO - warning: no files found matching '*.txt' 14:25:23 INFO - no previously-included directories found matching 'build' 14:25:23 INFO - no previously-included directories found matching 'dist' 14:25:23 INFO - no previously-included directories found matching '.git*' 14:25:23 INFO - Successfully installed jsonschema functools32 14:25:23 INFO - Cleaning up... 14:25:23 INFO - Return code: 0 14:25:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109c8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c934c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf88cbe570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, '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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 14:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:23 INFO - 'HOME': '/Users/cltbld', 14:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:23 INFO - 'LOGNAME': 'cltbld', 14:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:23 INFO - 'MOZ_NO_REMOTE': '1', 14:25:23 INFO - 'NO_EM_RESTART': '1', 14:25:23 INFO - 'PAGER': '/bin/cat', 14:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:23 INFO - 'PWD': '/builds/slave/test', 14:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:23 INFO - 'SHELL': '/bin/bash', 14:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:25:23 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:23 INFO - 'USER': 'cltbld', 14:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:23 INFO - 'XPC_FLAGS': '0x0', 14:25:23 INFO - 'XPC_SERVICE_NAME': '0', 14:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:24 INFO - Downloading/unpacking flake8 14:25:24 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 14:25:24 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 14:25:24 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 14:25:24 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 14:25:24 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 14:25:24 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 14:25:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:25:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:25:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:25:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:25:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:25:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:25:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:25:27 INFO - no previously-included directories found matching 'docs/_build' 14:25:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:25:27 INFO - Running setup.py install for pep8 14:25:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:25:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:25:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:25:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:25:27 INFO - no previously-included directories found matching 'docs/_build' 14:25:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:25:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:25:27 INFO - Cleaning up... 14:25:27 INFO - Return code: 0 14:25:27 INFO - Running post-action listener: _resource_record_post_action 14:25:27 INFO - Running post-action listener: _start_resource_monitoring 14:25:27 INFO - Starting resource monitoring. 14:25:27 INFO - ##### 14:25:27 INFO - ##### Running install step. 14:25:27 INFO - ##### 14:25:27 INFO - Running pre-action listener: _resource_record_pre_action 14:25:27 INFO - Running main action method: install 14:25:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:28 INFO - Reading from file tmpfile_stdout 14:25:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:25:28 INFO - Reading from file tmpfile_stdout 14:25:28 INFO - Output received: 14:25:28 INFO - Usage: mozinstall [options] installer 14:25:28 INFO - Options: 14:25:28 INFO - -h, --help show this help message and exit 14:25:28 INFO - -d DEST, --destination=DEST 14:25:28 INFO - Directory to install application into. [default: 14:25:28 INFO - "/builds/slave/test"] 14:25:28 INFO - --app=APP Application being installed. [default: firefox] 14:25:28 INFO - mkdir: /builds/slave/test/build/application 14:25:28 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'] 14:25:28 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 14:26:02 INFO - Reading from file tmpfile_stdout 14:26:02 INFO - Output received: 14:26:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:26:02 INFO - Running post-action listener: _resource_record_post_action 14:26:02 INFO - ##### 14:26:02 INFO - ##### Running run-tests step. 14:26:02 INFO - ##### 14:26:02 INFO - Running pre-action listener: _resource_record_pre_action 14:26:02 INFO - Running main action method: run_tests 14:26:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:26:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:26:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:26:02 INFO - 2016-03-09 14:26:02.087 screenresolution[1642:7523] starting screenresolution argv=screenresolution get 14:26:02 INFO - 2016-03-09 14:26:02.090 screenresolution[1642:7523] Display 0: 1600x1200x32@60 14:26:02 INFO - 2016-03-09 14:26:02.096 screenresolution[1643:7525] starting screenresolution argv=screenresolution list 14:26:02 INFO - Available Modes on Display 0 14:26:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:26:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:26:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:26:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:26:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:26:02 INFO - Intel Iris: 14:26:02 INFO - Chipset Model: Intel Iris 14:26:02 INFO - Type: GPU 14:26:02 INFO - Bus: Built-In 14:26:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:26:02 INFO - Vendor: Intel (0x8086) 14:26:02 INFO - Device ID: 0x0a2e 14:26:02 INFO - Revision ID: 0x0009 14:26:02 INFO - Displays: 14:26:02 INFO - Display: 14:26:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:26:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:26:02 INFO - Display Serial Number: 1600x1200 60 14:26:02 INFO - Main Display: Yes 14:26:02 INFO - Mirror: Off 14:26:02 INFO - Online: Yes 14:26:02 INFO - Rotation: Supported 14:26:02 INFO - Return code: 0 14:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:26:02 INFO - Python 2.7.3 14:26:02 INFO - Return code: 0 14:26:02 INFO - grabbing minidump binary from tooltool 14:26: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')]} 14:26:02 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 0x109b2fd30>, '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 0x109953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109b26b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:26:02 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 14:26:02 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 14:26:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:26:02 INFO - Return code: 0 14:26:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:26:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:26:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:26:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:26:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:26:03 INFO - Return code: 0 14:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 14:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 14:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOHQ9Kwrs4/Render', 14:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:03 INFO - 'HOME': '/Users/cltbld', 14:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:03 INFO - 'LOGNAME': 'cltbld', 14:26:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:26:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:03 INFO - 'MOZ_NO_REMOTE': '1', 14:26:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:26:03 INFO - 'NO_EM_RESTART': '1', 14:26:03 INFO - 'PAGER': '/bin/cat', 14:26:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:03 INFO - 'PWD': '/builds/slave/test', 14:26:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:03 INFO - 'SHELL': '/bin/bash', 14:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dmSQFH6tRg/Listeners', 14:26:03 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 14:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:03 INFO - 'USER': 'cltbld', 14:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:03 INFO - 'XPC_FLAGS': '0x0', 14:26:03 INFO - 'XPC_SERVICE_NAME': '0', 14:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 14:26:03 INFO - mozversion application_buildid: 20160309121625 14:26:03 INFO - mozversion application_changeset: 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f 14:26:03 INFO - mozversion application_display_name: Nightly 14:26:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:26:03 INFO - mozversion application_name: Firefox 14:26:03 INFO - mozversion application_remotingname: firefox 14:26:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:26:03 INFO - mozversion application_vendor: Mozilla 14:26:03 INFO - mozversion application_version: 48.0a1 14:26:03 INFO - mozversion platform_buildid: 20160309121625 14:26:03 INFO - mozversion platform_changeset: 2c9d4c7e3d2d6c5e34ab466ee0edc02c0a4d2d1f 14:26:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:26:03 INFO - mozversion platform_version: 48.0a1 14:26:03 INFO - using testdate: 1457562363 14:26:03 INFO - actual date: 1457562363 14:26:03 INFO - starting webserver on 'localhost:49270' 14:26:03 INFO - SUITE-START | Running 2 tests 14:26:03 INFO - TEST-START | dromaeo_css 14:26:03 INFO - operating with platform_type : mac_ 14:26:03 INFO - Initialising browser for dromaeo_css test... 14:26:03 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpJqtnZU/profile http://localhost:49270/getInfo.html) 14:26:06 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 14:26:06 INFO - PROCESS | 1661 | colorDepth:24 14:26:06 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 14:26:06 INFO - PROCESS | 1661 | __metrics 14:26:06 INFO - PROCESS | 1661 | 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" 14:26:06 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:26:07 INFO - TEST-INFO | 1661: exit 0 14:26:07 INFO - Browser initialized. 14:26:07 INFO - Running cycle 1/1 for dromaeo_css test... 14:26:07 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpJqtnZU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:18 INFO - PROCESS | 1664 | RSS: Main: 242999296 14:26:18 INFO - PROCESS | 1664 | 14:27:10 INFO - PROCESS | 1664 | 1457562430017 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] 14:29:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:29:21 INFO - PROCESS | 1664 | RSS: Main: 344977408 14:29:21 INFO - PROCESS | 1664 | 14:32:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:32:24 INFO - PROCESS | 1664 | RSS: Main: 376037376 14:32:24 INFO - PROCESS | 1664 | 14:35:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:35:26 INFO - PROCESS | 1664 | RSS: Main: 374587392 14:35:26 INFO - PROCESS | 1664 | 14:38:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:38:29 INFO - PROCESS | 1664 | RSS: Main: 332587008 14:38:29 INFO - PROCESS | 1664 | 14:41:32 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:41:33 INFO - PROCESS | 1664 | RSS: Main: 333176832 14:41:33 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:44:36 INFO - PROCESS | 1664 | RSS: Main: 389664768 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | __start_tp_report 14:44:36 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 14:44:36 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 14:44:36 INFO - PROCESS | 1664 | |i|pagename|runs| 14:44:36 INFO - PROCESS | 1664 | |0;dojo.html;2935.662398824133;3395.253044330247;3477.3393055319502;3480.895573132807;3545.9822700886493;5608.747606357713;5647.971760141194;5710.628809127404;5713.6000479966415;5749.540036797057;5666.886662266752;5728.914066289009;5728.971355143219;5748.109043098327;5755;5180.2229665550185;5227.660202086852;5246.842594722146;5269.156934890419;5309.575233981292;5311.548518375943;5312.229726689628;5316.362036555619;5320.654157479771;5321.122014867542;5194.506521880416;5245.029669511153;5251.894962100756;5260.473952604747;5324.094903866352;5246.921296180561;5287.101192797234;5302.310699609065;5303.310569625963;5317.899598134841;5125.38495380553;5158.458361872024;5159.303494028296;5241.42344342122;5245.475452454724;5585.888282234373;5591.664500129965;5599.272094627713;5605.831825045255;5707.543396528309;6227.813165605039;6236.314005459396;6240.781572644981;6242.594231374991;6247.062940558907;6117.541184411187;6136.140940268366;6241.875162496724;6266.404691554295;6270.2475702915945;5779.017567013618;5785.652860828363;5786.855328616776;5833.766649334064;5838.12428135783;5758.913616295759;6266.968665156645;6294.244690637152;6317.273513545909;6318.747250109944;5988.461038506468;6006.12911127884;6065.696715164224;6127.89207890682;6144.7571636353305;6142.662153581507;6252.6873656317;6265.404786545271;6265.937340626627;6267.843303917347;6109.083637454418;6163.630182188993;6171.228596425447;6172.783952561728;6189.102580125947;6096.420840020191;6136.079588061826;6167.814965551041;6190.938090619036;6204.100405441186;4911.386076740408;4911.803527858846;4911.901761964741;4917.557419832161;4921.606271498272;4032.1532478179324;4221.3114754098;4286.164197981364;4407.4050003249795;4456.710313829591;5624.156376543469;5684.573656975744;5763.279590051244;5792.565557583114;5798.391168927286;5187.351581052369;6258.561900667;6272.153259310026;6280.371962803683;6301.086342480315;5641;5724.484796368347;5732.283464566929;5739.626924249994;5741.684207368635;5315.096433606296;5324.227986941949;5381.596380271495;5400.378956419983;5413.323334583177;5240.868978275574;6292.937070629235;6301.558890877686;6329.145565348711;6341.841453963503;6153.261608606996;6270.843228919313;6333.050042493663;6339.334369891095;6339.366063393623;5753.683547404933;6138.987067133873;6269.279032911091;6318.147050148171;6333.050042493663;6160.397728122666;6191.102290167811;6200.410960958701;6215.689215539114;6220;6101.368489499298;6114.8448654109025;6195.876082478235;6260.624362538262;6304.464120549621;6092.573519853745;6125.784909797739;6131.682521312785;6139.553468857771;6143.542582966849;4987.376577927759;5911.55663325261;6123.70969670409;6128.662923539248;6137.877242455215;5736.971315143398;5888.676122813286;5920.904632642975;5940.227770389822;6020.397960203944;5889.087191485327;6092.603980741238;6103.3591472894705;6121.877562448637;6123.8162855114415;5919.467247947706;5928.140419639214;5945.286565612154;5947.256592925884;5959.314678811818 14:44:36 INFO - PROCESS | 1664 | |1;ext.html;503.90425819094395;535.8928214357129;545.2720617975006;634.2610858350023;635.5614625908124;30424;38392.232155356876;38846.50381465667;38955;38992;42010.7899460503;42616.573834261726;42680.14639707204;42688.78655606725;42786;9464.763380915463;9707.077827606367;9711.223102151811;9715.75710607237;9719.611215551406;9450.952745236264;9603.135717785399;9621.27840411972;9637.951810240975;9734.853977190347;9700.223982081416;9798.118169364756;9798.951005244999;9806.16647584956;9807;9694.806103877918;9762.267829912715;9774.56014479343;9775.804483910353;9785.412875227437;9606.567704453246;9713.514324283828;9722.222222222204;9744.610215591369;9763.609455621767;40324.79837600793;40801.387979180334;40839.38740918889;40866.795666021775;41007.179856402705;3079.5996520452422;3139.5133754268127;3194.3132226571165;3516.859325626972;3792.791396473193;28013.01954431585;28055;28142.296442588893;28338.71661283402;28376;2695.43395886864;2732.6584176977876;2733.8223015503927;2784.8329100253845;2834.957475637867;496927;497414;498696;500051;502389;63999.36000639934;65045;65129.023064654066;65293.67353163204;65316.69366612641;72985.27014729891;74173.629131854;74189.6290518544;74365;74368.25631743722;16584.6683066338;16825.747613785803;16853.241604127845;16875.746863797052;16877.91561042187;12855.035872309427;12934.547290844963;12950.740985180431;12970.935145324212;12973.221606703628;21273.936303185088;21627.459313516974;21643.67534486984;21684;22108.88945555294;8833;9034.2320902724;9041.276697864156;9061.728148155566;9127.90872091284;968.2689569375077;986.9654562090292;1061.6496556136456;1066.6213494209444;1075.4622688655672;29225.97709080172;29260;29701.554476682868;30054;30142.397152056838;1103.3821060206149;1128.5542210826677;1130.9660710178707;1131.5247596009697;1170.53763763313;14891.404343826125;15024.924875375771;15195.316210770541;15247.542573722805;15365.923170384076;300507;301646;302138;302537;303715;59438;60025.4980876436;60118.69940650269;60130;60316.698416507636;1326.111505291457;1445.7831325301288;1448.3265281643876;1463.0928824128896;1585.5243426971863;28331.43337133287;28670.076088312337;28910.421791564473;28934.27664308325;29178.124656260345;33531.4970275451;43549.56450435455;44245.778771105935;44364.55635443604;44404.777976109915;362862;365042;365345;365820;365833.1708341441;28515.857420712764;29031.85484072566;32829.67170328362;33378.33243335168;33869.49195762115;40930.79534602308;42218.36672449854;42736.35895461633;42980.78509607557;43073.78463107665;35744.64255357413;36549.634503654626;36783.89648310555;37608.247835043694;37691.62308376991;35407.645923541466;35807.104822379646;36180.09549761277;36676.08309792277;36824.26351473009;35935.64064359428;36319.818400907825;36565;36791.26417471582;37138.814305928296;31398.843005784824;32335;32343.514847276838;32406.02781916546;32445.51331729979;23889.28332150038;24079.398015049763;24307.756922430548;24557.263282101565;24606.138785142433 14:44:36 INFO - PROCESS | 1664 | |2;jquery.html;364.37509670914386;368.17528735632175;368.5853414908228;376.57070939129414;378.45124569374394;19549.02254887257;20704.585908281824;21660.56678866422;21844.45388865279;22180;18577.349792757257;19514.731542449765;20865.26971555996;21591.352259432202;21676.024578893946;5753.108268218422;5965.1946987156825;5998.670073145975;6019.939800601982;6049.818505444821;5646.661200327973;5976.462118409342;5983.670898100603;5985.16207730918;5987.251593550806;5901.911471327933;5926.792562260322;5927.051671732524;5930.199423077873;5930.733117009723;5644.774209031634;5893.0276504376725;5911.29064512257;5930.258717660293;5943.078822782454;5087.440381558025;5110.156824124015;5111.821086262;5115.2327150927285;5123.897522049539;20426.38720838377;26131.60802587963;26450.338741531425;26520.73479265202;26565;2108.4096452993185;2254.1884921428436;2669.9599506007426;2685.207863680219;2813.986964692709;9680.893498204998;10156.644517441853;10189.490525473771;10252.74368140795;10286.691399258034;1708.9145542722815;1739.5129363778162;1776.2806063544285;1810.592616661254;1823.124900047971;70339.64830175816;84922;101160.49419752927;105393.47303263511;107670.46164769205;11259.748050389955;11435.714107147222;11440.256383335056;11477.71305717347;11590.826137607943;13735.725285494435;13795.310234488436;13797.862021379658;13831.79252311216;13839.723205535833;7365.742199023116;8264.214899584651;8478.5336806475;8637.870431943526;8639.049704532496;8579.82840343202;8581.613827377783;8604.956975215084;8669.91330086691;8678.739637810875;4434.379186913835;4469.262571675637;4478.037221997286;4482.39487669167;4513.7066090704;1655.8013038435465;1866.188208129441;1926.2776458827939;1932.7050875913171;1964.0866996846535;898.2948385517337;925.2551695884742;971.4941840147743;1042.524827369264;1055.0399136785488;17080.743788843178;19577.804221957882;19679.90160049219;19856.50358741014;20133.194672212947;817.5462618246811;948.2650945517279;954.9761255968517;981.3572110267786;984.13396211335;10588.57645694179;10631.681049568526;10850.45747712627;10852;11030.393328367018;624566;626315;642712;643976;646746;70168;78908;110915;111211;113062.86937130688;987.8863930648067;988.3822610868208;998.6504723346916;1014.3964341217112;1017.0185770731132;17571;17729.645407091528;18189;18210.180541875383;18390.89654620727;48019.75990120027;48568;48825.511744883515;50774.74612626913;50865.237021443965;69338;70281.64859175672;71410.64294678702;73138;73312.63343683248;7791.961040194763;7888.290053895177;8029.759107226792;8056.27493525562;8297.875531866906;12778.87221127814;13210.94312454982;13237.80143297832;13596.86403135956;13598.524051658145;11498.425078746197;11551.653450396501;11702.590409335633;11880.76238475243;11908.166428349932;11313.886861131283;11385.975262226439;11475.540978360772;11532.538698451968;11851.703707407383;6163.106349579376;9296.674616388394;11813;11816.881831181578;11983.041356691618;8090.474119182234;8142.10436851934;8261.958690206511;8267.007959044953;8489.533075680896;11537;11714.824277635671;11810.881891180978;11904.523819047141;11990.362120333513 14:44:36 INFO - PROCESS | 1664 | |3;mootools.html;1437.5543581489733;1576.1725094325477;1598.7362085255934;1872.3166044393793;2013.496625843539;7975.800604984878;8639.65441382344;8772.868406973901;8783.341249406289;8793.340499462534;8555.78610534737;8782.516961567111;8782.868256976135;8783.956080219607;8786.12138786121;2183.1376606240524;2433.841800282985;2482.329770961839;2508.109621084516;2508.83692559983;2501.6747822783104;2514.9874250628723;2518.4207632244593;2522.583773677341;2525.734797846227;2367.041348253951;2389.6893403857475;2399.2802159352123;2412.9155479558217;2413.2036427978724;2460.3603063203695;2482.6276058591175;2489.2034548944343;2494.5010997800514;2511.3470497670737;2465.95068098637;2470.765277298654;2487.3035550046015;2494.3639371960035;2499.6500489931423;8812.162844529823;8878.911210887873;8881.600327985256;8883.289336853037;8893.688720894803;5420.83737487876;5555.083411237141;5569.081101618228;5572.554195664337;5580.776768929238;3527.805970671612;3529.0824385659657;3595.532580764484;3750.2312026034597;3755.830987605537;1035.1511760356511;1046.1317106801412;1053.0838170791385;1055.9313644613076;1058.62418841311;11872.168948173632;11883.881161188365;11887.465064072137;11910.987566056809;11925.105617078754;4863.610911127102;4909.018196360742;4996.600271978233;5009.173486374781;5022.723750193774;10203.908198819372;10209.081182693444;10224.488775561193;10227.02843229892;10234.437105959243;5549.611527193058;5565.30433695788;5568.1091025435735;5568.164775283659;5569.749361278752;4448.599626033672;4574.679772415965;4834.20235661112;4984.626153038536;5055.9241611375855;3959.148783011666;4010.3984402339297;4045.271851066836;4054.2364071628936;4084.673226141961;1313.750387426386;1321.7752981993085;1322.6957799706122;1329.6476433745065;1341.275711116006;1365.9248741319323;1379.1931719943946;1381.8341798984186;1410.5768269519103;1411.8941079419085;8177.509349439053;8215.424920255524;8261.17388261181;8272.503649780912;8283.17168283167;442.81180498288745;523.1028785632658;527.4514504914846;530.8089087928342;531.0414701463818;6261.405166509175;6285.968570157212;6294.307626161119;6306.180196574508;6319.842003949846;10123.848142277871;10810.35137891729;10826.837597436044;10945.671629851116;10959;10414.895851041545;10705.197110216764;10776.946115269373;10830.296030757976;10838.40388778609;8243.587820609066;8321.708740194184;8391.95804020976;8393.95803020981;8415.70545030921;7806.921930780847;7982.640781164978;8004.5597492138495;8011.83976320482;8087.069986951576;9380.484073375757;9585.424874507551;9664.130228279488;9759;9855.753606159617;9622.230221582116;9964.701058968243;10058.497075146068;10089.747756306151;10128.03783640553;6812.659367031728;6867.141607299088;7004.824879378057;7558.773236802905;7630.885536716843;8126.674933002614;8221.383396245425;8243.381746368927;8256.711015114442;8259.876101858597;7232.855342893218;7309.926900730925;7343.082114735658;7455.664495097625;7494.70021199146;7220.664177127248;7286.380657644159;7322.926770732438;7353.926460735324;7423.517471364344;7726.652300646597;7801.609919504115;7807.336376408069;7815.726449574237;7828.608569571613;5897.203877476657;6986.825329366807;7091.042709234393;7093.964530177316;7094.574325540484;7089.716411343488;7161.2122666507685;7178.5692858428665;7184.640767961477;7191.460640451883 14:44:36 INFO - PROCESS | 1664 | |4;prototype.html;322.29739168612423;326.2659017211275;332.3585480023554;333.16209732522697;337.47354127560993;6708.228553716324;6724.125863637726;6739.1239138912;6755.290694477083;6777.32226777322;6686.063951046845;6699.598024118556;6717.697703603338;6722.495812814034;6724.663766811665;4704.223803072489;4804.231322988323;4817.205161148424;4836.2987366831785;4986.975065124679;4829.951700482985;4841.176999910023;4863.440704319013;4918.704877707331;4963.379577552806;4850.199717046683;4885.853424397274;4888.388951381077;4896.167651499253;4903.950960490403;4100.958990410088;4767.951050768843;4883.267509873512;4886.951130488703;4906.656534042619;4005.1388951375593;4037.2934736421007;4131.235721391552;4133.937990930139;4139.875803725893;6297.086922396227;6323.810285691437;6329.556931014831;6336.112944187817;6342.143810585604;5643.633163844378;5648;5649.745761440704;5655.349634792011;5659.547236221092;6975.093237879094;6980.336867997532;6990.895136572955;6993.370596646276;6999.300069993011;4453.153900758845;4613.123506533748;4626.606738427237;4627.467841198271;4632.420947381577;7422.183559808417;7443.59060251686;7457.576287706517;7468.178500364956;7473.103227612667;4675.883102922386;4715.339852420664;4716.858494245178;4721.055788842245;4722.291656251589;4791.760411979387;4795.6163506919365;4795.976020119877;4798.616110711135;4798.688085274516;5635.774569017275;5641.605087643826;5642.85892852682;5643.746031428595;5649.378568357477;5170.508801663836;6794.45644348451;7037.788866334018;7061.399781018568;7232.0598322217775;1605.8233594304618;1627.853493185619;1634.6730653869035;1635.337688236266;1641.0563925742745;1037.8910214427528;1041.3803786746873;1052.5737076484036;1062.2086545523634;1063.31416236527;6422.42198202164;6610.900836487456;6670.299618540081;6680.933190668128;6752.020956961213;7273.163586187656;7354.154272258652;7426.517276377018;7439.51643143194;7498.737544185928;6716.891712867322;6717.966410167918;6718.294579069225;6723.361280678328;6728.831779205461;3917.2557214129224;3941.802909854553;3944.3491823848744;3955.7033222507853;3962.40563915415;7532.8493430132185;7861.646225919847;7872.055353357519;7910.564918929399;7922.841543169105;7745.070591529053;7765.068191816905;7783.961080194563;7806.024246969129;7807.024121984752;7880.566568838769;7891.644875980594;7894.921050789419;7902.525848449111;7914.287714105758;7500.8499830002;7506.624668766649;7507.474476786572;7508.249175082667;7509.986151869428;7064.834302340262;7408.851822963618;7418.480706350504;7427.740029098955;7440.590767507839;7869.763907082796;7925.167857374892;7927.12801591836;7931.881021784793;7942.166072562298;4623.976880115578;4663.930041049319;4684.063187362473;4686.343911852276;4686.554777296288;6075;7068.823279418056;7480.887786683313;7483;7508.174100848793;6116.908246376219;7165.892511612435;7178;7232.0959880015;7248.710051597877;6133.478654314434;7233.1681856587165;7234.16807067173;7244.239354867874;7259.52813067149;7011.894821577578;7028.613426261605;7040.542364746275;7042.647867606702;7045.542039767399;5874.911876321944;6984.441244700311;7207.495475316678;7214.89177662325;7235.421166306788;6742.93257067423;6936.34104760047;7044;7062.081929349151;7085.362317391459 14:44:36 INFO - PROCESS | 1664 | |5;yui.html;694.9166100067991;699.7585832887655;710.9502334836557;737.4211244173325;815.1481701621805;15237.923810380946;15451.918365714377;15468.69062618747;15474.38102475901;15479.14864682442;14070.64823379416;14236.217008064552;14500.782488262685;14536;14546.272686365666;740.8184994676285;914.4239129348517;922.1331947968921;934.444005816538;935.7473482159813;750.2422553221231;752.6537792615403;755.6297414266998;757.2957149850637;921.3136213520936;990.4898977026837;992.1864071461405;993.135971704618;994.1053052252994;995.9502024898762;989.3717489394251;990.128686755654;990.9851352229722;991.9652812151612;993.0417147452671;579.6522086747959;583.9416058394169;584.2638275772557;585.7803323753592;736.8047467421138;12429.440675169639;15469.922650386789;15478.45825396117;15478.5356439307;15542.456014039568;12472.875271247261;12479.56321528742;12736.872631273754;12842.486300547967;13087.541936032194;10010.04904534068;10064.642175406032;10121.746956326077;10176.847347289797;10506.369617822955;3476.4263896457055;3507.771994820354;3547.0600290922926;3556.4309710446464;3676.062604035954;85070.14929850685;85193.72209416864;85376.57311713464;85408.14591854127;85441.99999999937;9497.620095196253;9556.808863822685;9587.520623968774;9744.512774361396;9947.303688741718;20896.89551552263;21164.94175291229;21179.470513236985;21186.470338241357;21210.681839772416;7575.810604734926;7667.769966901002;7694.192109828499;8022.1175670676175;8102.554359510284;4133.359329303903;4143.97928010364;4182.623563879265;4239.172969947389;4416.315471101984;3622.9094272643397;3665.6151104133683;3668.413053911361;3674.283514714605;3677.0807298175455;659.66686823154;665.8235567574596;666.5201055240219;667.3226674924955;672.3444641474523;567.9379560222328;578.3320265093739;609.9542534309855;613.1140501974604;626.7399029402837;8064.435489515795;8139.267465928095;8267.793305167299;8309.252167304972;8327.625256863455;485.7959656944092;521.8199721096215;572.6964708704394;611.413043478257;620.7423919073624;3734.2344819311975;3824.9235015299537;3849.4610754494392;4070.61329173728;4219.831206751757;90149;92580;92691;92741.53629231811;93699;75366;75747.24252757512;77172.22827771651;77523.22476775273;80062;59000.40999590035;64131.717365652425;68178.31821681719;68182.9772553412;68416.315836842;6982.930170698228;8413.284870785807;8530.829383412172;8540.060593334852;8662.090480499457;46468.7676561615;48528;49818.75090624524;49873.00253994827;52169.739151304;62858.685706571174;71523.21191970243;71874;71945.56108877898;73149;10770.887982366175;11023.44882755875;11186.776264474502;11255.493502792559;11385.601503947322;11055.944720276348;11997.64007079789;12059.81910271329;12082.51669933228;12381.566645167375;11229.71925701864;11285.887141128813;11490.712732181762;11573.305601663928;11896.821547676618;11351.829722554003;11559;11561.42192890369;11779.116566257393;11854.881451185378;11183.440827958731;11543.88456115428;11634.360110193682;11695.356755378196;11753.236039657395;9424.434533927986;9639.807203855744;9645.71062868115;9658.468784216935;9815;9599.856002160113;9679.419234845931;9713.125818676353;9723.465209413267;9757.365771224848 14:44:36 INFO - PROCESS | 1664 | __end_tp_report 14:44:36 INFO - PROCESS | 1664 | __start_cc_report 14:44:36 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1018 14:44:36 INFO - PROCESS | 1664 | __end_cc_report 14:44:36 INFO - PROCESS | 1664 | __startTimestamp1457563476450__endTimestamp 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | ------- Summary: start ------- 14:44:36 INFO - PROCESS | 1664 | Number of tests: 6 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5717.16 Median:5889.09 stddev:639.02 (10.9%) stddev-sans-first:602.57 14:44:36 INFO - PROCESS | 1664 | Values: 2935.7 3395.3 3477.3 3480.9 3546.0 5608.7 5648.0 5710.6 5713.6 5749.5 5666.9 5728.9 5729.0 5748.1 5755.0 5180.2 5227.7 5246.8 5269.2 5309.6 5311.5 5312.2 5316.4 5320.7 5321.1 5194.5 5245.0 5251.9 5260.5 5324.1 5246.9 5287.1 5302.3 5303.3 5317.9 5125.4 5158.5 5159.3 5241.4 5245.5 5585.9 5591.7 5599.3 5605.8 5707.5 6227.8 6236.3 6240.8 6242.6 6247.1 6117.5 6136.1 6241.9 6266.4 6270.2 5779.0 5785.7 5786.9 5833.8 5838.1 5758.9 6267.0 6294.2 6317.3 6318.7 5988.5 6006.1 6065.7 6127.9 6144.8 6142.7 6252.7 6265.4 6265.9 6267.8 6109.1 6163.6 6171.2 6172.8 6189.1 6096.4 6136.1 6167.8 6190.9 6204.1 4911.4 4911.8 4911.9 4917.6 4921.6 4032.2 4221.3 4286.2 4407.4 4456.7 5624.2 5684.6 5763.3 5792.6 5798.4 5187.4 6258.6 6272.2 6280.4 6301.1 5641.0 5724.5 5732.3 5739.6 5741.7 5315.1 5324.2 5381.6 5400.4 5413.3 5240.9 6292.9 6301.6 6329.1 6341.8 6153.3 6270.8 6333.1 6339.3 6339.4 5753.7 6139.0 6269.3 6318.1 6333.1 6160.4 6191.1 6200.4 6215.7 6220.0 6101.4 6114.8 6195.9 6260.6 6304.5 6092.6 6125.8 6131.7 6139.6 6143.5 4987.4 5911.6 6123.7 6128.7 6137.9 5737.0 5888.7 5920.9 5940.2 6020.4 5889.1 6092.6 6103.4 6121.9 6123.8 5919.5 5928.1 5945.3 5947.3 5959.3 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:55240.95 Median:365826.59 stddev:105217.20 (28.8%) stddev-sans-first:105432.10 14:44:36 INFO - PROCESS | 1664 | Values: 503.9 535.9 545.3 634.3 635.6 30424.0 38392.2 38846.5 38955.0 38992.0 42010.8 42616.6 42680.1 42688.8 42786.0 9464.8 9707.1 9711.2 9715.8 9719.6 9451.0 9603.1 9621.3 9638.0 9734.9 9700.2 9798.1 9799.0 9806.2 9807.0 9694.8 9762.3 9774.6 9775.8 9785.4 9606.6 9713.5 9722.2 9744.6 9763.6 40324.8 40801.4 40839.4 40866.8 41007.2 3079.6 3139.5 3194.3 3516.9 3792.8 28013.0 28055.0 28142.3 28338.7 28376.0 2695.4 2732.7 2733.8 2784.8 2835.0 496927.0 497414.0 498696.0 500051.0 502389.0 63999.4 65045.0 65129.0 65293.7 65316.7 72985.3 74173.6 74189.6 74365.0 74368.3 16584.7 16825.7 16853.2 16875.7 16877.9 12855.0 12934.5 12950.7 12970.9 12973.2 21273.9 21627.5 21643.7 21684.0 22108.9 8833.0 9034.2 9041.3 9061.7 9127.9 968.3 987.0 1061.6 1066.6 1075.5 29226.0 29260.0 29701.6 30054.0 30142.4 1103.4 1128.6 1131.0 1131.5 1170.5 14891.4 15024.9 15195.3 15247.5 15365.9 300507.0 301646.0 302138.0 302537.0 303715.0 59438.0 60025.5 60118.7 60130.0 60316.7 1326.1 1445.8 1448.3 1463.1 1585.5 28331.4 28670.1 28910.4 28934.3 29178.1 33531.5 43549.6 44245.8 44364.6 44404.8 362862.0 365042.0 365345.0 365820.0 365833.2 28515.9 29031.9 32829.7 33378.3 33869.5 40930.8 42218.4 42736.4 42980.8 43073.8 35744.6 36549.6 36783.9 37608.2 37691.6 35407.6 35807.1 36180.1 36676.1 36824.3 35935.6 36319.8 36565.0 36791.3 37138.8 31398.8 32335.0 32343.5 32406.0 32445.5 23889.3 24079.4 24307.8 24557.3 24606.1 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34254.33 Median:2749.60 stddev:104862.17 (3813.7%) stddev-sans-first:105125.46 14:44:36 INFO - PROCESS | 1664 | Values: 364.4 368.2 368.6 376.6 378.5 19549.0 20704.6 21660.6 21844.5 22180.0 18577.3 19514.7 20865.3 21591.4 21676.0 5753.1 5965.2 5998.7 6019.9 6049.8 5646.7 5976.5 5983.7 5985.2 5987.3 5901.9 5926.8 5927.1 5930.2 5930.7 5644.8 5893.0 5911.3 5930.3 5943.1 5087.4 5110.2 5111.8 5115.2 5123.9 20426.4 26131.6 26450.3 26520.7 26565.0 2108.4 2254.2 2670.0 2685.2 2814.0 9680.9 10156.6 10189.5 10252.7 10286.7 1708.9 1739.5 1776.3 1810.6 1823.1 70339.6 84922.0 101160.5 105393.5 107670.5 11259.7 11435.7 11440.3 11477.7 11590.8 13735.7 13795.3 13797.9 13831.8 13839.7 7365.7 8264.2 8478.5 8637.9 8639.0 8579.8 8581.6 8605.0 8669.9 8678.7 4434.4 4469.3 4478.0 4482.4 4513.7 1655.8 1866.2 1926.3 1932.7 1964.1 898.3 925.3 971.5 1042.5 1055.0 17080.7 19577.8 19679.9 19856.5 20133.2 817.5 948.3 955.0 981.4 984.1 10588.6 10631.7 10850.5 10852.0 11030.4 624566.0 626315.0 642712.0 643976.0 646746.0 70168.0 78908.0 110915.0 111211.0 113062.9 987.9 988.4 998.7 1014.4 1017.0 17571.0 17729.6 18189.0 18210.2 18390.9 48019.8 48568.0 48825.5 50774.7 50865.2 69338.0 70281.6 71410.6 73138.0 73312.6 7792.0 7888.3 8029.8 8056.3 8297.9 12778.9 13210.9 13237.8 13596.9 13598.5 11498.4 11551.7 11702.6 11880.8 11908.2 11313.9 11386.0 11475.5 11532.5 11851.7 6163.1 9296.7 11813.0 11816.9 11983.0 8090.5 8142.1 8262.0 8267.0 8489.5 11537.0 11714.8 11810.9 11904.5 11990.4 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6081.03 Median:529.13 stddev:3216.45 (607.9%) stddev-sans-first:3206.53 14:44:36 INFO - PROCESS | 1664 | Values: 1437.6 1576.2 1598.7 1872.3 2013.5 7975.8 8639.7 8772.9 8783.3 8793.3 8555.8 8782.5 8782.9 8784.0 8786.1 2183.1 2433.8 2482.3 2508.1 2508.8 2501.7 2515.0 2518.4 2522.6 2525.7 2367.0 2389.7 2399.3 2412.9 2413.2 2460.4 2482.6 2489.2 2494.5 2511.3 2466.0 2470.8 2487.3 2494.4 2499.7 8812.2 8878.9 8881.6 8883.3 8893.7 5420.8 5555.1 5569.1 5572.6 5580.8 3527.8 3529.1 3595.5 3750.2 3755.8 1035.2 1046.1 1053.1 1055.9 1058.6 11872.2 11883.9 11887.5 11911.0 11925.1 4863.6 4909.0 4996.6 5009.2 5022.7 10203.9 10209.1 10224.5 10227.0 10234.4 5549.6 5565.3 5568.1 5568.2 5569.7 4448.6 4574.7 4834.2 4984.6 5055.9 3959.1 4010.4 4045.3 4054.2 4084.7 1313.8 1321.8 1322.7 1329.6 1341.3 1365.9 1379.2 1381.8 1410.6 1411.9 8177.5 8215.4 8261.2 8272.5 8283.2 442.8 523.1 527.5 530.8 531.0 6261.4 6286.0 6294.3 6306.2 6319.8 10123.8 10810.4 10826.8 10945.7 10959.0 10414.9 10705.2 10776.9 10830.3 10838.4 8243.6 8321.7 8392.0 8394.0 8415.7 7806.9 7982.6 8004.6 8011.8 8087.1 9380.5 9585.4 9664.1 9759.0 9855.8 9622.2 9964.7 10058.5 10089.7 10128.0 6812.7 6867.1 7004.8 7558.8 7630.9 8126.7 8221.4 8243.4 8256.7 8259.9 7232.9 7309.9 7343.1 7455.7 7494.7 7220.7 7286.4 7322.9 7353.9 7423.5 7726.7 7801.6 7807.3 7815.7 7828.6 5897.2 6986.8 7091.0 7094.0 7094.6 7089.7 7161.2 7178.6 7184.6 7191.5 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5843.20 Median:6703.91 stddev:1895.57 (28.3%) stddev-sans-first:1855.04 14:44:36 INFO - PROCESS | 1664 | Values: 322.3 326.3 332.4 333.2 337.5 6708.2 6724.1 6739.1 6755.3 6777.3 6686.1 6699.6 6717.7 6722.5 6724.7 4704.2 4804.2 4817.2 4836.3 4987.0 4830.0 4841.2 4863.4 4918.7 4963.4 4850.2 4885.9 4888.4 4896.2 4904.0 4101.0 4768.0 4883.3 4887.0 4906.7 4005.1 4037.3 4131.2 4133.9 4139.9 6297.1 6323.8 6329.6 6336.1 6342.1 5643.6 5648.0 5649.7 5655.3 5659.5 6975.1 6980.3 6990.9 6993.4 6999.3 4453.2 4613.1 4626.6 4627.5 4632.4 7422.2 7443.6 7457.6 7468.2 7473.1 4675.9 4715.3 4716.9 4721.1 4722.3 4791.8 4795.6 4796.0 4798.6 4798.7 5635.8 5641.6 5642.9 5643.7 5649.4 5170.5 6794.5 7037.8 7061.4 7232.1 1605.8 1627.9 1634.7 1635.3 1641.1 1037.9 1041.4 1052.6 1062.2 1063.3 6422.4 6610.9 6670.3 6680.9 6752.0 7273.2 7354.2 7426.5 7439.5 7498.7 6716.9 6718.0 6718.3 6723.4 6728.8 3917.3 3941.8 3944.3 3955.7 3962.4 7532.8 7861.6 7872.1 7910.6 7922.8 7745.1 7765.1 7784.0 7806.0 7807.0 7880.6 7891.6 7894.9 7902.5 7914.3 7500.8 7506.6 7507.5 7508.2 7510.0 7064.8 7408.9 7418.5 7427.7 7440.6 7869.8 7925.2 7927.1 7931.9 7942.2 4624.0 4663.9 4684.1 4686.3 4686.6 6075.0 7068.8 7480.9 7483.0 7508.2 6116.9 7165.9 7178.0 7232.1 7248.7 6133.5 7233.2 7234.2 7244.2 7259.5 7011.9 7028.6 7040.5 7042.6 7045.5 5874.9 6984.4 7207.5 7214.9 7235.4 6742.9 6936.3 7044.0 7062.1 7085.4 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18387.91 Median:610.68 stddev:25833.58 (4230.3%) stddev-sans-first:25871.89 14:44:36 INFO - PROCESS | 1664 | Values: 694.9 699.8 711.0 737.4 815.1 15237.9 15451.9 15468.7 15474.4 15479.1 14070.6 14236.2 14500.8 14536.0 14546.3 740.8 914.4 922.1 934.4 935.7 750.2 752.7 755.6 757.3 921.3 990.5 992.2 993.1 994.1 996.0 989.4 990.1 991.0 992.0 993.0 579.7 583.9 584.3 585.8 736.8 12429.4 15469.9 15478.5 15478.5 15542.5 12472.9 12479.6 12736.9 12842.5 13087.5 10010.0 10064.6 10121.7 10176.8 10506.4 3476.4 3507.8 3547.1 3556.4 3676.1 85070.1 85193.7 85376.6 85408.1 85442.0 9497.6 9556.8 9587.5 9744.5 9947.3 20896.9 21164.9 21179.5 21186.5 21210.7 7575.8 7667.8 7694.2 8022.1 8102.6 4133.4 4144.0 4182.6 4239.2 4416.3 3622.9 3665.6 3668.4 3674.3 3677.1 659.7 665.8 666.5 667.3 672.3 567.9 578.3 610.0 613.1 626.7 8064.4 8139.3 8267.8 8309.3 8327.6 485.8 521.8 572.7 611.4 620.7 3734.2 3824.9 3849.5 4070.6 4219.8 90149.0 92580.0 92691.0 92741.5 93699.0 75366.0 75747.2 77172.2 77523.2 80062.0 59000.4 64131.7 68178.3 68183.0 68416.3 6982.9 8413.3 8530.8 8540.1 8662.1 46468.8 48528.0 49818.8 49873.0 52169.7 62858.7 71523.2 71874.0 71945.6 73149.0 10770.9 11023.4 11186.8 11255.5 11385.6 11055.9 11997.6 12059.8 12082.5 12381.6 11229.7 11285.9 11490.7 11573.3 11896.8 11351.8 11559.0 11561.4 11779.1 11854.9 11183.4 11543.9 11634.4 11695.4 11753.2 9424.4 9639.8 9645.7 9658.5 9815.0 9599.9 9679.4 9713.1 9723.5 9757.4 14:44:36 INFO - PROCESS | 1664 | -------- Summary: end -------- 14:44:36 INFO - PROCESS | 1664 | 14:44:36 INFO - TEST-INFO | 1664: exit 0 14:44:37 INFO - TEST-OK | dromaeo_css | took 1113176ms 14:44:37 INFO - TEST-START | kraken 14:44:37 INFO - operating with platform_type : mac_ 14:44:37 INFO - Initialising browser for kraken test... 14:44:37 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmprOgPCn/profile http://localhost:49270/getInfo.html) 14:44:39 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 14:44:39 INFO - PROCESS | 1675 | colorDepth:24 14:44:39 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 14:44:39 INFO - PROCESS | 1675 | __metrics 14:44:39 INFO - PROCESS | 1675 | 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" 14:44:39 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:44:39 INFO - TEST-INFO | 1675: exit 0 14:44:39 INFO - Browser initialized. 14:44:39 INFO - Running cycle 1/1 for kraken test... 14:44:39 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmprOgPCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:51 INFO - PROCESS | 1677 | RSS: Main: 243384320 14:44:51 INFO - PROCESS | 1677 | 14:44:54 INFO - PROCESS | 1677 | 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) 14:44:55 INFO - PROCESS | 1677 | RSS: Main: 289488896 14:44:55 INFO - PROCESS | 1677 | 14:44:57 INFO - PROCESS | 1677 | 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) 14:44:58 INFO - PROCESS | 1677 | RSS: Main: 302305280 14:44:58 INFO - PROCESS | 1677 | 14:45:01 INFO - PROCESS | 1677 | 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) 14:45:02 INFO - PROCESS | 1677 | RSS: Main: 286494720 14:45:02 INFO - PROCESS | 1677 | 14:45:04 INFO - PROCESS | 1677 | 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) 14:45:04 INFO - PROCESS | 1677 | RSS: Main: 290844672 14:45:04 INFO - PROCESS | 1677 | 14:45:06 INFO - PROCESS | 1677 | 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) 14:45:07 INFO - PROCESS | 1677 | RSS: Main: 291614720 14:45:07 INFO - PROCESS | 1677 | 14:45:10 INFO - PROCESS | 1677 | 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) 14:45:10 INFO - PROCESS | 1677 | RSS: Main: 290488320 14:45:10 INFO - PROCESS | 1677 | 14:45:13 INFO - PROCESS | 1677 | 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) 14:45:14 INFO - PROCESS | 1677 | RSS: Main: 292057088 14:45:14 INFO - PROCESS | 1677 | 14:45:17 INFO - PROCESS | 1677 | 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) 14:45:17 INFO - PROCESS | 1677 | RSS: Main: 290467840 14:45:17 INFO - PROCESS | 1677 | 14:45:19 INFO - PROCESS | 1677 | 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) 14:45:19 INFO - PROCESS | 1677 | RSS: Main: 324579328 14:45:19 INFO - PROCESS | 1677 | 14:45:21 INFO - PROCESS | 1677 | 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) 14:45:22 INFO - PROCESS | 1677 | RSS: Main: 323317760 14:45:22 INFO - PROCESS | 1677 | 14:45:24 INFO - PROCESS | 1677 | 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) 14:45:25 INFO - PROCESS | 1677 | RSS: Main: 331567104 14:45:25 INFO - PROCESS | 1677 | 14:45:27 INFO - PROCESS | 1677 | 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) 14:45:28 INFO - PROCESS | 1677 | RSS: Main: 331870208 14:45:28 INFO - PROCESS | 1677 | 14:45:30 INFO - PROCESS | 1677 | 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) 14:45:31 INFO - PROCESS | 1677 | RSS: Main: 333418496 14:45:31 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | 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) 14:45:33 INFO - PROCESS | 1677 | RSS: Main: 394031104 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | __start_tp_report 14:45:33 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 14:45:33 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 14:45:33 INFO - PROCESS | 1677 | |i|pagename|runs| 14:45:33 INFO - PROCESS | 1677 | |0;ai-astar;110;108;111;111;121;162;162;112;111;111 14:45:33 INFO - PROCESS | 1677 | |1;audio-beat-detection;157;118;142;159;116;141;137;117;197;145 14:45:33 INFO - PROCESS | 1677 | |2;audio-dft;190;184;188;186;186;188;184;181;180;183 14:45:33 INFO - PROCESS | 1677 | |3;audio-fft;74;73;88;78;74;46;56;77;104;82 14:45:33 INFO - PROCESS | 1677 | |4;audio-oscillator;89;104;169;119;105;90;116;76;78;113 14:45:33 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;85;89;94;133;85;88;85;87;86 14:45:33 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;93;94;95;92;93;94;94;102;149 14:45:33 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;88;85;85;86;85;85;85;87;84 14:45:33 INFO - PROCESS | 1677 | |8;json-parse-financial;56;53;53;53;52;53;56;64;54;52 14:45:33 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;62;72;74;70;66;65;69;66;67 14:45:33 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;82;82;82;83;82;82;82;82;83;82 14:45:33 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;127;132;130;128;127;131;129;122;131;121 14:45:33 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;145;171;179;137;137;140;138;136;136;139 14:45:33 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;69;66;66;67;67;67;66;66;67;66 14:45:33 INFO - PROCESS | 1677 | __end_tp_report 14:45:33 INFO - PROCESS | 1677 | __start_cc_report 14:45:33 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1250 14:45:33 INFO - PROCESS | 1677 | __end_cc_report 14:45:33 INFO - PROCESS | 1677 | __startTimestamp1457563533303__endTimestamp 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | ------- Summary: start ------- 14:45:33 INFO - PROCESS | 1677 | Number of tests: 14 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:121.90 Median:111.50 stddev:21.41 (19.2%) stddev-sans-first:22.27 14:45:33 INFO - PROCESS | 1677 | Values: 110.0 108.0 111.0 111.0 121.0 162.0 162.0 112.0 111.0 111.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:143.50 stddev:24.59 (17.1%) stddev-sans-first:25.55 14:45:33 INFO - PROCESS | 1677 | Values: 157.0 118.0 142.0 159.0 116.0 141.0 137.0 117.0 197.0 145.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:3.20 (1.7%) stddev-sans-first:2.83 14:45:33 INFO - PROCESS | 1677 | Values: 190.0 184.0 188.0 186.0 186.0 188.0 184.0 181.0 180.0 183.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.50 stddev:15.92 (21.1%) stddev-sans-first:16.87 14:45:33 INFO - PROCESS | 1677 | Values: 74.0 73.0 88.0 78.0 74.0 46.0 56.0 77.0 104.0 82.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:122.50 stddev:26.92 (22.0%) stddev-sans-first:27.85 14:45:33 INFO - PROCESS | 1677 | Values: 89.0 104.0 169.0 119.0 105.0 90.0 116.0 76.0 78.0 113.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:87.50 stddev:14.66 (16.8%) stddev-sans-first:15.48 14:45:33 INFO - PROCESS | 1677 | Values: 88.0 85.0 89.0 94.0 133.0 85.0 88.0 85.0 87.0 86.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:93.50 stddev:17.48 (18.7%) stddev-sans-first:18.36 14:45:33 INFO - PROCESS | 1677 | Values: 93.0 93.0 94.0 95.0 92.0 93.0 94.0 94.0 102.0 149.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 14:45:33 INFO - PROCESS | 1677 | Values: 85.0 88.0 85.0 85.0 86.0 85.0 85.0 85.0 87.0 84.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:53.50 stddev:3.60 (6.7%) stddev-sans-first:3.78 14:45:33 INFO - PROCESS | 1677 | Values: 56.0 53.0 53.0 53.0 52.0 53.0 56.0 64.0 54.0 52.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:3.63 (5.3%) stddev-sans-first:3.72 14:45:33 INFO - PROCESS | 1677 | Values: 65.0 62.0 72.0 74.0 70.0 66.0 65.0 69.0 66.0 67.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 14:45:33 INFO - PROCESS | 1677 | Values: 82.0 82.0 82.0 83.0 82.0 82.0 82.0 82.0 83.0 82.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:129.50 stddev:3.74 (2.9%) stddev-sans-first:3.95 14:45:33 INFO - PROCESS | 1677 | Values: 127.0 132.0 130.0 128.0 127.0 131.0 129.0 122.0 131.0 121.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:139.50 stddev:15.73 (11.3%) stddev-sans-first:16.68 14:45:33 INFO - PROCESS | 1677 | Values: 145.0 171.0 179.0 137.0 137.0 140.0 138.0 136.0 136.0 139.0 14:45:33 INFO - PROCESS | 1677 | 14:45:33 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.53 14:45:33 INFO - PROCESS | 1677 | Values: 69.0 66.0 66.0 67.0 67.0 67.0 66.0 66.0 67.0 66.0 14:45:33 INFO - PROCESS | 1677 | -------- Summary: end -------- 14:45:33 INFO - PROCESS | 1677 | 14:45:34 INFO - TEST-INFO | 1677: exit 0 14:45:34 INFO - TEST-OK | kraken | took 57056ms 14:45:34 INFO - SUITE-END | took 1170s 14:45:34 INFO - Completed test suite (00:19:30) 14:45:34 INFO - javascript benchmark 14:45:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2935.662398824133, 3395.253044330247, 3477.3393055319502, 3480.895573132807, 3545.9822700886493, 5608.747606357713, 5647.971760141194, 5710.628809127404, 5713.6000479966415, 5749.540036797057, 5666.886662266752, 5728.914066289009, 5728.971355143219, 5748.109043098327, 5755.0, 5180.2229665550185, 5227.660202086852, 5246.842594722146, 5269.156934890419, 5309.575233981292, 5311.548518375943, 5312.229726689628, 5316.362036555619, 5320.654157479771, 5321.122014867542, 5194.506521880416, 5245.029669511153, 5251.894962100756, 5260.473952604747, 5324.094903866352, 5246.921296180561, 5287.101192797234, 5302.310699609065, 5303.310569625963, 5317.899598134841, 5125.38495380553, 5158.458361872024, 5159.303494028296, 5241.42344342122, 5245.475452454724, 5585.888282234373, 5591.664500129965, 5599.272094627713, 5605.831825045255, 5707.543396528309, 6227.813165605039, 6236.314005459396, 6240.781572644981, 6242.594231374991, 6247.062940558907, 6117.541184411187, 6136.140940268366, 6241.875162496724, 6266.404691554295, 6270.2475702915945, 5779.017567013618, 5785.652860828363, 5786.855328616776, 5833.766649334064, 5838.12428135783, 5758.913616295759, 6266.968665156645, 6294.244690637152, 6317.273513545909, 6318.747250109944, 5988.461038506468, 6006.12911127884, 6065.696715164224, 6127.89207890682, 6144.7571636353305, 6142.662153581507, 6252.6873656317, 6265.404786545271, 6265.937340626627, 6267.843303917347, 6109.083637454418, 6163.630182188993, 6171.228596425447, 6172.783952561728, 6189.102580125947, 6096.420840020191, 6136.079588061826, 6167.814965551041, 6190.938090619036, 6204.100405441186, 4911.386076740408, 4911.803527858846, 4911.901761964741, 4917.557419832161, 4921.606271498272, 4032.1532478179324, 4221.3114754098, 4286.164197981364, 4407.4050003249795, 4456.710313829591, 5624.156376543469, 5684.573656975744, 5763.279590051244, 5792.565557583114, 5798.391168927286, 5187.351581052369, 6258.561900667, 6272.153259310026, 6280.371962803683, 6301.086342480315, 5641.0, 5724.484796368347, 5732.283464566929, 5739.626924249994, 5741.684207368635, 5315.096433606296, 5324.227986941949, 5381.596380271495, 5400.378956419983, 5413.323334583177, 5240.868978275574, 6292.937070629235, 6301.558890877686, 6329.145565348711, 6341.841453963503, 6153.261608606996, 6270.843228919313, 6333.050042493663, 6339.334369891095, 6339.366063393623, 5753.683547404933, 6138.987067133873, 6269.279032911091, 6318.147050148171, 6333.050042493663, 6160.397728122666, 6191.102290167811, 6200.410960958701, 6215.689215539114, 6220.0, 6101.368489499298, 6114.8448654109025, 6195.876082478235, 6260.624362538262, 6304.464120549621, 6092.573519853745, 6125.784909797739, 6131.682521312785, 6139.553468857771, 6143.542582966849, 4987.376577927759, 5911.55663325261, 6123.70969670409, 6128.662923539248, 6137.877242455215, 5736.971315143398, 5888.676122813286, 5920.904632642975, 5940.227770389822, 6020.397960203944, 5889.087191485327, 6092.603980741238, 6103.3591472894705, 6121.877562448637, 6123.8162855114415, 5919.467247947706, 5928.140419639214, 5945.286565612154, 5947.256592925884, 5959.314678811818], "unit": "score", "name": "dojo.html", "value": 5676.998268577148}, {"lowerIsBetter": false, "replicates": [503.90425819094395, 535.8928214357129, 545.2720617975006, 634.2610858350023, 635.5614625908124, 30424.0, 38392.232155356876, 38846.50381465667, 38955.0, 38992.0, 42010.7899460503, 42616.573834261726, 42680.14639707204, 42688.78655606725, 42786.0, 9464.763380915463, 9707.077827606367, 9711.223102151811, 9715.75710607237, 9719.611215551406, 9450.952745236264, 9603.135717785399, 9621.27840411972, 9637.951810240975, 9734.853977190347, 9700.223982081416, 9798.118169364756, 9798.951005244999, 9806.16647584956, 9807.0, 9694.806103877918, 9762.267829912715, 9774.56014479343, 9775.804483910353, 9785.412875227437, 9606.567704453246, 9713.514324283828, 9722.222222222204, 9744.610215591369, 9763.609455621767, 40324.79837600793, 40801.387979180334, 40839.38740918889, 40866.795666021775, 41007.179856402705, 3079.5996520452422, 3139.5133754268127, 3194.3132226571165, 3516.859325626972, 3792.791396473193, 28013.01954431585, 28055.0, 28142.296442588893, 28338.71661283402, 28376.0, 2695.43395886864, 2732.6584176977876, 2733.8223015503927, 2784.8329100253845, 2834.957475637867, 496927.0, 497414.0, 498696.0, 500051.0, 502389.0, 63999.36000639934, 65045.0, 65129.023064654066, 65293.67353163204, 65316.69366612641, 72985.27014729891, 74173.629131854, 74189.6290518544, 74365.0, 74368.25631743722, 16584.6683066338, 16825.747613785803, 16853.241604127845, 16875.746863797052, 16877.91561042187, 12855.035872309427, 12934.547290844963, 12950.740985180431, 12970.935145324212, 12973.221606703628, 21273.936303185088, 21627.459313516974, 21643.67534486984, 21684.0, 22108.88945555294, 8833.0, 9034.2320902724, 9041.276697864156, 9061.728148155566, 9127.90872091284, 968.2689569375077, 986.9654562090292, 1061.6496556136456, 1066.6213494209444, 1075.4622688655672, 29225.97709080172, 29260.0, 29701.554476682868, 30054.0, 30142.397152056838, 1103.3821060206149, 1128.5542210826677, 1130.9660710178707, 1131.5247596009697, 1170.53763763313, 14891.404343826125, 15024.924875375771, 15195.316210770541, 15247.542573722805, 15365.923170384076, 300507.0, 301646.0, 302138.0, 302537.0, 303715.0, 59438.0, 60025.4980876436, 60118.69940650269, 60130.0, 60316.698416507636, 1326.111505291457, 1445.7831325301288, 1448.3265281643876, 1463.0928824128896, 1585.5243426971863, 28331.43337133287, 28670.076088312337, 28910.421791564473, 28934.27664308325, 29178.124656260345, 33531.4970275451, 43549.56450435455, 44245.778771105935, 44364.55635443604, 44404.777976109915, 362862.0, 365042.0, 365345.0, 365820.0, 365833.1708341441, 28515.857420712764, 29031.85484072566, 32829.67170328362, 33378.33243335168, 33869.49195762115, 40930.79534602308, 42218.36672449854, 42736.35895461633, 42980.78509607557, 43073.78463107665, 35744.64255357413, 36549.634503654626, 36783.89648310555, 37608.247835043694, 37691.62308376991, 35407.645923541466, 35807.104822379646, 36180.09549761277, 36676.08309792277, 36824.26351473009, 35935.64064359428, 36319.818400907825, 36565.0, 36791.26417471582, 37138.814305928296, 31398.843005784824, 32335.0, 32343.514847276838, 32406.02781916546, 32445.51331729979, 23889.28332150038, 24079.398015049763, 24307.756922430548, 24557.263282101565, 24606.138785142433], "unit": "score", "name": "ext.html", "value": 19472.269623603755}, {"lowerIsBetter": false, "replicates": [364.37509670914386, 368.17528735632175, 368.5853414908228, 376.57070939129414, 378.45124569374394, 19549.02254887257, 20704.585908281824, 21660.56678866422, 21844.45388865279, 22180.0, 18577.349792757257, 19514.731542449765, 20865.26971555996, 21591.352259432202, 21676.024578893946, 5753.108268218422, 5965.1946987156825, 5998.670073145975, 6019.939800601982, 6049.818505444821, 5646.661200327973, 5976.462118409342, 5983.670898100603, 5985.16207730918, 5987.251593550806, 5901.911471327933, 5926.792562260322, 5927.051671732524, 5930.199423077873, 5930.733117009723, 5644.774209031634, 5893.0276504376725, 5911.29064512257, 5930.258717660293, 5943.078822782454, 5087.440381558025, 5110.156824124015, 5111.821086262, 5115.2327150927285, 5123.897522049539, 20426.38720838377, 26131.60802587963, 26450.338741531425, 26520.73479265202, 26565.0, 2108.4096452993185, 2254.1884921428436, 2669.9599506007426, 2685.207863680219, 2813.986964692709, 9680.893498204998, 10156.644517441853, 10189.490525473771, 10252.74368140795, 10286.691399258034, 1708.9145542722815, 1739.5129363778162, 1776.2806063544285, 1810.592616661254, 1823.124900047971, 70339.64830175816, 84922.0, 101160.49419752927, 105393.47303263511, 107670.46164769205, 11259.748050389955, 11435.714107147222, 11440.256383335056, 11477.71305717347, 11590.826137607943, 13735.725285494435, 13795.310234488436, 13797.862021379658, 13831.79252311216, 13839.723205535833, 7365.742199023116, 8264.214899584651, 8478.5336806475, 8637.870431943526, 8639.049704532496, 8579.82840343202, 8581.613827377783, 8604.956975215084, 8669.91330086691, 8678.739637810875, 4434.379186913835, 4469.262571675637, 4478.037221997286, 4482.39487669167, 4513.7066090704, 1655.8013038435465, 1866.188208129441, 1926.2776458827939, 1932.7050875913171, 1964.0866996846535, 898.2948385517337, 925.2551695884742, 971.4941840147743, 1042.524827369264, 1055.0399136785488, 17080.743788843178, 19577.804221957882, 19679.90160049219, 19856.50358741014, 20133.194672212947, 817.5462618246811, 948.2650945517279, 954.9761255968517, 981.3572110267786, 984.13396211335, 10588.57645694179, 10631.681049568526, 10850.45747712627, 10852.0, 11030.393328367018, 624566.0, 626315.0, 642712.0, 643976.0, 646746.0, 70168.0, 78908.0, 110915.0, 111211.0, 113062.86937130688, 987.8863930648067, 988.3822610868208, 998.6504723346916, 1014.3964341217112, 1017.0185770731132, 17571.0, 17729.645407091528, 18189.0, 18210.180541875383, 18390.89654620727, 48019.75990120027, 48568.0, 48825.511744883515, 50774.74612626913, 50865.237021443965, 69338.0, 70281.64859175672, 71410.64294678702, 73138.0, 73312.63343683248, 7791.961040194763, 7888.290053895177, 8029.759107226792, 8056.27493525562, 8297.875531866906, 12778.87221127814, 13210.94312454982, 13237.80143297832, 13596.86403135956, 13598.524051658145, 11498.425078746197, 11551.653450396501, 11702.590409335633, 11880.76238475243, 11908.166428349932, 11313.886861131283, 11385.975262226439, 11475.540978360772, 11532.538698451968, 11851.703707407383, 6163.106349579376, 9296.674616388394, 11813.0, 11816.881831181578, 11983.041356691618, 8090.474119182234, 8142.10436851934, 8261.958690206511, 8267.007959044953, 8489.533075680896, 11537.0, 11714.824277635671, 11810.881891180978, 11904.523819047141, 11990.362120333513], "unit": "score", "name": "jquery.html", "value": 9401.485802310077}, {"lowerIsBetter": false, "replicates": [1437.5543581489733, 1576.1725094325477, 1598.7362085255934, 1872.3166044393793, 2013.496625843539, 7975.800604984878, 8639.65441382344, 8772.868406973901, 8783.341249406289, 8793.340499462534, 8555.78610534737, 8782.516961567111, 8782.868256976135, 8783.956080219607, 8786.12138786121, 2183.1376606240524, 2433.841800282985, 2482.329770961839, 2508.109621084516, 2508.83692559983, 2501.6747822783104, 2514.9874250628723, 2518.4207632244593, 2522.583773677341, 2525.734797846227, 2367.041348253951, 2389.6893403857475, 2399.2802159352123, 2412.9155479558217, 2413.2036427978724, 2460.3603063203695, 2482.6276058591175, 2489.2034548944343, 2494.5010997800514, 2511.3470497670737, 2465.95068098637, 2470.765277298654, 2487.3035550046015, 2494.3639371960035, 2499.6500489931423, 8812.162844529823, 8878.911210887873, 8881.600327985256, 8883.289336853037, 8893.688720894803, 5420.83737487876, 5555.083411237141, 5569.081101618228, 5572.554195664337, 5580.776768929238, 3527.805970671612, 3529.0824385659657, 3595.532580764484, 3750.2312026034597, 3755.830987605537, 1035.1511760356511, 1046.1317106801412, 1053.0838170791385, 1055.9313644613076, 1058.62418841311, 11872.168948173632, 11883.881161188365, 11887.465064072137, 11910.987566056809, 11925.105617078754, 4863.610911127102, 4909.018196360742, 4996.600271978233, 5009.173486374781, 5022.723750193774, 10203.908198819372, 10209.081182693444, 10224.488775561193, 10227.02843229892, 10234.437105959243, 5549.611527193058, 5565.30433695788, 5568.1091025435735, 5568.164775283659, 5569.749361278752, 4448.599626033672, 4574.679772415965, 4834.20235661112, 4984.626153038536, 5055.9241611375855, 3959.148783011666, 4010.3984402339297, 4045.271851066836, 4054.2364071628936, 4084.673226141961, 1313.750387426386, 1321.7752981993085, 1322.6957799706122, 1329.6476433745065, 1341.275711116006, 1365.9248741319323, 1379.1931719943946, 1381.8341798984186, 1410.5768269519103, 1411.8941079419085, 8177.509349439053, 8215.424920255524, 8261.17388261181, 8272.503649780912, 8283.17168283167, 442.81180498288745, 523.1028785632658, 527.4514504914846, 530.8089087928342, 531.0414701463818, 6261.405166509175, 6285.968570157212, 6294.307626161119, 6306.180196574508, 6319.842003949846, 10123.848142277871, 10810.35137891729, 10826.837597436044, 10945.671629851116, 10959.0, 10414.895851041545, 10705.197110216764, 10776.946115269373, 10830.296030757976, 10838.40388778609, 8243.587820609066, 8321.708740194184, 8391.95804020976, 8393.95803020981, 8415.70545030921, 7806.921930780847, 7982.640781164978, 8004.5597492138495, 8011.83976320482, 8087.069986951576, 9380.484073375757, 9585.424874507551, 9664.130228279488, 9759.0, 9855.753606159617, 9622.230221582116, 9964.701058968243, 10058.497075146068, 10089.747756306151, 10128.03783640553, 6812.659367031728, 6867.141607299088, 7004.824879378057, 7558.773236802905, 7630.885536716843, 8126.674933002614, 8221.383396245425, 8243.381746368927, 8256.711015114442, 8259.876101858597, 7232.855342893218, 7309.926900730925, 7343.082114735658, 7455.664495097625, 7494.70021199146, 7220.664177127248, 7286.380657644159, 7322.926770732438, 7353.926460735324, 7423.517471364344, 7726.652300646597, 7801.609919504115, 7807.336376408069, 7815.726449574237, 7828.608569571613, 5897.203877476657, 6986.825329366807, 7091.042709234393, 7093.964530177316, 7094.574325540484, 7089.716411343488, 7161.2122666507685, 7178.5692858428665, 7184.640767961477, 7191.460640451883], "unit": "score", "name": "mootools.html", "value": 4881.166331286492}, {"lowerIsBetter": false, "replicates": [322.29739168612423, 326.2659017211275, 332.3585480023554, 333.16209732522697, 337.47354127560993, 6708.228553716324, 6724.125863637726, 6739.1239138912, 6755.290694477083, 6777.32226777322, 6686.063951046845, 6699.598024118556, 6717.697703603338, 6722.495812814034, 6724.663766811665, 4704.223803072489, 4804.231322988323, 4817.205161148424, 4836.2987366831785, 4986.975065124679, 4829.951700482985, 4841.176999910023, 4863.440704319013, 4918.704877707331, 4963.379577552806, 4850.199717046683, 4885.853424397274, 4888.388951381077, 4896.167651499253, 4903.950960490403, 4100.958990410088, 4767.951050768843, 4883.267509873512, 4886.951130488703, 4906.656534042619, 4005.1388951375593, 4037.2934736421007, 4131.235721391552, 4133.937990930139, 4139.875803725893, 6297.086922396227, 6323.810285691437, 6329.556931014831, 6336.112944187817, 6342.143810585604, 5643.633163844378, 5648.0, 5649.745761440704, 5655.349634792011, 5659.547236221092, 6975.093237879094, 6980.336867997532, 6990.895136572955, 6993.370596646276, 6999.300069993011, 4453.153900758845, 4613.123506533748, 4626.606738427237, 4627.467841198271, 4632.420947381577, 7422.183559808417, 7443.59060251686, 7457.576287706517, 7468.178500364956, 7473.103227612667, 4675.883102922386, 4715.339852420664, 4716.858494245178, 4721.055788842245, 4722.291656251589, 4791.760411979387, 4795.6163506919365, 4795.976020119877, 4798.616110711135, 4798.688085274516, 5635.774569017275, 5641.605087643826, 5642.85892852682, 5643.746031428595, 5649.378568357477, 5170.508801663836, 6794.45644348451, 7037.788866334018, 7061.399781018568, 7232.0598322217775, 1605.8233594304618, 1627.853493185619, 1634.6730653869035, 1635.337688236266, 1641.0563925742745, 1037.8910214427528, 1041.3803786746873, 1052.5737076484036, 1062.2086545523634, 1063.31416236527, 6422.42198202164, 6610.900836487456, 6670.299618540081, 6680.933190668128, 6752.020956961213, 7273.163586187656, 7354.154272258652, 7426.517276377018, 7439.51643143194, 7498.737544185928, 6716.891712867322, 6717.966410167918, 6718.294579069225, 6723.361280678328, 6728.831779205461, 3917.2557214129224, 3941.802909854553, 3944.3491823848744, 3955.7033222507853, 3962.40563915415, 7532.8493430132185, 7861.646225919847, 7872.055353357519, 7910.564918929399, 7922.841543169105, 7745.070591529053, 7765.068191816905, 7783.961080194563, 7806.024246969129, 7807.024121984752, 7880.566568838769, 7891.644875980594, 7894.921050789419, 7902.525848449111, 7914.287714105758, 7500.8499830002, 7506.624668766649, 7507.474476786572, 7508.249175082667, 7509.986151869428, 7064.834302340262, 7408.851822963618, 7418.480706350504, 7427.740029098955, 7440.590767507839, 7869.763907082796, 7925.167857374892, 7927.12801591836, 7931.881021784793, 7942.166072562298, 4623.976880115578, 4663.930041049319, 4684.063187362473, 4686.343911852276, 4686.554777296288, 6075.0, 7068.823279418056, 7480.887786683313, 7483.0, 7508.174100848793, 6116.908246376219, 7165.892511612435, 7178.0, 7232.0959880015, 7248.710051597877, 6133.478654314434, 7233.1681856587165, 7234.16807067173, 7244.239354867874, 7259.52813067149, 7011.894821577578, 7028.613426261605, 7040.542364746275, 7042.647867606702, 7045.542039767399, 5874.911876321944, 6984.441244700311, 7207.495475316678, 7214.89177662325, 7235.421166306788, 6742.93257067423, 6936.34104760047, 7044.0, 7062.081929349151, 7085.362317391459], "unit": "score", "name": "prototype.html", "value": 5206.198313789742}, {"lowerIsBetter": false, "replicates": [694.9166100067991, 699.7585832887655, 710.9502334836557, 737.4211244173325, 815.1481701621805, 15237.923810380946, 15451.918365714377, 15468.69062618747, 15474.38102475901, 15479.14864682442, 14070.64823379416, 14236.217008064552, 14500.782488262685, 14536.0, 14546.272686365666, 740.8184994676285, 914.4239129348517, 922.1331947968921, 934.444005816538, 935.7473482159813, 750.2422553221231, 752.6537792615403, 755.6297414266998, 757.2957149850637, 921.3136213520936, 990.4898977026837, 992.1864071461405, 993.135971704618, 994.1053052252994, 995.9502024898762, 989.3717489394251, 990.128686755654, 990.9851352229722, 991.9652812151612, 993.0417147452671, 579.6522086747959, 583.9416058394169, 584.2638275772557, 585.7803323753592, 736.8047467421138, 12429.440675169639, 15469.922650386789, 15478.45825396117, 15478.5356439307, 15542.456014039568, 12472.875271247261, 12479.56321528742, 12736.872631273754, 12842.486300547967, 13087.541936032194, 10010.04904534068, 10064.642175406032, 10121.746956326077, 10176.847347289797, 10506.369617822955, 3476.4263896457055, 3507.771994820354, 3547.0600290922926, 3556.4309710446464, 3676.062604035954, 85070.14929850685, 85193.72209416864, 85376.57311713464, 85408.14591854127, 85441.99999999937, 9497.620095196253, 9556.808863822685, 9587.520623968774, 9744.512774361396, 9947.303688741718, 20896.89551552263, 21164.94175291229, 21179.470513236985, 21186.470338241357, 21210.681839772416, 7575.810604734926, 7667.769966901002, 7694.192109828499, 8022.1175670676175, 8102.554359510284, 4133.359329303903, 4143.97928010364, 4182.623563879265, 4239.172969947389, 4416.315471101984, 3622.9094272643397, 3665.6151104133683, 3668.413053911361, 3674.283514714605, 3677.0807298175455, 659.66686823154, 665.8235567574596, 666.5201055240219, 667.3226674924955, 672.3444641474523, 567.9379560222328, 578.3320265093739, 609.9542534309855, 613.1140501974604, 626.7399029402837, 8064.435489515795, 8139.267465928095, 8267.793305167299, 8309.252167304972, 8327.625256863455, 485.7959656944092, 521.8199721096215, 572.6964708704394, 611.413043478257, 620.7423919073624, 3734.2344819311975, 3824.9235015299537, 3849.4610754494392, 4070.61329173728, 4219.831206751757, 90149.0, 92580.0, 92691.0, 92741.53629231811, 93699.0, 75366.0, 75747.24252757512, 77172.22827771651, 77523.22476775273, 80062.0, 59000.40999590035, 64131.717365652425, 68178.31821681719, 68182.9772553412, 68416.315836842, 6982.930170698228, 8413.284870785807, 8530.829383412172, 8540.060593334852, 8662.090480499457, 46468.7676561615, 48528.0, 49818.75090624524, 49873.00253994827, 52169.739151304, 62858.685706571174, 71523.21191970243, 71874.0, 71945.56108877898, 73149.0, 10770.887982366175, 11023.44882755875, 11186.776264474502, 11255.493502792559, 11385.601503947322, 11055.944720276348, 11997.64007079789, 12059.81910271329, 12082.51669933228, 12381.566645167375, 11229.71925701864, 11285.887141128813, 11490.712732181762, 11573.305601663928, 11896.821547676618, 11351.829722554003, 11559.0, 11561.42192890369, 11779.116566257393, 11854.881451185378, 11183.440827958731, 11543.88456115428, 11634.360110193682, 11695.356755378196, 11753.236039657395, 9424.434533927986, 9639.807203855744, 9645.71062868115, 9658.468784216935, 9815.0, 9599.856002160113, 9679.419234845931, 9713.125818676353, 9723.465209413267, 9757.365771224848], "unit": "score", "name": "yui.html", "value": 6930.881370302325}], "name": "dromaeo_css", "value": 7535.287160997373}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 111.0, 121.0, 162.0, 162.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.9}, {"lowerIsBetter": true, "replicates": [157.0, 118.0, 142.0, 159.0, 116.0, 141.0, 137.0, 117.0, 197.0, 145.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [190.0, 184.0, 188.0, 186.0, 186.0, 188.0, 184.0, 181.0, 180.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 88.0, 78.0, 74.0, 46.0, 56.0, 77.0, 104.0, 82.0], "unit": "score", "name": "audio-fft", "value": 75.2}, {"lowerIsBetter": true, "replicates": [89.0, 104.0, 169.0, 119.0, 105.0, 90.0, 116.0, 76.0, 78.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 94.0, 133.0, 85.0, 88.0, 85.0, 87.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 95.0, 92.0, 93.0, 94.0, 94.0, 102.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 99.9}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 53.0, 53.0, 52.0, 53.0, 56.0, 64.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 72.0, 74.0, 70.0, 66.0, 65.0, 69.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [127.0, 132.0, 130.0, 128.0, 127.0, 131.0, 129.0, 122.0, 131.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.8}, {"lowerIsBetter": true, "replicates": [145.0, 171.0, 179.0, 137.0, 137.0, 140.0, 138.0, 136.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1453.0}]} 14:45:34 INFO - Return code: 0 14:45:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:45:34 ERROR - # TBPL SUCCESS # 14:45:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:45:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:45:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:45:34 INFO - 2016-03-09 14:45:34.635 screenresolution[1681:10015] starting screenresolution argv=screenresolution get 14:45:34 INFO - 2016-03-09 14:45:34.637 screenresolution[1681:10015] Display 0: 1600x1200x32@60 14:45:34 INFO - 2016-03-09 14:45:34.643 screenresolution[1682:10018] starting screenresolution argv=screenresolution list 14:45:34 INFO - Available Modes on Display 0 14:45:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:45:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:45:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:45:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:45:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:45:34 INFO - Intel Iris: 14:45:34 INFO - Chipset Model: Intel Iris 14:45:34 INFO - Type: GPU 14:45:34 INFO - Bus: Built-In 14:45:34 INFO - VRAM (Dynamic, Max): 1536 MB 14:45:34 INFO - Vendor: Intel (0x8086) 14:45:34 INFO - Device ID: 0x0a2e 14:45:34 INFO - Revision ID: 0x0009 14:45:34 INFO - Displays: 14:45:34 INFO - Display: 14:45:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:45:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:45:34 INFO - Display Serial Number: 1600x1200 60 14:45:34 INFO - Main Display: Yes 14:45:34 INFO - Mirror: Off 14:45:34 INFO - Online: Yes 14:45:34 INFO - Rotation: Supported 14:45:34 INFO - Return code: 0 14:45:34 INFO - Running post-action listener: _resource_record_post_action 14:45:34 INFO - Running post-run listener: _resource_record_post_run 14:45:35 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39593472; Write bytes: 705672192; Read time: 440; Write time: 2031 14:45:35 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402203136; Write bytes: 405155328; Read time: 30466; Write time: 790 14:45:35 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37770752; Write bytes: 299668992; Read time: 420; Write time: 1239 14:45:35 INFO - Running post-run listener: _upload_blobber_files 14:45:35 INFO - Blob upload gear active. 14:45:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:45:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:45:36 INFO - (blobuploader) - INFO - Open directory for files ... 14:45:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:45:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:45:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:37 INFO - (blobuploader) - INFO - Done attempting. 14:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:45:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:38 INFO - (blobuploader) - INFO - Done attempting. 14:45:38 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:38 INFO - Return code: 0 14:45:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dbc9b5181491d238eca0bf98c6fd0a030d2f431fc3da73189229a91d2537aec33639065276bc5f272de9c7d485d836b28047b5287bb51bacdb78fbee376601a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0daaa5855de04a1716178b5a07cd9f8ea9ce8faccf066675173cd7dedf2e245c9ff30fb16da5bed3e952d81f69adc43e55d3fc312fb4b3443c319c87eac6be3f"} 14:45:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:38 INFO - Contents: 14:45:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2dbc9b5181491d238eca0bf98c6fd0a030d2f431fc3da73189229a91d2537aec33639065276bc5f272de9c7d485d836b28047b5287bb51bacdb78fbee376601a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0daaa5855de04a1716178b5a07cd9f8ea9ce8faccf066675173cd7dedf2e245c9ff30fb16da5bed3e952d81f69adc43e55d3fc312fb4b3443c319c87eac6be3f"} 14:45:38 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:38 INFO - Copying logs to upload dir... 14:45:38 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.795337 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-09 14:45:38.519138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 14:45:38.522253) ========= 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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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/2dbc9b5181491d238eca0bf98c6fd0a030d2f431fc3da73189229a91d2537aec33639065276bc5f272de9c7d485d836b28047b5287bb51bacdb78fbee376601a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0daaa5855de04a1716178b5a07cd9f8ea9ce8faccf066675173cd7dedf2e245c9ff30fb16da5bed3e952d81f69adc43e55d3fc312fb4b3443c319c87eac6be3f"} build_url:https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/F-7rPuHpQea_NIsUt-_KZQ/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/2dbc9b5181491d238eca0bf98c6fd0a030d2f431fc3da73189229a91d2537aec33639065276bc5f272de9c7d485d836b28047b5287bb51bacdb78fbee376601a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0daaa5855de04a1716178b5a07cd9f8ea9ce8faccf066675173cd7dedf2e245c9ff30fb16da5bed3e952d81f69adc43e55d3fc312fb4b3443c319c87eac6be3f"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 14:45:38.955293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:45:38.955611) ========= 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.BOHQ9Kwrs4/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.dmSQFH6tRg/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.004930 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 14:45:39.004662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 14:45:39.004978) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 14:45:39.005355) ========= ========= Total master_lag: 0.69 =========