builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0158 starttime: 1460095155.69 results: success (0) buildid: 20160407220538 builduid: c50cd10d59474e33af57162747c82975 revision: 34293bb847d1e28198d596a87ea4baf96bfb0286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.687470) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.687942) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.688227) ========= 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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005584 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.715024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.715300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.736784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.737138) ========= 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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005590 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.788949) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.789244) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.789618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.789910) ========= 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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 22:59:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.3M=0.001s 2016-04-07 22:59:15 (16.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.964947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:15.965284) ========= 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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.035298 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:16.018207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 22:59:16.021563) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34293bb847d1e28198d596a87ea4baf96bfb0286 --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 34293bb847d1e28198d596a87ea4baf96bfb0286 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 22:59:15,974 truncating revision to first 12 chars 2016-04-07 22:59:15,974 Setting DEBUG logging. 2016-04-07 22:59:15,974 attempt 1/10 2016-04-07 22:59:15,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34293bb847d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 22:59:16,833 unpacking tar archive at: fx-team-34293bb847d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.106603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 22:59:17.147682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:17.148040) ========= echo 34293bb847d1e28198d596a87ea4baf96bfb0286 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'34293bb847d1e28198d596a87ea4baf96bfb0286'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 34293bb847d1e28198d596a87ea4baf96bfb0286 program finished with exit code 0 elapsedTime=0.005254 script_repo_revision: '34293bb847d1e28198d596a87ea4baf96bfb0286' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:17.200292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:17.200632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 22:59:17.218463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-07 22:59:17.218754) ========= /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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:17 INFO - MultiFileLogger online at 20160407 22:59:17 in /builds/slave/test 22:59:17 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 22:59:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:59:17 INFO - {'append_to_log': False, 22:59:17 INFO - 'base_work_dir': '/builds/slave/test', 22:59:17 INFO - 'blob_upload_branch': 'Fx-Team', 22:59:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:59:17 INFO - 'branch': 'Fx-Team', 22:59:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:59:17 INFO - 'config_files': ('talos/mac_config.py',), 22:59:17 INFO - 'default_actions': ('clobber', 22:59:17 INFO - 'read-buildbot-config', 22:59:17 INFO - 'download-and-extract', 22:59:17 INFO - 'populate-webroot', 22:59:17 INFO - 'create-virtualenv', 22:59:17 INFO - 'install', 22:59:17 INFO - 'run-tests'), 22:59:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:59:17 INFO - 'download_minidump_stackwalk': True, 22:59:17 INFO - 'download_symbols': 'ondemand', 22:59:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:59:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:59:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:59:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:59:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:59:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:59:17 INFO - 'installer_path': 'installer.exe', 22:59:17 INFO - 'log_level': 'info', 22:59:17 INFO - 'log_name': 'talos', 22:59:17 INFO - 'log_to_console': True, 22:59:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:59:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:59:17 INFO - 'opt_config_files': (), 22:59:17 INFO - 'pip_index': False, 22:59:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:59:17 INFO - 'cmd': ('bash', 22:59:17 INFO - '-c', 22:59:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:59:17 INFO - 'enabled': True, 22:59:17 INFO - 'halt_on_failure': False, 22:59:17 INFO - 'name': 'check_screen_resolution'},), 22:59:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:59:17 INFO - 'cmd': ('bash', 22:59:17 INFO - '-c', 22:59:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:59:17 INFO - 'enabled': True, 22:59:17 INFO - 'halt_on_failure': False, 22:59:17 INFO - 'name': 'check_screen_resolution'},), 22:59:17 INFO - 'run_cmd_checks_enabled': True, 22:59:17 INFO - 'sps_profile': False, 22:59:17 INFO - 'sps_profile_interval': 0, 22:59:17 INFO - 'suite': 'dromaeojs', 22:59:17 INFO - 'system_bits': '32', 22:59:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:59:17 INFO - 'title': 't-yosemite-r7-0158', 22:59:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:59:17 INFO - 'use_talos_json': True, 22:59:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:59:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:59:17 INFO - 'work_dir': 'build'} 22:59:17 INFO - ##### 22:59:17 INFO - ##### Running clobber step. 22:59:17 INFO - ##### 22:59:17 INFO - Running pre-action listener: _resource_record_pre_action 22:59:17 INFO - Running main action method: clobber 22:59:17 INFO - rmtree: /builds/slave/test/build 22:59:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:59:18 INFO - Running post-action listener: _resource_record_post_action 22:59:18 INFO - ##### 22:59:18 INFO - ##### Running read-buildbot-config step. 22:59:18 INFO - ##### 22:59:18 INFO - Running pre-action listener: _resource_record_pre_action 22:59:18 INFO - Running main action method: read_buildbot_config 22:59:18 INFO - Using buildbot properties: 22:59:18 INFO - { 22:59:18 INFO - "project": "", 22:59:18 INFO - "product": "firefox", 22:59:18 INFO - "script_repo_revision": "production", 22:59:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:59:18 INFO - "repository": "", 22:59:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:59:18 INFO - "buildid": "20160407220538", 22:59:18 INFO - "pgo_build": "False", 22:59:18 INFO - "basedir": "/builds/slave/test", 22:59:18 INFO - "buildnumber": 691, 22:59:18 INFO - "slavename": "t-yosemite-r7-0158", 22:59:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:59:18 INFO - "platform": "yosemite_r7", 22:59:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:59:18 INFO - "branch": "fx-team", 22:59:18 INFO - "repo_path": "integration/fx-team", 22:59:18 INFO - "revision": "34293bb847d1e28198d596a87ea4baf96bfb0286", 22:59:18 INFO - "stage_platform": "macosx64", 22:59:18 INFO - "builduid": "c50cd10d59474e33af57162747c82975", 22:59:18 INFO - "slavebuilddir": "test" 22:59:18 INFO - } 22:59:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:59:18 INFO - Running post-action listener: _resource_record_post_action 22:59:18 INFO - ##### 22:59:18 INFO - ##### Running download-and-extract step. 22:59:18 INFO - ##### 22:59:18 INFO - Running pre-action listener: _resource_record_pre_action 22:59:18 INFO - Running main action method: download_and_extract 22:59:18 INFO - mkdir: /builds/slave/test/build/tests 22:59:18 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')]} 22:59:18 INFO - https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:21 INFO - Downloaded 1199 bytes. 22:59:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:59:21 INFO - Using the following test package requirements: 22:59:21 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:59:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:59:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:59:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'jsshell-mac.zip'], 22:59:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:59:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:59:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:59:21 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:59:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:59:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:59:21 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:59:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:59:21 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')]} 22:59:21 INFO - https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:59:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:59:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:59:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:23 INFO - Downloaded 18014556 bytes. 22:59:23 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'] 22:59:23 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 22:59:26 INFO - Return code: 0 22:59:26 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 22:59:26 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')]} 22:59:26 INFO - https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:28 INFO - Downloaded 18014556 bytes. 22:59:28 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'] 22:59:28 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 22:59:32 INFO - Return code: 0 22:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:32 INFO - https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:33 INFO - Downloaded 10847693 bytes. 22:59:33 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'] 22:59:33 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 22:59:33 INFO - Return code: 0 22:59:33 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')]} 22:59:33 INFO - https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eARAgOM4TKGKsrAij7VXYg/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 22:59:36 INFO - Downloaded 108783970 bytes. 22:59:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:59:36 INFO - mkdir: /builds/slave/test/properties 22:59:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:59:36 INFO - Writing to file /builds/slave/test/properties/build_url 22:59:36 INFO - Contents: 22:59:36 INFO - build_url:https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:59:37 INFO - Running post-action listener: _resource_record_post_action 22:59:37 INFO - Running post-action listener: set_extra_try_arguments 22:59:37 INFO - ##### 22:59:37 INFO - ##### Running populate-webroot step. 22:59:37 INFO - ##### 22:59:37 INFO - Running pre-action listener: _resource_record_pre_action 22:59:37 INFO - Running main action method: populate_webroot 22:59:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:59:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:59:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:59:37 INFO - '--tppagecycles', 22:59:37 INFO - '7'], 22:59:37 INFO - 'tests': ['tsvgm']}}, 22:59:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:59:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:59:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:59:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:59:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:59:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['damp', 'tps']}, 22:59:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'tests': ['damp', 'tps']}, 22:59:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['dromaeo_dom']}, 22:59:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:59:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['a11yr', 22:59:37 INFO - 'ts_paint', 22:59:37 INFO - 'tpaint', 22:59:37 INFO - 'sessionrestore', 22:59:37 INFO - 'sessionrestore_no_auto_restore', 22:59:37 INFO - 'tabpaint']}, 22:59:37 INFO - 'other-e10s': {'tests': ['a11yr', 22:59:37 INFO - 'ts_paint', 22:59:37 INFO - 'tpaint', 22:59:37 INFO - 'sessionrestore', 22:59:37 INFO - 'sessionrestore_no_auto_restore', 22:59:37 INFO - 'tabpaint']}, 22:59:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:59:37 INFO - 'ts_paint', 22:59:37 INFO - 'tpaint', 22:59:37 INFO - 'sessionrestore', 22:59:37 INFO - 'sessionrestore_no_auto_restore', 22:59:37 INFO - 'tabpaint']}, 22:59:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:59:37 INFO - 'ts_paint', 22:59:37 INFO - 'tpaint', 22:59:37 INFO - 'sessionrestore', 22:59:37 INFO - 'sessionrestore_no_auto_restore', 22:59:37 INFO - 'tabpaint']}, 22:59:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['a11yr', 22:59:37 INFO - 'ts_paint', 22:59:37 INFO - 'tpaint', 22:59:37 INFO - 'sessionrestore', 22:59:37 INFO - 'sessionrestore_no_auto_restore', 22:59:37 INFO - 'tabpaint']}, 22:59:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['a11yr', 22:59:37 INFO - 'ts_paint', 22:59:37 INFO - 'tpaint', 22:59:37 INFO - 'sessionrestore', 22:59:37 INFO - 'sessionrestore_no_auto_restore', 22:59:37 INFO - 'tabpaint']}, 22:59:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['tsvgx', 22:59:37 INFO - 'tsvgr_opacity', 22:59:37 INFO - 'tart', 22:59:37 INFO - 'tscrollx', 22:59:37 INFO - 'cart']}, 22:59:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:59:37 INFO - 'tsvgr_opacity', 22:59:37 INFO - 'tart', 22:59:37 INFO - 'tscrollx', 22:59:37 INFO - 'cart']}, 22:59:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'talos_options': ['--disable-e10s'], 22:59:37 INFO - 'tests': ['tp5o']}, 22:59:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'tests': ['tp5o']}, 22:59:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'talos_options': ['--disable-e10s', 22:59:37 INFO - '--xperf_path', 22:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:37 INFO - 'tests': ['tp5n']}, 22:59:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:59:37 INFO - 'talos_options': ['--xperf_path', 22:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:59:37 INFO - 'tests': ['tp5n']}}, 22:59:37 INFO - 'talos.zip': {'path': '', 22:59:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:59:37 INFO - Running post-action listener: _resource_record_post_action 22:59:37 INFO - ##### 22:59:37 INFO - ##### Running create-virtualenv step. 22:59:37 INFO - ##### 22:59:37 INFO - Running pre-action listener: _resource_record_pre_action 22:59:37 INFO - Running main action method: create_virtualenv 22:59:37 INFO - Creating virtualenv /builds/slave/test/build/venv 22:59:37 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 22:59:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:59:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:59:37 INFO - Using real prefix '/tools/python27' 22:59:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 22:59:41 INFO - Installing pip.................done. 22:59:41 INFO - Return code: 0 22:59:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 22:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:59:41 INFO - 'HOME': '/Users/cltbld', 22:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:59:41 INFO - 'LOGNAME': 'cltbld', 22:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:41 INFO - 'MOZ_NO_REMOTE': '1', 22:59:41 INFO - 'NO_EM_RESTART': '1', 22:59:41 INFO - 'PAGER': '/bin/cat', 22:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:41 INFO - 'PWD': '/builds/slave/test', 22:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:59:41 INFO - 'SHELL': '/bin/bash', 22:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 22:59:41 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 22:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:59:41 INFO - 'USER': 'cltbld', 22:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:41 INFO - 'XPC_FLAGS': '0x0', 22:59:41 INFO - 'XPC_SERVICE_NAME': '0', 22:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:41 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 22:59:41 INFO - Cleaning up... 22:59:41 INFO - Return code: 0 22:59:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 22:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:59:41 INFO - 'HOME': '/Users/cltbld', 22:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:59:41 INFO - 'LOGNAME': 'cltbld', 22:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:41 INFO - 'MOZ_NO_REMOTE': '1', 22:59:41 INFO - 'NO_EM_RESTART': '1', 22:59:41 INFO - 'PAGER': '/bin/cat', 22:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:41 INFO - 'PWD': '/builds/slave/test', 22:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:59:41 INFO - 'SHELL': '/bin/bash', 22:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 22:59:41 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 22:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:59:41 INFO - 'USER': 'cltbld', 22:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:41 INFO - 'XPC_FLAGS': '0x0', 22:59:41 INFO - 'XPC_SERVICE_NAME': '0', 22:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:41 INFO - Downloading/unpacking psutil>=0.7.1 22:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:44 INFO - Installing collected packages: psutil 22:59:44 INFO - Running setup.py install for psutil 22:59:44 INFO - building 'psutil._psutil_osx' extension 22:59:44 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 22:59:45 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 22:59:45 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 22:59:45 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 22:59:45 INFO - building 'psutil._psutil_posix' extension 22:59:45 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 22:59:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:59:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:59:45 INFO - ^ 22:59:45 INFO - 1 warning generated. 22:59:45 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 22:59:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:45 INFO - Successfully installed psutil 22:59:45 INFO - Cleaning up... 22:59:45 INFO - Return code: 0 22:59:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:59:45 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')]} 22:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:45 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')]} 22:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:45 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:45 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 22:59:45 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 22:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 22:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:59:45 INFO - 'HOME': '/Users/cltbld', 22:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:59:45 INFO - 'LOGNAME': 'cltbld', 22:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:45 INFO - 'MOZ_NO_REMOTE': '1', 22:59:45 INFO - 'NO_EM_RESTART': '1', 22:59:45 INFO - 'PAGER': '/bin/cat', 22:59:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:45 INFO - 'PWD': '/builds/slave/test', 22:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:59:45 INFO - 'SHELL': '/bin/bash', 22:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 22:59:45 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 22:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:59:45 INFO - 'USER': 'cltbld', 22:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:45 INFO - 'XPC_FLAGS': '0x0', 22:59:45 INFO - 'XPC_SERVICE_NAME': '0', 22:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:59:45 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 22:59:45 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 22:59:45 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 22:59:45 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 22:59:45 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 22:59:45 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 22:59:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:59:48 INFO - Installing collected packages: mozsystemmonitor 22:59:48 INFO - Running setup.py install for mozsystemmonitor 22:59:48 INFO - Successfully installed mozsystemmonitor 22:59:48 INFO - Cleaning up... 22:59:48 INFO - Return code: 0 22:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:48 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:48 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 22:59:48 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 22:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 22:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:59:48 INFO - 'HOME': '/Users/cltbld', 22:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:59:48 INFO - 'LOGNAME': 'cltbld', 22:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:48 INFO - 'MOZ_NO_REMOTE': '1', 22:59:48 INFO - 'NO_EM_RESTART': '1', 22:59:48 INFO - 'PAGER': '/bin/cat', 22:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:48 INFO - 'PWD': '/builds/slave/test', 22:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:59:48 INFO - 'SHELL': '/bin/bash', 22:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 22:59:48 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 22:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:59:48 INFO - 'USER': 'cltbld', 22:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:48 INFO - 'XPC_FLAGS': '0x0', 22:59:48 INFO - 'XPC_SERVICE_NAME': '0', 22:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:59:48 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 22:59:48 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 22:59:48 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 22:59:48 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 22:59:48 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 22:59:48 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 22:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:59:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 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 22:59:51 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 22:59:52 INFO - Downloading docopt-0.6.1.tar.gz 22:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:52 INFO - Running setup.py install for blobuploader 22:59:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:59:52 INFO - Running setup.py install for requests 22:59:53 INFO - Running setup.py install for docopt 22:59:53 INFO - Successfully installed blobuploader requests docopt 22:59:53 INFO - Cleaning up... 22:59:53 INFO - Return code: 0 22:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:53 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:53 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 22:59:53 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 22:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 22:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:59:53 INFO - 'HOME': '/Users/cltbld', 22:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:59:53 INFO - 'LOGNAME': 'cltbld', 22:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:53 INFO - 'MOZ_NO_REMOTE': '1', 22:59:53 INFO - 'NO_EM_RESTART': '1', 22:59:53 INFO - 'PAGER': '/bin/cat', 22:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:53 INFO - 'PWD': '/builds/slave/test', 22:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:59:53 INFO - 'SHELL': '/bin/bash', 22:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 22:59:53 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 22:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:59:53 INFO - 'USER': 'cltbld', 22:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:53 INFO - 'XPC_FLAGS': '0x0', 22:59:53 INFO - 'XPC_SERVICE_NAME': '0', 22:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-CHw0Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-lRHM4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-5ryqWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:53 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Ff1CA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-SlHeXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-6YjmkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-aFZdYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-2rxO5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-MZioIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-FCKPKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-eUqWgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-s7m3pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:54 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-DyTsbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:55 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-_0hhOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:55 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-QFaQr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:55 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ch8WCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:55 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-g_Q26P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:55 INFO - Running setup.py install for manifestparser 22:59:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:59:55 INFO - Running setup.py install for mozcrash 22:59:55 INFO - Running setup.py install for mozdebug 22:59:55 INFO - Running setup.py install for mozdevice 22:59:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Running setup.py install for mozfile 22:59:56 INFO - Running setup.py install for mozhttpd 22:59:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Running setup.py install for mozinfo 22:59:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Running setup.py install for mozInstall 22:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Running setup.py install for mozleak 22:59:56 INFO - Running setup.py install for mozlog 22:59:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:59:56 INFO - Running setup.py install for moznetwork 22:59:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:59:57 INFO - Running setup.py install for mozprocess 22:59:57 INFO - Running setup.py install for mozprofile 22:59:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:59:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:59:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:59:57 INFO - Running setup.py install for mozrunner 22:59:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:59:57 INFO - Running setup.py install for mozscreenshot 22:59:57 INFO - Running setup.py install for moztest 22:59:57 INFO - Running setup.py install for mozversion 22:59:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:57 INFO - Cleaning up... 22:59:58 INFO - Return code: 0 22:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:58 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 22:59:58 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 22:59:58 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 22:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 22:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:59:58 INFO - 'HOME': '/Users/cltbld', 22:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:59:58 INFO - 'LOGNAME': 'cltbld', 22:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:58 INFO - 'MOZ_NO_REMOTE': '1', 22:59:58 INFO - 'NO_EM_RESTART': '1', 22:59:58 INFO - 'PAGER': '/bin/cat', 22:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:58 INFO - 'PWD': '/builds/slave/test', 22:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:59:58 INFO - 'SHELL': '/bin/bash', 22:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 22:59:58 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 22:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:59:58 INFO - 'USER': 'cltbld', 22:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:58 INFO - 'XPC_FLAGS': '0x0', 22:59:58 INFO - 'XPC_SERVICE_NAME': '0', 22:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XW0mR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:58 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)) 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-JGnjSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:58 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)) 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Xd_ocP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:58 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)) 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-cD20__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:58 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)) 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-128acg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:58 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)) 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Bmek6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:58 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)) 22:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:58 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ddt3g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-oWeVsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-8G7ME9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-UKckM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-U2nGlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-FnRgpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-GIlBBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-lQ7lr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-oD5rB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ukG_aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:59 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)) 22:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:59 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-18zvFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:00:00 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)) 23:00:00 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)) 23:00:00 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)) 23:00:00 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)) 23:00:00 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)) 23:00:00 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)) 23:00:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:00:00 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 23:00:00 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 23:00:00 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 23:00:00 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 23:00:00 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 23:00:00 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 23:00:02 INFO - Downloading blessings-1.6.tar.gz 23:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:00:02 INFO - Installing collected packages: blessings 23:00:02 INFO - Running setup.py install for blessings 23:00:02 INFO - Successfully installed blessings 23:00:02 INFO - Cleaning up... 23:00:02 INFO - Return code: 0 23:00:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:00:03 INFO - Reading from file tmpfile_stdout 23:00:03 INFO - Current package versions: 23:00:03 INFO - blessings == 1.6 23:00:03 INFO - blobuploader == 1.2.4 23:00:03 INFO - docopt == 0.6.1 23:00:03 INFO - manifestparser == 1.1 23:00:03 INFO - mozInstall == 1.12 23:00:03 INFO - mozcrash == 0.17 23:00:03 INFO - mozdebug == 0.1 23:00:03 INFO - mozdevice == 0.48 23:00:03 INFO - mozfile == 1.2 23:00:03 INFO - mozhttpd == 0.7 23:00:03 INFO - mozinfo == 0.9 23:00:03 INFO - mozleak == 0.1 23:00:03 INFO - mozlog == 3.1 23:00:03 INFO - moznetwork == 0.27 23:00:03 INFO - mozprocess == 0.22 23:00:03 INFO - mozprofile == 0.28 23:00:03 INFO - mozrunner == 6.11 23:00:03 INFO - mozscreenshot == 0.1 23:00:03 INFO - mozsystemmonitor == 0.0 23:00:03 INFO - moztest == 0.7 23:00:03 INFO - mozversion == 1.4 23:00:03 INFO - psutil == 3.1.1 23:00:03 INFO - requests == 1.2.3 23:00:03 INFO - wsgiref == 0.1.2 23:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:03 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 23:00:03 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 23:00:03 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 23:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 23:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:00:03 INFO - 'HOME': '/Users/cltbld', 23:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:00:03 INFO - 'LOGNAME': 'cltbld', 23:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:03 INFO - 'MOZ_NO_REMOTE': '1', 23:00:03 INFO - 'NO_EM_RESTART': '1', 23:00:03 INFO - 'PAGER': '/bin/cat', 23:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:03 INFO - 'PWD': '/builds/slave/test', 23:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:00:03 INFO - 'SHELL': '/bin/bash', 23:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 23:00:03 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 23:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:00:03 INFO - 'USER': 'cltbld', 23:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:03 INFO - 'XPC_FLAGS': '0x0', 23:00:03 INFO - 'XPC_SERVICE_NAME': '0', 23:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 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)) 23:00:03 INFO - Cleaning up... 23:00:03 INFO - Return code: 0 23:00:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:03 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 23:00:03 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 23:00:03 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 23:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 23:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:00:03 INFO - 'HOME': '/Users/cltbld', 23:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:00:03 INFO - 'LOGNAME': 'cltbld', 23:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:03 INFO - 'MOZ_NO_REMOTE': '1', 23:00:03 INFO - 'NO_EM_RESTART': '1', 23:00:03 INFO - 'PAGER': '/bin/cat', 23:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:03 INFO - 'PWD': '/builds/slave/test', 23:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:00:03 INFO - 'SHELL': '/bin/bash', 23:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 23:00:03 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 23:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:00:03 INFO - 'USER': 'cltbld', 23:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:03 INFO - 'XPC_FLAGS': '0x0', 23:00:03 INFO - 'XPC_SERVICE_NAME': '0', 23:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:03 INFO - Downloading/unpacking jsonschema 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:00:06 INFO - Downloading/unpacking functools32 (from jsonschema) 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00:06 INFO - Downloading functools32-3.2.3-2.tar.gz 23:00:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:00:06 INFO - warning: no files found matching '*.txt' 23:00:06 INFO - no previously-included directories found matching 'build' 23:00:06 INFO - no previously-included directories found matching 'dist' 23:00:06 INFO - no previously-included directories found matching '.git*' 23:00:06 INFO - Installing collected packages: jsonschema, functools32 23:00:06 INFO - Running setup.py install for functools32 23:00:06 INFO - warning: no files found matching '*.txt' 23:00:06 INFO - no previously-included directories found matching 'build' 23:00:06 INFO - no previously-included directories found matching 'dist' 23:00:06 INFO - no previously-included directories found matching '.git*' 23:00:06 INFO - Successfully installed jsonschema functools32 23:00:06 INFO - Cleaning up... 23:00:06 INFO - Return code: 0 23:00:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:00:06 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')]} 23:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:06 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')]} 23:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:06 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 0x1044cca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044dc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa193c85ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, '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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 23:00:06 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 23:00:06 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 23:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 23:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:00:06 INFO - 'HOME': '/Users/cltbld', 23:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:00:06 INFO - 'LOGNAME': 'cltbld', 23:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:06 INFO - 'MOZ_NO_REMOTE': '1', 23:00:06 INFO - 'NO_EM_RESTART': '1', 23:00:06 INFO - 'PAGER': '/bin/cat', 23:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:06 INFO - 'PWD': '/builds/slave/test', 23:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:00:06 INFO - 'SHELL': '/bin/bash', 23:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 23:00:06 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 23:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:00:06 INFO - 'USER': 'cltbld', 23:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:06 INFO - 'XPC_FLAGS': '0x0', 23:00:06 INFO - 'XPC_SERVICE_NAME': '0', 23:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:07 INFO - Downloading/unpacking flake8 23:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:00:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:00:10 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 23:00:10 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 23:00:10 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 23:00:10 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 23:00:10 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 23:00:10 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 23:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:00:10 INFO - no previously-included directories found matching 'docs/_build' 23:00:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:00:10 INFO - Running setup.py install for pep8 23:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:00:11 INFO - no previously-included directories found matching 'docs/_build' 23:00:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:00:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:00:11 INFO - Cleaning up... 23:00:11 INFO - Return code: 0 23:00:11 INFO - Running post-action listener: _resource_record_post_action 23:00:11 INFO - Running post-action listener: _start_resource_monitoring 23:00:11 INFO - Starting resource monitoring. 23:00:11 INFO - ##### 23:00:11 INFO - ##### Running install step. 23:00:11 INFO - ##### 23:00:11 INFO - Running pre-action listener: _resource_record_pre_action 23:00:11 INFO - Running main action method: install 23:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:00:11 INFO - Reading from file tmpfile_stdout 23:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 23:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:00:11 INFO - Reading from file tmpfile_stdout 23:00:11 INFO - Output received: 23:00:11 INFO - Usage: mozinstall [options] installer 23:00:11 INFO - Options: 23:00:11 INFO - -h, --help show this help message and exit 23:00:11 INFO - -d DEST, --destination=DEST 23:00:11 INFO - Directory to install application into. [default: 23:00:11 INFO - "/builds/slave/test"] 23:00:11 INFO - --app=APP Application being installed. [default: firefox] 23:00:11 INFO - mkdir: /builds/slave/test/build/application 23:00:11 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'] 23:00:11 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 23:00:44 INFO - Reading from file tmpfile_stdout 23:00:44 INFO - Output received: 23:00:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:00:44 INFO - Running post-action listener: _resource_record_post_action 23:00:44 INFO - ##### 23:00:44 INFO - ##### Running run-tests step. 23:00:44 INFO - ##### 23:00:44 INFO - Running pre-action listener: _resource_record_pre_action 23:00:44 INFO - Running main action method: run_tests 23:00:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:00:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:00:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:00:44 INFO - 2016-04-07 23:00:44.658 screenresolution[1641:7370] starting screenresolution argv=screenresolution get 23:00:44 INFO - 2016-04-07 23:00:44.661 screenresolution[1641:7370] Display 0: 1600x1200x32@60 23:00:44 INFO - 2016-04-07 23:00:44.666 screenresolution[1642:7372] starting screenresolution argv=screenresolution list 23:00:44 INFO - Available Modes on Display 0 23:00:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:00:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:00:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:00:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:00:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:00:44 INFO - Intel Iris: 23:00:44 INFO - Chipset Model: Intel Iris 23:00:44 INFO - Type: GPU 23:00:44 INFO - Bus: Built-In 23:00:44 INFO - VRAM (Dynamic, Max): 1536 MB 23:00:44 INFO - Vendor: Intel (0x8086) 23:00:44 INFO - Device ID: 0x0a2e 23:00:44 INFO - Revision ID: 0x0009 23:00:44 INFO - Displays: 23:00:44 INFO - Display: 23:00:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:00:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:00:44 INFO - Display Serial Number: 1600x1200 60 23:00:44 INFO - Main Display: Yes 23:00:44 INFO - Mirror: Off 23:00:44 INFO - Online: Yes 23:00:44 INFO - Rotation: Supported 23:00:44 INFO - Return code: 0 23:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:00:44 INFO - Python 2.7.3 23:00:44 INFO - Return code: 0 23:00:44 INFO - grabbing minidump binary from tooltool 23:00:44 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')]} 23:00:44 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 0x10436be00>, '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 0x104194db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104366b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:00:44 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 23:00:44 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 23:00:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:00:44 INFO - Return code: 0 23:00:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:00:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:00:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:00:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:00:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:00:46 INFO - Return code: 0 23:00:46 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/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 23:00:46 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/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --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 23:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hdm1nijO8q/Render', 23:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:00:46 INFO - 'HOME': '/Users/cltbld', 23:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:00:46 INFO - 'LOGNAME': 'cltbld', 23:00:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:00:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:46 INFO - 'MOZ_NO_REMOTE': '1', 23:00:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:00:46 INFO - 'NO_EM_RESTART': '1', 23:00:46 INFO - 'PAGER': '/bin/cat', 23:00:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:46 INFO - 'PWD': '/builds/slave/test', 23:00:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:00:46 INFO - 'SHELL': '/bin/bash', 23:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6OR9rDP3j/Listeners', 23:00:46 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 23:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:00:46 INFO - 'USER': 'cltbld', 23:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:46 INFO - 'XPC_FLAGS': '0x0', 23:00:46 INFO - 'XPC_SERVICE_NAME': '0', 23:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:00:46 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/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 23:00:46 INFO - mozversion application_buildid: 20160407220538 23:00:46 INFO - mozversion application_changeset: 34293bb847d1e28198d596a87ea4baf96bfb0286 23:00:46 INFO - mozversion application_display_name: Nightly 23:00:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:00:46 INFO - mozversion application_name: Firefox 23:00:46 INFO - mozversion application_remotingname: firefox 23:00:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:00:46 INFO - mozversion application_vendor: Mozilla 23:00:46 INFO - mozversion application_version: 48.0a1 23:00:46 INFO - mozversion platform_buildid: 20160407220538 23:00:46 INFO - mozversion platform_changeset: 34293bb847d1e28198d596a87ea4baf96bfb0286 23:00:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:00:46 INFO - mozversion platform_version: 48.0a1 23:00:46 INFO - using testdate: 1460095246 23:00:46 INFO - actual date: 1460095246 23:00:46 INFO - starting webserver on 'localhost:49278' 23:00:46 INFO - SUITE-START | Running 2 tests 23:00:46 INFO - TEST-START | dromaeo_css 23:00:46 INFO - operating with platform_type : mac_ 23:00:46 INFO - Initialising browser for dromaeo_css test... 23:00:46 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp5VxA5C/profile http://localhost:49278/getInfo.html) 23:00:48 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 23:00:48 INFO - PROCESS | 1660 | colorDepth:24 23:00:48 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 23:00:48 INFO - PROCESS | 1660 | __metrics 23:00:49 INFO - PROCESS | 1660 | 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" 23:00:49 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:00:49 INFO - TEST-INFO | 1660: exit 0 23:00:49 INFO - Browser initialized. 23:00:49 INFO - Running cycle 1/1 for dromaeo_css test... 23:00:49 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp5VxA5C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:01 INFO - PROCESS | 1665 | RSS: Main: 237584384 23:01:01 INFO - PROCESS | 1665 | 23:01:52 INFO - PROCESS | 1665 | 1460095312965 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] 23:04:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 23:04:04 INFO - PROCESS | 1665 | RSS: Main: 373420032 23:04:04 INFO - PROCESS | 1665 | 23:07:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 23:07:08 INFO - PROCESS | 1665 | RSS: Main: 368713728 23:07:08 INFO - PROCESS | 1665 | 23:10:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 23:10:11 INFO - PROCESS | 1665 | RSS: Main: 375066624 23:10:11 INFO - PROCESS | 1665 | 23:13:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 23:13:13 INFO - PROCESS | 1665 | RSS: Main: 335327232 23:13:13 INFO - PROCESS | 1665 | 23:16:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 23:16:17 INFO - PROCESS | 1665 | RSS: Main: 350683136 23:16:17 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 23:19:20 INFO - PROCESS | 1665 | RSS: Main: 385171456 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | __start_tp_report 23:19:20 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 23:19:20 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 23:19:20 INFO - PROCESS | 1665 | |i|pagename|runs| 23:19:20 INFO - PROCESS | 1665 | |0;dojo.html;2962.837043962582;3321.2859235264423;3443.208062145708;3477.704395126414;3526.329997300513;5595.38450770416;5678.119891416837;5746.425357464252;5746.942530574693;5751.367349591546;5734.4265573442635;5835.912461313083;5841.182234487164;5845.152452894327;5862.73617687204;5199.688018718889;5233.345831771019;5315.707636080014;5338.973305133469;5351.518363347298;5342.626016178869;5346.946530534684;5350.571954243651;5353.518183363496;5361.41024487308;5220.895582088356;5358.5981051421295;5377.731113444332;5425.213344065108;5443.020256353855;5167.147420675584;5200.635955483118;5286.365636123652;5295.232191332274;5308.787648494055;5216.139337009389;5232.973835130838;5246.527812496855;5249.973750131263;5283.973580132075;4670.486246512881;5646.971765141189;5682.829515114553;5687;5735.942640573624;6098.069176274479;6148.6618235997;6211.844703882439;6255.655938923357;6279.120923070774;6271.96864015677;6301.68491575424;6323.9051414228825;6335.588186767845;6343.746250149989;5840.503557197643;5858.53131749459;5860.531157507389;5863.882722345572;5870.0607902735355;6236.407541283571;6243.250809902841;6309.936900631027;6315.431611154926;6349.333320001426;6178.907316390258;6193.597416167935;6194.9690251549355;6211.409916057967;6223.097650840603;6242.906356404657;6262.5929314594405;6326.335734747877;6331.651759153198;6345.206849143857;6077.179580756541;6114.71053653006;6128.164296304456;6145.0782382642965;6257.937420625826;6250.249970003538;6279.529035322369;6280.152179455807;6289.905651415233;6307.274663413675;4968.652194346433;4971.080350135237;4976.477469865685;4981.42713587942;5005.624578156653;4388.385626012361;4474.888127796831;4483.058557702853;4520.773961301922;4531.048479819209;5668.858278543069;5706.972744905874;5708.942910570924;5718;5722.084466485426;6219.751209951552;6245.0632405139595;6262.467690246289;6272.937270627326;6356.523260755462;5678.375378708339;5700.201971723962;5700.800471983461;5723.942760572424;5753.597248192586;5283.920741188886;5341.62608617393;5346.064438723208;5360.91958620621;5377.336031424855;6239.906401403982;6272.937270627326;6295.433410993032;6319.178506794087;6347.206599175103;6313.652749098844;6324.209473815773;6324.6521441321165;6327.746890124344;6346.07981842621;6275.152854364785;6319.05214217871;6325.841853953504;6333.050042493479;6356.841078973062;6095.969520152371;6132.814448934826;6203.7828675996125;6253.530985176039;6259.561830671809;5273.34083239595;5394.352677678704;6318.241810982711;6333.841653958688;6335.176427064452;6011.729472173675;6153.815385538441;6162.537809664383;6178;6187.474064704551;5075.87310317245;6117.3576774439825;6138.296437970319;6186;6191.907121393273;6025.337212906665;6050.591330480968;6062.514998799998;6074.058520929263;6136.447719705248;6005.489533389711;6111.816645500642;6162.938370616236;6164.6917654118015;6180.721867515883;5997.880042399215;6007.549433792396;6067.757289708362;6130.785422510191;6136.662483563447 23:19:20 INFO - PROCESS | 1665 | |1;ext.html;511.2790964739718;532.7629205003773;533.9667742917454;546.4289817141088;599.5263741644102;27307.044253451135;29456.263593410124;29521.2619684508;29544.704552954463;29557.261068473297;25454;38522.22955540888;38622;38694;38717.8064109679;9422.246220302377;9639.662611808588;9658.661946831862;9659.90340096597;9669.661561845336;9381.953090234574;9519.857202141973;9554.378965367263;9579.760505987337;9580.952095239514;9552.665656701982;9609.135177834029;9655.372400793962;9709.417434953926;9727.902720972806;9605.327627066108;9686.51567421633;9687.079727425884;9689.51552422383;9696.933337332888;8145.389095817778;9495.05049495052;9590.992945740667;9606.327557071008;9608.27937904653;39436.60563394358;39825;39866.40200396996;39873.60126398728;39883.60116398828;2726.7861390849134;3447.293304872495;3574.946375804365;3910.921781564353;3962.7424217425773;24610.261692149084;28076.71923280782;28891.56662650062;29302.974395896254;29537;2726.127639155471;2751.9724802752116;2759.65504311961;2762.958555621667;2838.6025956366125;414493;417015.999999997;417242;417788;418730;31637;34758.47862282068;35719.4642080369;58053.709731451076;58406.70796645989;34084.829575852455;34114.82942585271;34202.82898585491;34216.82891585526;34283;13825.723485530232;13975.301234938212;14013.579592612237;14023.298835058411;14035.298235088205;11757.235779674294;11824.408779560987;11829.17195796286;11833;11841.763164736656;8084.797880052928;8115.594220288962;8161.959190204011;8206;8223.506589604644;3420.3330350581396;3459.08334291413;3459.3427248822645;3464.809435481073;3488.5639295088113;991.1426615977272;1004.4977511244377;1016.598443614768;1068.4283908109123;1088.9546035805556;23999.20005999557;28838.855805720836;28947.842086316734;29678.703212968026;29680.554791678143;1092.546593163844;1117.5306371324064;1123.5955056179769;1158.7798318319492;1180.7933611617932;14850.405983760744;15027.774583381259;15063.397464101314;15410.845891541165;15481.612959675873;582441;588368;598261;601941;602255;58320;59165.704171478865;59211.70394148002;59286;59571.53213509004;1325.6818363592668;1371.1567386057304;1371.1841454334854;1464.3337281536876;1509.2378348933937;29623.407531849673;29854.402911942074;29898.85050574733;30713.692863071083;30877.536836947915;55353.44646553483;57486.7125664369;57547;57595.848083038945;57672.846543068066;437018;454611;455330;455672;456795;25584.48831023332;40211.79894100511;40754.1849163021;41103.7944810286;41713;42165.57834421616;42835;43319.35020974625;43322;43360.34959475547;33771.83114084414;34969.82515087408;36684.60003284674;36801.81599091987;37095.629043710294;36208.275834482636;36247.45628815517;36271.730489432746;37104;37329.6267037337;30467.390652187274;31427.685723142476;31943.840280798446;32879.34241315208;36746.816265918496;30159.246018849703;31453.528197076605;31485.842570787914;31553.684463155994;31570.684293156773;23584.29247122589;24231.75768242295;24469.143579974614;24576.262712118663;24681.506369872863 23:19:20 INFO - PROCESS | 1665 | |2;jquery.html;390.9296326661201;397.6679472640345;398.2612254268334;404.0847480456768;406.1815441884601;14950.177740224284;16338.836611633895;17345.306187752507;19390.515237119078;20088.296909608147;19589.412317630457;19885.204591816346;20594.382168534932;20608.969551522438;20677.896610516964;4631.490536041041;5852.209951656514;5862.06207006879;5867.911981320262;5871.089981052944;4112.999999999985;4323.913521729579;5665.688387138705;5783.074708046714;5793.681347525884;6064;6388.297287298416;6428.292887782341;6429.517786166056;6441.645709485976;6242.687865606701;6332.303446620868;6411.48708103353;6427.035944608299;6437.0666253393465;5588.189712491707;5594.748236329375;5602.915956260659;5606.159076138571;5624.128260119688;13050.347482625832;13741.450341986309;13771.931140344333;13774.586762397144;13775.448982040707;2031.197676917624;2053.661145910923;2055.496403381166;2086.0612724273988;2143.5712857428575;9560.235181185488;9719.708408747749;10133.240006999504;10167.847482287772;10197.337173083726;1617.5713435939367;1633.3711521064356;1717.2787429279608;1742.128935532234;1753.7807774028247;96589.51705241499;109648;111227;117038.41480792627;120373.39813300964;11600.18798684084;11671.766564668658;11713.88286117128;11730;11886.821697674543;13515.932420338033;14054.859451405355;14276.928615356857;14951.775723364159;14976.251187440585;8267.586620668942;8278.71024514139;8334.583270836434;8432.198941100585;8447.32421406286;8044.839103217902;8070.192980702001;8078.071021832447;8197.754067377988;8223.671053157927;4069.2969397847814;4348.499922508889;4551.658625603093;4644.512326205768;4717.905641887143;1965.3317871923614;1976.5256338478948;1976.9110390032483;1977.8219960203362;2006.56858775364;864.1876635962176;913.7030465098736;918.9402688825205;919.2278486071732;1003.7340104872214;17465.650686986442;19775.505612359808;20388.79611203869;20626.27808026712;20663.17347306121;871.655696000089;935.7520257131865;947.8720372749591;953.823542644613;1017.7557386227401;9905.158061564704;10407.94796026015;10517.42154181512;10692.358458492516;11398.601048963412;492953;624006;627156;640318;644775;113609.72780544509;117426.8257317433;125098;126246.36876815557;138097.6190238105;1011.5751384418562;1026.6868605075524;1040.5941682743887;1057.3127467146417;1059.523214553454;17063.06153161588;17285.654286914443;17569;17613;17720.291188352323;49583.50416495933;50163.74590635263;50185;50302.74848625733;50866.74566627143;60796;64642;69491.65254173697;69771.65114174396;70861.29138708753;6813;6817.659117044029;6852.451803855779;7286.562806231643;8057.959710201411;9174.220191283815;11982.161248712506;12077.637670869888;12310.938445307716;12540.87459125397;10349.9482502587;10394.376337419779;10517.368957862553;10837.295575787548;10960.013598776148;10424.68725938223;10486.056254937092;10610.029381007045;10790.352578845295;10867.29362591429;10754.354738715389;10935.56257749681;11050;11137.554497819996;11207.047400970683;7343.522671026366;7456.96271518639;7493.775186744407;7510.549367037996;7729.381649468141;10213.948930255301;10630.30902991303;10880.347179169275;10903.182261330274;10947.124230061736 23:19:20 INFO - PROCESS | 1665 | |3;mootools.html;1416.0158689710643;1601.3674598533576;1619.5951012246937;1885.7925628180897;2001.5496513284504;7770.3783697304225;8475.745727628173;8718.60766265518;8722.38943273971;8730.083341249172;7174.354308112269;7361.926380736191;8128.780682897568;8201.630926608303;8593.140685931403;2385.2367242482414;2421.092090466075;2422.515496900618;2425.223928342931;2426.8665223412704;2081.2923605973965;2374.6912901322803;2385.129427758864;2393.820463465247;2431.404305945046;2393.6768536247646;2399.0523743121457;2404.8557086574774;2430.7569243075727;2430.987845060772;2109.799569040946;2335.0426325206668;2386.3079706884982;2408.8675122868235;2418.4195793009726;2132.3070002249333;2246.146464343539;2351.3063646224405;2395.2215529952837;2399.2802159352123;8634.827303453958;8655.826883462358;8688.956555217246;8716.912830871674;8717.869231961526;5088.1350170471105;5310.787568497255;5311.973440132813;5317.707526086064;5332.493413125786;3110.4867696829997;3508.7193024557973;3548.2193917338145;3585.8744943926836;3586.0855481852223;1026.768976980181;1044.253358848427;1048.4024106259435;1051.75283808305;1053.3627155570846;11320.377379244139;11324;11338.433078346132;11354.034907032912;11354.772904541864;4593.862184134481;4678.953210467852;4805.423349198119;4851.102546028996;4852.660313778002;9589.136977672042;9594.904050959542;9600.32797704168;9631.422114673142;9645;5277.815276465305;5281.9207711884355;5282.630215884851;5283.9471605284225;5297.258383826267;4033.4353190553347;4299.871003869889;4397.472303323558;4812.374391329105;4873.293372460973;3924.9607503925167;3987.4816273884207;4024.195160967818;4050.4936882889638;4067.572904845008;1325.8342707161605;1326.4362645875465;1330.5010621017118;1345.5492410042746;1351.8580549042406;949.1647350331664;960.1118964957386;977.1889331854544;999.3753903809974;1002.7894142230067;7791.610419479003;7962.7213047543055;7974.9632547768415;7975.561344126013;7980.720674776355;502.8441183233209;509.38364578859256;512.6232219318798;517.3171413733835;521.3379008658982;6179.073139029181;6184.381561843779;6318.241810982711;6325.493960483151;6336.493080553545;10149.695509134737;10522.579096836194;10527.052565269163;10592.735181620366;10622.628208012682;10368.326058806153;10430;10483.580656773796;10487.37075775456;10495.737606559896;7821.217878212134;7922.762317130495;8042.879356809535;8052.154523775036;8073.152319006537;7660.923390766021;7886.132525422314;7906;7922.801929951797;7926.682932682628;9395.765105872408;9652.613895444385;9741.464219467998;9793.657221997197;9815.85276220843;7666.041744781903;9728.902710973083;9960.601575936882;9975.251856110675;9977.251706121924;6392.840178995562;6758.189017317954;7084.326988936043;7324.19433862264;7366.815829604303;7716.807079822825;7958.3235424989525;8008.719694810654;8025.197480251928;8037.7588672339925;7205.891911621225;7221.638918054181;7314.780556583311;7348.889766653611;7373.446991475768;7018.824529386806;7124.145102587722;7130.322619351154;7256.96371518139;7295.270472952874;7558.508696934681;7640.197779233323;7641.732539361095;7657.846843063219;7659.808504787202;6855.177378714586;6980.511364204457;6985.685644145924;7005;7025.016497690225;7039.859202816017;7086.220515743161;7123.180834203926;7123.180834204133;7148.499605027599 23:19:20 INFO - PROCESS | 1665 | |4;prototype.html;317.77279245339577;319.89763275751756;326.8708860000298;328.70252421558496;332.33864609427246;5583.441655834419;5832.270966129228;5902.586818922677;5909.704514774266;5959.433853783895;4772.78522466489;5794.739236734346;5816.912746308809;5820.650760954335;5922.822315330547;3537.9469307960403;3982.8207730652043;4166.749995000309;4269.423627810253;4330.50199227089;3959.386295124246;4113.25961326961;4399.73601583906;4477.440319960005;4477.48508921475;4440.422745043156;4441.133978874121;4441.356003379508;4450.777461126931;4467.5755803198645;4167.5619762438855;4232.25935461293;4415.359772832953;4429.889252768674;4456.732596044215;3198.3763166182603;3837.5586807517216;3849.615038496156;3850.4994350734505;3859.3824988002066;5188.870278243036;5641.464060914206;5646.943530564724;5669.914951275734;5745.368009518949;4232.661387089025;4511.909761804778;4542.772861356919;5081.441041485434;5148.3821941366905;5099.796008159669;5640.843627056443;6126.846828829271;6206.834514397689;6242.843928901813;3551.3607550640872;4040.1717647882115;4271.466066741657;4272.978635106836;4295.377170310318;5008.524190201925;5850.882982340329;6196.721147548371;6266.561340706153;6360.300366959631;4245.8513952011535;4313.590208930146;4336.891577710519;4363.781810909441;4379.146066516999;4418.762746431004;4419.889502762392;4435.667324950641;4443.666724995638;4449.621782148553;4957.273499575292;5112.539871411591;5139.7687104080405;5154.639175257696;5167.586593072545;5118.206677964921;5219.347581552306;6267.65527895961;6296.811095667137;6311.810645680637;1275.3177050278243;1507.555271194978;1523.6800271943016;1527.594612956083;1527.7173722861085;861.8362511122992;900.2752784008804;947.2706016367358;983.8160769219276;991.965281215154;4806;5211.009908117446;5760.567957403212;5768.9711551442815;5844.561657875676;5998.490128339053;6139.140520327158;6436.3241859605005;6473.417392434703;6481.578697384655;4801.807927682854;5487;5582.246396736388;5748.942510574924;5797.391273916262;2907.3458471843664;3246.740260779179;3349.748768842298;3388.2376465295606;3390.4066788311948;6280.214973128359;6401.743930242738;6667.933320666732;6668.799936001928;6707.262201157869;5697.401772813878;5831.241938547962;6206.689665516707;6565.474762019027;6582.544164313774;6234.719437625317;6436.613803171825;6626.304238055031;6651.63416012124;6656.771465838968;6347.492200623847;6361;6376.617402955838;6392.616443013248;6403.64779937108;4990.577685359655;6299.275583307978;6304.968475157595;6338.144350512622;6416.262129855127;5445.863853403538;5611.38274789781;6306.400891915261;6357.586756860789;6374.107624932606;4347.65218782503;4362.563743625612;4367.606915377632;4371.103923695571;4406.449193850769;5570.24801651788;5733.31200255972;6351.904721429275;6426.518011149089;6503.772367967098;6205.703889560711;6281.811545653638;6284.937150628435;6294.779682711083;6304.369563043659;5451.700156491431;6025.276966763841;6264.404881536247;6304.779332723333;6317.936820631735;6134.35589263121;6148.754049838135;6154.707231631056;6155.138280640804;6170.167027451236;5726.165548053574;5870.178175055581;6215.782447614311;6293.874122517433;6302.527310451826;5337.412884582771;5760.884782304247;5953.613015154175;6014.188084608521;6150.10823430609 23:19:20 INFO - PROCESS | 1665 | |5;yui.html;670.7551743613581;741.3985790692107;742.4134933402612;759.810047488128;801.0707579208118;14622.122672639649;14694.559163225107;15183.924080379582;15228;15229.923850380746;11449.2557983731;14472.638184045403;14478.782818257734;14479.986400951937;14486.130832150078;748.0350348051007;771.1632878327022;914.5655813488573;915.9175674189322;948.8481842905137;948.1182500274741;951.1202138022302;955.412421360865;959.2853324273426;961.5576834656067;988.9456079915602;990.692885205585;993.602558976408;993.9850902236473;995.3878364805629;780.2431641307923;950.6815216902346;978.990210097897;999.0109791306554;1001.0790073132663;731.8646050480678;737.4948160510068;738.0663460722191;743.438703778649;744.6537360127512;15030.17334046627;15040.473583424528;15044.022138560958;15064;15073.020253683475;12386.62840114789;12437.253764774143;12525.624231272985;12575.811362829565;12600.495980160782;10880.891191088147;11113.388763617997;11114.444277786079;11265.493052812642;11566.421678916106;4154.626083652486;4214.904124927511;4268.338407546835;4300.548442413564;4324.545922678105;84096.3180736388;84400;84454;88034.55982720046;88088.11911880864;9551.856722149174;9622.759431014281;9713.320067595201;10087.848682269772;10273.021290105004;22164.556708866054;22178.778212217992;22192.889035555043;22206.66689999651;22267.220647277267;7531.359834414026;7550.962245188849;7755.457118001686;7885.48744331628;7894.842103157905;3504.3829704529403;4121.361189015707;4193.30810416284;4201.831926722958;4216.978915105405;3452.5684289463816;3547.2018795770746;3550.9112272192883;3552.8401221945073;3564.3049605326714;548.314606741573;633.6456938866596;641.9903701444482;653.8855700252532;664.4385494257344;534.9411564727877;554.9201929292411;555.7832445346318;592.9534371833716;601.3685630088389;7643.617819109022;7684.500507466997;7715.673148018571;7719.768406947801;8238.258556729923;555.328053055807;556.4352182534731;582.4059459351438;589.9557782724639;597.4981015946539;3717.8141092945784;3731.6641502264924;3737.9626203738158;3792.9123756371177;3803.4786085565993;83042;84196;85122.14877851267;85446.71829922555;85538;72601.91097133547;73925.26074739291;74152.62923685346;74623.64193611301;75082.6245868778;52029.479705202466;64114;66472.35276472314;67886.64226715438;68698.31301687019;7106.289371062852;7329.230430804902;7350.117985841734;7373.152087510005;7380.372668323253;31589.684103158674;42036.94907627334;42619.57380426156;43173;43521.78239108784;56380.590485238194;60541;60730;60757;61436.69281653563;8240.711575094843;9766.658166964122;10090.293679442368;10148.797024059626;10162.237832162766;10422.635207767691;10471.842922356018;10539.841902371318;10639.840402394126;11078.612248571262;9469.337146399961;9486.810263794823;9661.758456038655;9755.658551950648;9775.853362199716;9999.000099989942;10008.249381296577;10108.241881858743;10368.066873981377;10408.063274305348;9618.951905240428;9695.91884525906;9723.416595004323;9903.306768526134;10219.978002199721;8332.33341332704;8496.787580310542;8719.258862996716;8870.379073464796;8883.777905552413;8129.715459958873;8276.503409795432;8439.240468357877;8451.619677114422;8482.363822713445 23:19:20 INFO - PROCESS | 1665 | __end_tp_report 23:19:20 INFO - PROCESS | 1665 | __start_cc_report 23:19:20 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1299 23:19:20 INFO - PROCESS | 1665 | __end_cc_report 23:19:20 INFO - PROCESS | 1665 | __startTimestamp1460096360888__endTimestamp 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | ------- Summary: start ------- 23:19:20 INFO - PROCESS | 1665 | Number of tests: 6 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5768.17 Median:6025.34 stddev:646.19 (10.7%) stddev-sans-first:609.55 23:19:20 INFO - PROCESS | 1665 | Values: 2962.8 3321.3 3443.2 3477.7 3526.3 5595.4 5678.1 5746.4 5746.9 5751.4 5734.4 5835.9 5841.2 5845.2 5862.7 5199.7 5233.3 5315.7 5339.0 5351.5 5342.6 5346.9 5350.6 5353.5 5361.4 5220.9 5358.6 5377.7 5425.2 5443.0 5167.1 5200.6 5286.4 5295.2 5308.8 5216.1 5233.0 5246.5 5250.0 5284.0 4670.5 5647.0 5682.8 5687.0 5735.9 6098.1 6148.7 6211.8 6255.7 6279.1 6272.0 6301.7 6323.9 6335.6 6343.7 5840.5 5858.5 5860.5 5863.9 5870.1 6236.4 6243.3 6309.9 6315.4 6349.3 6178.9 6193.6 6195.0 6211.4 6223.1 6242.9 6262.6 6326.3 6331.7 6345.2 6077.2 6114.7 6128.2 6145.1 6257.9 6250.2 6279.5 6280.2 6289.9 6307.3 4968.7 4971.1 4976.5 4981.4 5005.6 4388.4 4474.9 4483.1 4520.8 4531.0 5668.9 5707.0 5708.9 5718.0 5722.1 6219.8 6245.1 6262.5 6272.9 6356.5 5678.4 5700.2 5700.8 5723.9 5753.6 5283.9 5341.6 5346.1 5360.9 5377.3 6239.9 6272.9 6295.4 6319.2 6347.2 6313.7 6324.2 6324.7 6327.7 6346.1 6275.2 6319.1 6325.8 6333.1 6356.8 6096.0 6132.8 6203.8 6253.5 6259.6 5273.3 5394.4 6318.2 6333.8 6335.2 6011.7 6153.8 6162.5 6178.0 6187.5 5075.9 6117.4 6138.3 6186.0 6191.9 6025.3 6050.6 6062.5 6074.1 6136.4 6005.5 6111.8 6162.9 6164.7 6180.7 5997.9 6007.5 6067.8 6130.8 6136.7 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:61151.27 Median:36478.17 stddev:131938.89 (361.7%) stddev-sans-first:132230.46 23:19:20 INFO - PROCESS | 1665 | Values: 511.3 532.8 534.0 546.4 599.5 27307.0 29456.3 29521.3 29544.7 29557.3 25454.0 38522.2 38622.0 38694.0 38717.8 9422.2 9639.7 9658.7 9659.9 9669.7 9382.0 9519.9 9554.4 9579.8 9581.0 9552.7 9609.1 9655.4 9709.4 9727.9 9605.3 9686.5 9687.1 9689.5 9696.9 8145.4 9495.1 9591.0 9606.3 9608.3 39436.6 39825.0 39866.4 39873.6 39883.6 2726.8 3447.3 3574.9 3910.9 3962.7 24610.3 28076.7 28891.6 29303.0 29537.0 2726.1 2752.0 2759.7 2763.0 2838.6 414493.0 417016.0 417242.0 417788.0 418730.0 31637.0 34758.5 35719.5 58053.7 58406.7 34084.8 34114.8 34202.8 34216.8 34283.0 13825.7 13975.3 14013.6 14023.3 14035.3 11757.2 11824.4 11829.2 11833.0 11841.8 8084.8 8115.6 8162.0 8206.0 8223.5 3420.3 3459.1 3459.3 3464.8 3488.6 991.1 1004.5 1016.6 1068.4 1089.0 23999.2 28838.9 28947.8 29678.7 29680.6 1092.5 1117.5 1123.6 1158.8 1180.8 14850.4 15027.8 15063.4 15410.8 15481.6 582441.0 588368.0 598261.0 601941.0 602255.0 58320.0 59165.7 59211.7 59286.0 59571.5 1325.7 1371.2 1371.2 1464.3 1509.2 29623.4 29854.4 29898.9 30713.7 30877.5 55353.4 57486.7 57547.0 57595.8 57672.8 437018.0 454611.0 455330.0 455672.0 456795.0 25584.5 40211.8 40754.2 41103.8 41713.0 42165.6 42835.0 43319.4 43322.0 43360.3 33771.8 34969.8 36684.6 36801.8 37095.6 36208.3 36247.5 36271.7 37104.0 37329.6 30467.4 31427.7 31943.8 32879.3 36746.8 30159.2 31453.5 31485.8 31553.7 31570.7 23584.3 24231.8 24469.1 24576.3 24681.5 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:33943.16 Median:20601.68 stddev:101237.97 (491.4%) stddev-sans-first:101490.62 23:19:20 INFO - PROCESS | 1665 | Values: 390.9 397.7 398.3 404.1 406.2 14950.2 16338.8 17345.3 19390.5 20088.3 19589.4 19885.2 20594.4 20609.0 20677.9 4631.5 5852.2 5862.1 5867.9 5871.1 4113.0 4323.9 5665.7 5783.1 5793.7 6064.0 6388.3 6428.3 6429.5 6441.6 6242.7 6332.3 6411.5 6427.0 6437.1 5588.2 5594.7 5602.9 5606.2 5624.1 13050.3 13741.5 13771.9 13774.6 13775.4 2031.2 2053.7 2055.5 2086.1 2143.6 9560.2 9719.7 10133.2 10167.8 10197.3 1617.6 1633.4 1717.3 1742.1 1753.8 96589.5 109648.0 111227.0 117038.4 120373.4 11600.2 11671.8 11713.9 11730.0 11886.8 13515.9 14054.9 14276.9 14951.8 14976.3 8267.6 8278.7 8334.6 8432.2 8447.3 8044.8 8070.2 8078.1 8197.8 8223.7 4069.3 4348.5 4551.7 4644.5 4717.9 1965.3 1976.5 1976.9 1977.8 2006.6 864.2 913.7 918.9 919.2 1003.7 17465.7 19775.5 20388.8 20626.3 20663.2 871.7 935.8 947.9 953.8 1017.8 9905.2 10407.9 10517.4 10692.4 11398.6 492953.0 624006.0 627156.0 640318.0 644775.0 113609.7 117426.8 125098.0 126246.4 138097.6 1011.6 1026.7 1040.6 1057.3 1059.5 17063.1 17285.7 17569.0 17613.0 17720.3 49583.5 50163.7 50185.0 50302.7 50866.7 60796.0 64642.0 69491.7 69771.7 70861.3 6813.0 6817.7 6852.5 7286.6 8058.0 9174.2 11982.2 12077.6 12310.9 12540.9 10349.9 10394.4 10517.4 10837.3 10960.0 10424.7 10486.1 10610.0 10790.4 10867.3 10754.4 10935.6 11050.0 11137.6 11207.0 7343.5 7457.0 7493.8 7510.5 7729.4 10213.9 10630.3 10880.3 10903.2 10947.1 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5885.65 Median:5755.78 stddev:3129.70 (54.4%) stddev-sans-first:3120.45 23:19:20 INFO - PROCESS | 1665 | Values: 1416.0 1601.4 1619.6 1885.8 2001.5 7770.4 8475.7 8718.6 8722.4 8730.1 7174.4 7361.9 8128.8 8201.6 8593.1 2385.2 2421.1 2422.5 2425.2 2426.9 2081.3 2374.7 2385.1 2393.8 2431.4 2393.7 2399.1 2404.9 2430.8 2431.0 2109.8 2335.0 2386.3 2408.9 2418.4 2132.3 2246.1 2351.3 2395.2 2399.3 8634.8 8655.8 8689.0 8716.9 8717.9 5088.1 5310.8 5312.0 5317.7 5332.5 3110.5 3508.7 3548.2 3585.9 3586.1 1026.8 1044.3 1048.4 1051.8 1053.4 11320.4 11324.0 11338.4 11354.0 11354.8 4593.9 4679.0 4805.4 4851.1 4852.7 9589.1 9594.9 9600.3 9631.4 9645.0 5277.8 5281.9 5282.6 5283.9 5297.3 4033.4 4299.9 4397.5 4812.4 4873.3 3925.0 3987.5 4024.2 4050.5 4067.6 1325.8 1326.4 1330.5 1345.5 1351.9 949.2 960.1 977.2 999.4 1002.8 7791.6 7962.7 7975.0 7975.6 7980.7 502.8 509.4 512.6 517.3 521.3 6179.1 6184.4 6318.2 6325.5 6336.5 10149.7 10522.6 10527.1 10592.7 10622.6 10368.3 10430.0 10483.6 10487.4 10495.7 7821.2 7922.8 8042.9 8052.2 8073.2 7660.9 7886.1 7906.0 7922.8 7926.7 9395.8 9652.6 9741.5 9793.7 9815.9 7666.0 9728.9 9960.6 9975.3 9977.3 6392.8 6758.2 7084.3 7324.2 7366.8 7716.8 7958.3 8008.7 8025.2 8037.8 7205.9 7221.6 7314.8 7348.9 7373.4 7018.8 7124.1 7130.3 7257.0 7295.3 7558.5 7640.2 7641.7 7657.8 7659.8 6855.2 6980.5 6985.7 7005.0 7025.0 7039.9 7086.2 7123.2 7123.2 7148.5 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5002.00 Median:5658.43 stddev:1548.79 (27.4%) stddev-sans-first:1512.70 23:19:20 INFO - PROCESS | 1665 | Values: 317.8 319.9 326.9 328.7 332.3 5583.4 5832.3 5902.6 5909.7 5959.4 4772.8 5794.7 5816.9 5820.7 5922.8 3537.9 3982.8 4166.7 4269.4 4330.5 3959.4 4113.3 4399.7 4477.4 4477.5 4440.4 4441.1 4441.4 4450.8 4467.6 4167.6 4232.3 4415.4 4429.9 4456.7 3198.4 3837.6 3849.6 3850.5 3859.4 5188.9 5641.5 5646.9 5669.9 5745.4 4232.7 4511.9 4542.8 5081.4 5148.4 5099.8 5640.8 6126.8 6206.8 6242.8 3551.4 4040.2 4271.5 4273.0 4295.4 5008.5 5850.9 6196.7 6266.6 6360.3 4245.9 4313.6 4336.9 4363.8 4379.1 4418.8 4419.9 4435.7 4443.7 4449.6 4957.3 5112.5 5139.8 5154.6 5167.6 5118.2 5219.3 6267.7 6296.8 6311.8 1275.3 1507.6 1523.7 1527.6 1527.7 861.8 900.3 947.3 983.8 992.0 4806.0 5211.0 5760.6 5769.0 5844.6 5998.5 6139.1 6436.3 6473.4 6481.6 4801.8 5487.0 5582.2 5748.9 5797.4 2907.3 3246.7 3349.7 3388.2 3390.4 6280.2 6401.7 6667.9 6668.8 6707.3 5697.4 5831.2 6206.7 6565.5 6582.5 6234.7 6436.6 6626.3 6651.6 6656.8 6347.5 6361.0 6376.6 6392.6 6403.6 4990.6 6299.3 6305.0 6338.1 6416.3 5445.9 5611.4 6306.4 6357.6 6374.1 4347.7 4362.6 4367.6 4371.1 4406.4 5570.2 5733.3 6351.9 6426.5 6503.8 6205.7 6281.8 6284.9 6294.8 6304.4 5451.7 6025.3 6264.4 6304.8 6317.9 6134.4 6148.8 6154.7 6155.1 6170.2 5726.2 5870.2 6215.8 6293.9 6302.5 5337.4 5760.9 5953.6 6014.2 6150.1 23:19:20 INFO - PROCESS | 1665 | 23:19:20 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:17250.40 Median:32383.94 stddev:24275.00 (75.0%) stddev-sans-first:24311.18 23:19:20 INFO - PROCESS | 1665 | Values: 670.8 741.4 742.4 759.8 801.1 14622.1 14694.6 15183.9 15228.0 15229.9 11449.3 14472.6 14478.8 14480.0 14486.1 748.0 771.2 914.6 915.9 948.8 948.1 951.1 955.4 959.3 961.6 988.9 990.7 993.6 994.0 995.4 780.2 950.7 979.0 999.0 1001.1 731.9 737.5 738.1 743.4 744.7 15030.2 15040.5 15044.0 15064.0 15073.0 12386.6 12437.3 12525.6 12575.8 12600.5 10880.9 11113.4 11114.4 11265.5 11566.4 4154.6 4214.9 4268.3 4300.5 4324.5 84096.3 84400.0 84454.0 88034.6 88088.1 9551.9 9622.8 9713.3 10087.8 10273.0 22164.6 22178.8 22192.9 22206.7 22267.2 7531.4 7551.0 7755.5 7885.5 7894.8 3504.4 4121.4 4193.3 4201.8 4217.0 3452.6 3547.2 3550.9 3552.8 3564.3 548.3 633.6 642.0 653.9 664.4 534.9 554.9 555.8 593.0 601.4 7643.6 7684.5 7715.7 7719.8 8238.3 555.3 556.4 582.4 590.0 597.5 3717.8 3731.7 3738.0 3792.9 3803.5 83042.0 84196.0 85122.1 85446.7 85538.0 72601.9 73925.3 74152.6 74623.6 75082.6 52029.5 64114.0 66472.4 67886.6 68698.3 7106.3 7329.2 7350.1 7373.2 7380.4 31589.7 42036.9 42619.6 43173.0 43521.8 56380.6 60541.0 60730.0 60757.0 61436.7 8240.7 9766.7 10090.3 10148.8 10162.2 10422.6 10471.8 10539.8 10639.8 11078.6 9469.3 9486.8 9661.8 9755.7 9775.9 9999.0 10008.2 10108.2 10368.1 10408.1 9619.0 9695.9 9723.4 9903.3 10220.0 8332.3 8496.8 8719.3 8870.4 8883.8 8129.7 8276.5 8439.2 8451.6 8482.4 23:19:20 INFO - PROCESS | 1665 | -------- Summary: end -------- 23:19:20 INFO - PROCESS | 1665 | 23:19:21 INFO - TEST-INFO | 1665: exit 0 23:19:21 INFO - TEST-OK | dromaeo_css | took 1115022ms 23:19:21 INFO - TEST-START | kraken 23:19:21 INFO - operating with platform_type : mac_ 23:19:21 INFO - Initialising browser for kraken test... 23:19:21 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpwg3iGP/profile http://localhost:49278/getInfo.html) 23:19:23 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 23:19:23 INFO - PROCESS | 1671 | colorDepth:24 23:19:23 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 23:19:23 INFO - PROCESS | 1671 | __metrics 23:19:23 INFO - PROCESS | 1671 | 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" 23:19:23 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:19:24 INFO - TEST-INFO | 1671: exit 0 23:19:24 INFO - Browser initialized. 23:19:24 INFO - Running cycle 1/1 for kraken test... 23:19:24 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpwg3iGP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:36 INFO - PROCESS | 1673 | RSS: Main: 237252608 23:19:36 INFO - PROCESS | 1673 | 23:19:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 23:19:39 INFO - PROCESS | 1673 | RSS: Main: 283738112 23:19:39 INFO - PROCESS | 1673 | 23:19:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 23:19:42 INFO - PROCESS | 1673 | RSS: Main: 294150144 23:19:42 INFO - PROCESS | 1673 | 23:19:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 23:19:46 INFO - PROCESS | 1673 | RSS: Main: 280547328 23:19:46 INFO - PROCESS | 1673 | 23:19:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 23:19:49 INFO - PROCESS | 1673 | RSS: Main: 282931200 23:19:49 INFO - PROCESS | 1673 | 23:19:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:19:51 INFO - PROCESS | 1673 | RSS: Main: 284266496 23:19:51 INFO - PROCESS | 1673 | 23:19:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 23:19:55 INFO - PROCESS | 1673 | RSS: Main: 284192768 23:19:55 INFO - PROCESS | 1673 | 23:19:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 23:19:58 INFO - PROCESS | 1673 | RSS: Main: 284504064 23:19:58 INFO - PROCESS | 1673 | 23:20:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 23:20:02 INFO - PROCESS | 1673 | RSS: Main: 285011968 23:20:02 INFO - PROCESS | 1673 | 23:20:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:20:04 INFO - PROCESS | 1673 | RSS: Main: 318652416 23:20:04 INFO - PROCESS | 1673 | 23:20:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:20:06 INFO - PROCESS | 1673 | RSS: Main: 318230528 23:20:06 INFO - PROCESS | 1673 | 23:20:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:20:09 INFO - PROCESS | 1673 | RSS: Main: 324136960 23:20:09 INFO - PROCESS | 1673 | 23:20:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:20:12 INFO - PROCESS | 1673 | RSS: Main: 325328896 23:20:12 INFO - PROCESS | 1673 | 23:20:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:20:16 INFO - PROCESS | 1673 | RSS: Main: 325394432 23:20:16 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 23:20:18 INFO - PROCESS | 1673 | RSS: Main: 389496832 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | __start_tp_report 23:20:18 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 23:20:18 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 23:20:18 INFO - PROCESS | 1673 | |i|pagename|runs| 23:20:18 INFO - PROCESS | 1673 | |0;ai-astar;113;110;112;118;112;112;116;111;111;116 23:20:18 INFO - PROCESS | 1673 | |1;audio-beat-detection;157;121;142;162;118;142;141;123;191;157 23:20:18 INFO - PROCESS | 1673 | |2;audio-dft;185;183;186;185;188;186;186;180;185;184 23:20:18 INFO - PROCESS | 1673 | |3;audio-fft;77;75;85;80;56;58;57;101;107;82 23:20:18 INFO - PROCESS | 1673 | |4;audio-oscillator;89;93;129;78;78;80;115;78;76;114 23:20:18 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;86;82;85;83;91;84;86;83;86;83 23:20:18 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;106;149;93;130;150;94;93;92;92 23:20:18 INFO - PROCESS | 1673 | |7;imaging-desaturate;85;88;86;88;85;84;86;85;85;86 23:20:18 INFO - PROCESS | 1673 | |8;json-parse-financial;54;57;55;55;52;54;54;63;54;51 23:20:18 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;65;66;70;78;74;71;68;68;69;68 23:20:18 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;97;115;114;85;84;86;83;84;85;85 23:20:18 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;145;144;150;141;142;141;145;142;151;157 23:20:18 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;207;170;170;170;170;171;169;172;167;168 23:20:18 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;71;67;68;67;73;67;64;69;67;68 23:20:18 INFO - PROCESS | 1673 | __end_tp_report 23:20:18 INFO - PROCESS | 1673 | __start_cc_report 23:20:18 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1313 23:20:18 INFO - PROCESS | 1673 | __end_cc_report 23:20:18 INFO - PROCESS | 1673 | __startTimestamp1460096418362__endTimestamp 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | ------- Summary: start ------- 23:20:18 INFO - PROCESS | 1673 | Number of tests: 14 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:113.10 Median:112.50 stddev:2.64 (2.3%) stddev-sans-first:2.80 23:20:18 INFO - PROCESS | 1673 | Values: 113.0 110.0 112.0 118.0 112.0 112.0 116.0 111.0 111.0 116.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:149.50 stddev:22.40 (15.0%) stddev-sans-first:23.36 23:20:18 INFO - PROCESS | 1673 | Values: 157.0 121.0 142.0 162.0 118.0 142.0 141.0 123.0 191.0 157.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.50 stddev:2.15 (1.2%) stddev-sans-first:2.28 23:20:18 INFO - PROCESS | 1673 | Values: 185.0 183.0 186.0 185.0 188.0 186.0 186.0 180.0 185.0 184.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:77.80 Median:76.00 stddev:17.55 (23.1%) stddev-sans-first:18.62 23:20:18 INFO - PROCESS | 1673 | Values: 77.0 75.0 85.0 80.0 56.0 58.0 57.0 101.0 107.0 82.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:19.35 (24.8%) stddev-sans-first:20.47 23:20:18 INFO - PROCESS | 1673 | Values: 89.0 93.0 129.0 78.0 78.0 80.0 115.0 78.0 76.0 114.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:85.50 stddev:2.60 (3.0%) stddev-sans-first:2.73 23:20:18 INFO - PROCESS | 1673 | Values: 86.0 82.0 85.0 83.0 91.0 84.0 86.0 83.0 86.0 83.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:92.50 stddev:24.27 (26.2%) stddev-sans-first:25.02 23:20:18 INFO - PROCESS | 1673 | Values: 93.0 106.0 149.0 93.0 130.0 150.0 94.0 93.0 92.0 92.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.36 23:20:18 INFO - PROCESS | 1673 | Values: 85.0 88.0 86.0 88.0 85.0 84.0 86.0 85.0 85.0 86.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.28 (6.0%) stddev-sans-first:3.46 23:20:18 INFO - PROCESS | 1673 | Values: 54.0 57.0 55.0 55.0 52.0 54.0 54.0 63.0 54.0 51.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:3.86 (5.6%) stddev-sans-first:3.70 23:20:18 INFO - PROCESS | 1673 | Values: 65.0 66.0 70.0 78.0 74.0 71.0 68.0 68.0 69.0 68.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:85.00 stddev:12.60 (14.8%) stddev-sans-first:13.23 23:20:18 INFO - PROCESS | 1673 | Values: 97.0 115.0 114.0 85.0 84.0 86.0 83.0 84.0 85.0 85.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:145.00 stddev:5.27 (3.6%) stddev-sans-first:5.58 23:20:18 INFO - PROCESS | 1673 | Values: 145.0 144.0 150.0 141.0 142.0 141.0 145.0 142.0 151.0 157.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:170.00 stddev:11.89 (7.0%) stddev-sans-first:1.50 23:20:18 INFO - PROCESS | 1673 | Values: 207.0 170.0 170.0 170.0 170.0 171.0 169.0 172.0 167.0 168.0 23:20:18 INFO - PROCESS | 1673 | 23:20:18 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.47 (3.6%) stddev-sans-first:2.39 23:20:18 INFO - PROCESS | 1673 | Values: 71.0 67.0 68.0 67.0 73.0 67.0 64.0 69.0 67.0 68.0 23:20:18 INFO - PROCESS | 1673 | -------- Summary: end -------- 23:20:18 INFO - PROCESS | 1673 | 23:20:19 INFO - TEST-INFO | 1673: exit 0 23:20:19 INFO - TEST-OK | kraken | took 57719ms 23:20:19 INFO - SUITE-END | took 1172s 23:20:19 INFO - Completed test suite (00:19:33) 23:20:19 INFO - javascript benchmark 23:20:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.837043962582, 3321.2859235264423, 3443.208062145708, 3477.704395126414, 3526.329997300513, 5595.38450770416, 5678.119891416837, 5746.425357464252, 5746.942530574693, 5751.367349591546, 5734.4265573442635, 5835.912461313083, 5841.182234487164, 5845.152452894327, 5862.73617687204, 5199.688018718889, 5233.345831771019, 5315.707636080014, 5338.973305133469, 5351.518363347298, 5342.626016178869, 5346.946530534684, 5350.571954243651, 5353.518183363496, 5361.41024487308, 5220.895582088356, 5358.5981051421295, 5377.731113444332, 5425.213344065108, 5443.020256353855, 5167.147420675584, 5200.635955483118, 5286.365636123652, 5295.232191332274, 5308.787648494055, 5216.139337009389, 5232.973835130838, 5246.527812496855, 5249.973750131263, 5283.973580132075, 4670.486246512881, 5646.971765141189, 5682.829515114553, 5687.0, 5735.942640573624, 6098.069176274479, 6148.6618235997, 6211.844703882439, 6255.655938923357, 6279.120923070774, 6271.96864015677, 6301.68491575424, 6323.9051414228825, 6335.588186767845, 6343.746250149989, 5840.503557197643, 5858.53131749459, 5860.531157507389, 5863.882722345572, 5870.0607902735355, 6236.407541283571, 6243.250809902841, 6309.936900631027, 6315.431611154926, 6349.333320001426, 6178.907316390258, 6193.597416167935, 6194.9690251549355, 6211.409916057967, 6223.097650840603, 6242.906356404657, 6262.5929314594405, 6326.335734747877, 6331.651759153198, 6345.206849143857, 6077.179580756541, 6114.71053653006, 6128.164296304456, 6145.0782382642965, 6257.937420625826, 6250.249970003538, 6279.529035322369, 6280.152179455807, 6289.905651415233, 6307.274663413675, 4968.652194346433, 4971.080350135237, 4976.477469865685, 4981.42713587942, 5005.624578156653, 4388.385626012361, 4474.888127796831, 4483.058557702853, 4520.773961301922, 4531.048479819209, 5668.858278543069, 5706.972744905874, 5708.942910570924, 5718.0, 5722.084466485426, 6219.751209951552, 6245.0632405139595, 6262.467690246289, 6272.937270627326, 6356.523260755462, 5678.375378708339, 5700.201971723962, 5700.800471983461, 5723.942760572424, 5753.597248192586, 5283.920741188886, 5341.62608617393, 5346.064438723208, 5360.91958620621, 5377.336031424855, 6239.906401403982, 6272.937270627326, 6295.433410993032, 6319.178506794087, 6347.206599175103, 6313.652749098844, 6324.209473815773, 6324.6521441321165, 6327.746890124344, 6346.07981842621, 6275.152854364785, 6319.05214217871, 6325.841853953504, 6333.050042493479, 6356.841078973062, 6095.969520152371, 6132.814448934826, 6203.7828675996125, 6253.530985176039, 6259.561830671809, 5273.34083239595, 5394.352677678704, 6318.241810982711, 6333.841653958688, 6335.176427064452, 6011.729472173675, 6153.815385538441, 6162.537809664383, 6178.0, 6187.474064704551, 5075.87310317245, 6117.3576774439825, 6138.296437970319, 6186.0, 6191.907121393273, 6025.337212906665, 6050.591330480968, 6062.514998799998, 6074.058520929263, 6136.447719705248, 6005.489533389711, 6111.816645500642, 6162.938370616236, 6164.6917654118015, 6180.721867515883, 5997.880042399215, 6007.549433792396, 6067.757289708362, 6130.785422510191, 6136.662483563447], "value": 5727.1199976994785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.2790964739718, 532.7629205003773, 533.9667742917454, 546.4289817141088, 599.5263741644102, 27307.044253451135, 29456.263593410124, 29521.2619684508, 29544.704552954463, 29557.261068473297, 25454.0, 38522.22955540888, 38622.0, 38694.0, 38717.8064109679, 9422.246220302377, 9639.662611808588, 9658.661946831862, 9659.90340096597, 9669.661561845336, 9381.953090234574, 9519.857202141973, 9554.378965367263, 9579.760505987337, 9580.952095239514, 9552.665656701982, 9609.135177834029, 9655.372400793962, 9709.417434953926, 9727.902720972806, 9605.327627066108, 9686.51567421633, 9687.079727425884, 9689.51552422383, 9696.933337332888, 8145.389095817778, 9495.05049495052, 9590.992945740667, 9606.327557071008, 9608.27937904653, 39436.60563394358, 39825.0, 39866.40200396996, 39873.60126398728, 39883.60116398828, 2726.7861390849134, 3447.293304872495, 3574.946375804365, 3910.921781564353, 3962.7424217425773, 24610.261692149084, 28076.71923280782, 28891.56662650062, 29302.974395896254, 29537.0, 2726.127639155471, 2751.9724802752116, 2759.65504311961, 2762.958555621667, 2838.6025956366125, 414493.0, 417015.999999997, 417242.0, 417788.0, 418730.0, 31637.0, 34758.47862282068, 35719.4642080369, 58053.709731451076, 58406.70796645989, 34084.829575852455, 34114.82942585271, 34202.82898585491, 34216.82891585526, 34283.0, 13825.723485530232, 13975.301234938212, 14013.579592612237, 14023.298835058411, 14035.298235088205, 11757.235779674294, 11824.408779560987, 11829.17195796286, 11833.0, 11841.763164736656, 8084.797880052928, 8115.594220288962, 8161.959190204011, 8206.0, 8223.506589604644, 3420.3330350581396, 3459.08334291413, 3459.3427248822645, 3464.809435481073, 3488.5639295088113, 991.1426615977272, 1004.4977511244377, 1016.598443614768, 1068.4283908109123, 1088.9546035805556, 23999.20005999557, 28838.855805720836, 28947.842086316734, 29678.703212968026, 29680.554791678143, 1092.546593163844, 1117.5306371324064, 1123.5955056179769, 1158.7798318319492, 1180.7933611617932, 14850.405983760744, 15027.774583381259, 15063.397464101314, 15410.845891541165, 15481.612959675873, 582441.0, 588368.0, 598261.0, 601941.0, 602255.0, 58320.0, 59165.704171478865, 59211.70394148002, 59286.0, 59571.53213509004, 1325.6818363592668, 1371.1567386057304, 1371.1841454334854, 1464.3337281536876, 1509.2378348933937, 29623.407531849673, 29854.402911942074, 29898.85050574733, 30713.692863071083, 30877.536836947915, 55353.44646553483, 57486.7125664369, 57547.0, 57595.848083038945, 57672.846543068066, 437018.0, 454611.0, 455330.0, 455672.0, 456795.0, 25584.48831023332, 40211.79894100511, 40754.1849163021, 41103.7944810286, 41713.0, 42165.57834421616, 42835.0, 43319.35020974625, 43322.0, 43360.34959475547, 33771.83114084414, 34969.82515087408, 36684.60003284674, 36801.81599091987, 37095.629043710294, 36208.275834482636, 36247.45628815517, 36271.730489432746, 37104.0, 37329.6267037337, 30467.390652187274, 31427.685723142476, 31943.840280798446, 32879.34241315208, 36746.816265918496, 30159.246018849703, 31453.528197076605, 31485.842570787914, 31553.684463155994, 31570.684293156773, 23584.29247122589, 24231.75768242295, 24469.143579974614, 24576.262712118663, 24681.506369872863], "value": 17978.081393681594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9296326661201, 397.6679472640345, 398.2612254268334, 404.0847480456768, 406.1815441884601, 14950.177740224284, 16338.836611633895, 17345.306187752507, 19390.515237119078, 20088.296909608147, 19589.412317630457, 19885.204591816346, 20594.382168534932, 20608.969551522438, 20677.896610516964, 4631.490536041041, 5852.209951656514, 5862.06207006879, 5867.911981320262, 5871.089981052944, 4112.999999999985, 4323.913521729579, 5665.688387138705, 5783.074708046714, 5793.681347525884, 6064.0, 6388.297287298416, 6428.292887782341, 6429.517786166056, 6441.645709485976, 6242.687865606701, 6332.303446620868, 6411.48708103353, 6427.035944608299, 6437.0666253393465, 5588.189712491707, 5594.748236329375, 5602.915956260659, 5606.159076138571, 5624.128260119688, 13050.347482625832, 13741.450341986309, 13771.931140344333, 13774.586762397144, 13775.448982040707, 2031.197676917624, 2053.661145910923, 2055.496403381166, 2086.0612724273988, 2143.5712857428575, 9560.235181185488, 9719.708408747749, 10133.240006999504, 10167.847482287772, 10197.337173083726, 1617.5713435939367, 1633.3711521064356, 1717.2787429279608, 1742.128935532234, 1753.7807774028247, 96589.51705241499, 109648.0, 111227.0, 117038.41480792627, 120373.39813300964, 11600.18798684084, 11671.766564668658, 11713.88286117128, 11730.0, 11886.821697674543, 13515.932420338033, 14054.859451405355, 14276.928615356857, 14951.775723364159, 14976.251187440585, 8267.586620668942, 8278.71024514139, 8334.583270836434, 8432.198941100585, 8447.32421406286, 8044.839103217902, 8070.192980702001, 8078.071021832447, 8197.754067377988, 8223.671053157927, 4069.2969397847814, 4348.499922508889, 4551.658625603093, 4644.512326205768, 4717.905641887143, 1965.3317871923614, 1976.5256338478948, 1976.9110390032483, 1977.8219960203362, 2006.56858775364, 864.1876635962176, 913.7030465098736, 918.9402688825205, 919.2278486071732, 1003.7340104872214, 17465.650686986442, 19775.505612359808, 20388.79611203869, 20626.27808026712, 20663.17347306121, 871.655696000089, 935.7520257131865, 947.8720372749591, 953.823542644613, 1017.7557386227401, 9905.158061564704, 10407.94796026015, 10517.42154181512, 10692.358458492516, 11398.601048963412, 492953.0, 624006.0, 627156.0, 640318.0, 644775.0, 113609.72780544509, 117426.8257317433, 125098.0, 126246.36876815557, 138097.6190238105, 1011.5751384418562, 1026.6868605075524, 1040.5941682743887, 1057.3127467146417, 1059.523214553454, 17063.06153161588, 17285.654286914443, 17569.0, 17613.0, 17720.291188352323, 49583.50416495933, 50163.74590635263, 50185.0, 50302.74848625733, 50866.74566627143, 60796.0, 64642.0, 69491.65254173697, 69771.65114174396, 70861.29138708753, 6813.0, 6817.659117044029, 6852.451803855779, 7286.562806231643, 8057.959710201411, 9174.220191283815, 11982.161248712506, 12077.637670869888, 12310.938445307716, 12540.87459125397, 10349.9482502587, 10394.376337419779, 10517.368957862553, 10837.295575787548, 10960.013598776148, 10424.68725938223, 10486.056254937092, 10610.029381007045, 10790.352578845295, 10867.29362591429, 10754.354738715389, 10935.56257749681, 11050.0, 11137.554497819996, 11207.047400970683, 7343.522671026366, 7456.96271518639, 7493.775186744407, 7510.549367037996, 7729.381649468141, 10213.948930255301, 10630.30902991303, 10880.347179169275, 10903.182261330274, 10947.124230061736], "value": 9111.127162048577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.0158689710643, 1601.3674598533576, 1619.5951012246937, 1885.7925628180897, 2001.5496513284504, 7770.3783697304225, 8475.745727628173, 8718.60766265518, 8722.38943273971, 8730.083341249172, 7174.354308112269, 7361.926380736191, 8128.780682897568, 8201.630926608303, 8593.140685931403, 2385.2367242482414, 2421.092090466075, 2422.515496900618, 2425.223928342931, 2426.8665223412704, 2081.2923605973965, 2374.6912901322803, 2385.129427758864, 2393.820463465247, 2431.404305945046, 2393.6768536247646, 2399.0523743121457, 2404.8557086574774, 2430.7569243075727, 2430.987845060772, 2109.799569040946, 2335.0426325206668, 2386.3079706884982, 2408.8675122868235, 2418.4195793009726, 2132.3070002249333, 2246.146464343539, 2351.3063646224405, 2395.2215529952837, 2399.2802159352123, 8634.827303453958, 8655.826883462358, 8688.956555217246, 8716.912830871674, 8717.869231961526, 5088.1350170471105, 5310.787568497255, 5311.973440132813, 5317.707526086064, 5332.493413125786, 3110.4867696829997, 3508.7193024557973, 3548.2193917338145, 3585.8744943926836, 3586.0855481852223, 1026.768976980181, 1044.253358848427, 1048.4024106259435, 1051.75283808305, 1053.3627155570846, 11320.377379244139, 11324.0, 11338.433078346132, 11354.034907032912, 11354.772904541864, 4593.862184134481, 4678.953210467852, 4805.423349198119, 4851.102546028996, 4852.660313778002, 9589.136977672042, 9594.904050959542, 9600.32797704168, 9631.422114673142, 9645.0, 5277.815276465305, 5281.9207711884355, 5282.630215884851, 5283.9471605284225, 5297.258383826267, 4033.4353190553347, 4299.871003869889, 4397.472303323558, 4812.374391329105, 4873.293372460973, 3924.9607503925167, 3987.4816273884207, 4024.195160967818, 4050.4936882889638, 4067.572904845008, 1325.8342707161605, 1326.4362645875465, 1330.5010621017118, 1345.5492410042746, 1351.8580549042406, 949.1647350331664, 960.1118964957386, 977.1889331854544, 999.3753903809974, 1002.7894142230067, 7791.610419479003, 7962.7213047543055, 7974.9632547768415, 7975.561344126013, 7980.720674776355, 502.8441183233209, 509.38364578859256, 512.6232219318798, 517.3171413733835, 521.3379008658982, 6179.073139029181, 6184.381561843779, 6318.241810982711, 6325.493960483151, 6336.493080553545, 10149.695509134737, 10522.579096836194, 10527.052565269163, 10592.735181620366, 10622.628208012682, 10368.326058806153, 10430.0, 10483.580656773796, 10487.37075775456, 10495.737606559896, 7821.217878212134, 7922.762317130495, 8042.879356809535, 8052.154523775036, 8073.152319006537, 7660.923390766021, 7886.132525422314, 7906.0, 7922.801929951797, 7926.682932682628, 9395.765105872408, 9652.613895444385, 9741.464219467998, 9793.657221997197, 9815.85276220843, 7666.041744781903, 9728.902710973083, 9960.601575936882, 9975.251856110675, 9977.251706121924, 6392.840178995562, 6758.189017317954, 7084.326988936043, 7324.19433862264, 7366.815829604303, 7716.807079822825, 7958.3235424989525, 8008.719694810654, 8025.197480251928, 8037.7588672339925, 7205.891911621225, 7221.638918054181, 7314.780556583311, 7348.889766653611, 7373.446991475768, 7018.824529386806, 7124.145102587722, 7130.322619351154, 7256.96371518139, 7295.270472952874, 7558.508696934681, 7640.197779233323, 7641.732539361095, 7657.846843063219, 7659.808504787202, 6855.177378714586, 6980.511364204457, 6985.685644145924, 7005.0, 7025.016497690225, 7039.859202816017, 7086.220515743161, 7123.180834203926, 7123.180834204133, 7148.499605027599], "value": 4700.431800969353, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.77279245339577, 319.89763275751756, 326.8708860000298, 328.70252421558496, 332.33864609427246, 5583.441655834419, 5832.270966129228, 5902.586818922677, 5909.704514774266, 5959.433853783895, 4772.78522466489, 5794.739236734346, 5816.912746308809, 5820.650760954335, 5922.822315330547, 3537.9469307960403, 3982.8207730652043, 4166.749995000309, 4269.423627810253, 4330.50199227089, 3959.386295124246, 4113.25961326961, 4399.73601583906, 4477.440319960005, 4477.48508921475, 4440.422745043156, 4441.133978874121, 4441.356003379508, 4450.777461126931, 4467.5755803198645, 4167.5619762438855, 4232.25935461293, 4415.359772832953, 4429.889252768674, 4456.732596044215, 3198.3763166182603, 3837.5586807517216, 3849.615038496156, 3850.4994350734505, 3859.3824988002066, 5188.870278243036, 5641.464060914206, 5646.943530564724, 5669.914951275734, 5745.368009518949, 4232.661387089025, 4511.909761804778, 4542.772861356919, 5081.441041485434, 5148.3821941366905, 5099.796008159669, 5640.843627056443, 6126.846828829271, 6206.834514397689, 6242.843928901813, 3551.3607550640872, 4040.1717647882115, 4271.466066741657, 4272.978635106836, 4295.377170310318, 5008.524190201925, 5850.882982340329, 6196.721147548371, 6266.561340706153, 6360.300366959631, 4245.8513952011535, 4313.590208930146, 4336.891577710519, 4363.781810909441, 4379.146066516999, 4418.762746431004, 4419.889502762392, 4435.667324950641, 4443.666724995638, 4449.621782148553, 4957.273499575292, 5112.539871411591, 5139.7687104080405, 5154.639175257696, 5167.586593072545, 5118.206677964921, 5219.347581552306, 6267.65527895961, 6296.811095667137, 6311.810645680637, 1275.3177050278243, 1507.555271194978, 1523.6800271943016, 1527.594612956083, 1527.7173722861085, 861.8362511122992, 900.2752784008804, 947.2706016367358, 983.8160769219276, 991.965281215154, 4806.0, 5211.009908117446, 5760.567957403212, 5768.9711551442815, 5844.561657875676, 5998.490128339053, 6139.140520327158, 6436.3241859605005, 6473.417392434703, 6481.578697384655, 4801.807927682854, 5487.0, 5582.246396736388, 5748.942510574924, 5797.391273916262, 2907.3458471843664, 3246.740260779179, 3349.748768842298, 3388.2376465295606, 3390.4066788311948, 6280.214973128359, 6401.743930242738, 6667.933320666732, 6668.799936001928, 6707.262201157869, 5697.401772813878, 5831.241938547962, 6206.689665516707, 6565.474762019027, 6582.544164313774, 6234.719437625317, 6436.613803171825, 6626.304238055031, 6651.63416012124, 6656.771465838968, 6347.492200623847, 6361.0, 6376.617402955838, 6392.616443013248, 6403.64779937108, 4990.577685359655, 6299.275583307978, 6304.968475157595, 6338.144350512622, 6416.262129855127, 5445.863853403538, 5611.38274789781, 6306.400891915261, 6357.586756860789, 6374.107624932606, 4347.65218782503, 4362.563743625612, 4367.606915377632, 4371.103923695571, 4406.449193850769, 5570.24801651788, 5733.31200255972, 6351.904721429275, 6426.518011149089, 6503.772367967098, 6205.703889560711, 6281.811545653638, 6284.937150628435, 6294.779682711083, 6304.369563043659, 5451.700156491431, 6025.276966763841, 6264.404881536247, 6304.779332723333, 6317.936820631735, 6134.35589263121, 6148.754049838135, 6154.707231631056, 6155.138280640804, 6170.167027451236, 5726.165548053574, 5870.178175055581, 6215.782447614311, 6293.874122517433, 6302.527310451826, 5337.412884582771, 5760.884782304247, 5953.613015154175, 6014.188084608521, 6150.10823430609], "value": 4501.82495194365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.7551743613581, 741.3985790692107, 742.4134933402612, 759.810047488128, 801.0707579208118, 14622.122672639649, 14694.559163225107, 15183.924080379582, 15228.0, 15229.923850380746, 11449.2557983731, 14472.638184045403, 14478.782818257734, 14479.986400951937, 14486.130832150078, 748.0350348051007, 771.1632878327022, 914.5655813488573, 915.9175674189322, 948.8481842905137, 948.1182500274741, 951.1202138022302, 955.412421360865, 959.2853324273426, 961.5576834656067, 988.9456079915602, 990.692885205585, 993.602558976408, 993.9850902236473, 995.3878364805629, 780.2431641307923, 950.6815216902346, 978.990210097897, 999.0109791306554, 1001.0790073132663, 731.8646050480678, 737.4948160510068, 738.0663460722191, 743.438703778649, 744.6537360127512, 15030.17334046627, 15040.473583424528, 15044.022138560958, 15064.0, 15073.020253683475, 12386.62840114789, 12437.253764774143, 12525.624231272985, 12575.811362829565, 12600.495980160782, 10880.891191088147, 11113.388763617997, 11114.444277786079, 11265.493052812642, 11566.421678916106, 4154.626083652486, 4214.904124927511, 4268.338407546835, 4300.548442413564, 4324.545922678105, 84096.3180736388, 84400.0, 84454.0, 88034.55982720046, 88088.11911880864, 9551.856722149174, 9622.759431014281, 9713.320067595201, 10087.848682269772, 10273.021290105004, 22164.556708866054, 22178.778212217992, 22192.889035555043, 22206.66689999651, 22267.220647277267, 7531.359834414026, 7550.962245188849, 7755.457118001686, 7885.48744331628, 7894.842103157905, 3504.3829704529403, 4121.361189015707, 4193.30810416284, 4201.831926722958, 4216.978915105405, 3452.5684289463816, 3547.2018795770746, 3550.9112272192883, 3552.8401221945073, 3564.3049605326714, 548.314606741573, 633.6456938866596, 641.9903701444482, 653.8855700252532, 664.4385494257344, 534.9411564727877, 554.9201929292411, 555.7832445346318, 592.9534371833716, 601.3685630088389, 7643.617819109022, 7684.500507466997, 7715.673148018571, 7719.768406947801, 8238.258556729923, 555.328053055807, 556.4352182534731, 582.4059459351438, 589.9557782724639, 597.4981015946539, 3717.8141092945784, 3731.6641502264924, 3737.9626203738158, 3792.9123756371177, 3803.4786085565993, 83042.0, 84196.0, 85122.14877851267, 85446.71829922555, 85538.0, 72601.91097133547, 73925.26074739291, 74152.62923685346, 74623.64193611301, 75082.6245868778, 52029.479705202466, 64114.0, 66472.35276472314, 67886.64226715438, 68698.31301687019, 7106.289371062852, 7329.230430804902, 7350.117985841734, 7373.152087510005, 7380.372668323253, 31589.684103158674, 42036.94907627334, 42619.57380426156, 43173.0, 43521.78239108784, 56380.590485238194, 60541.0, 60730.0, 60757.0, 61436.69281653563, 8240.711575094843, 9766.658166964122, 10090.293679442368, 10148.797024059626, 10162.237832162766, 10422.635207767691, 10471.842922356018, 10539.841902371318, 10639.840402394126, 11078.612248571262, 9469.337146399961, 9486.810263794823, 9661.758456038655, 9755.658551950648, 9775.853362199716, 9999.000099989942, 10008.249381296577, 10108.241881858743, 10368.066873981377, 10408.063274305348, 9618.951905240428, 9695.91884525906, 9723.416595004323, 9903.306768526134, 10219.978002199721, 8332.33341332704, 8496.787580310542, 8719.258862996716, 8870.379073464796, 8883.777905552413, 8129.715459958873, 8276.503409795432, 8439.240468357877, 8451.619677114422, 8482.363822713445], "value": 6685.388057324468, "unit": "score"}], "name": "dromaeo_css", "value": 7142.061019145502, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 112.0, 118.0, 112.0, 112.0, 116.0, 111.0, 111.0, 116.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 142.0, 162.0, 118.0, 142.0, 141.0, 123.0, 191.0, 157.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 186.0, 185.0, 188.0, 186.0, 186.0, 180.0, 185.0, 184.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 85.0, 80.0, 56.0, 58.0, 57.0, 101.0, 107.0, 82.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 129.0, 78.0, 78.0, 80.0, 115.0, 78.0, 76.0, 114.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 85.0, 83.0, 91.0, 84.0, 86.0, 83.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 106.0, 149.0, 93.0, 130.0, 150.0, 94.0, 93.0, 92.0, 92.0], "value": 109.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 86.0, 88.0, 85.0, 84.0, 86.0, 85.0, 85.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 55.0, 55.0, 52.0, 54.0, 54.0, 63.0, 54.0, 51.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 70.0, 78.0, 74.0, 71.0, 68.0, 68.0, 69.0, 68.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 115.0, 114.0, 85.0, 84.0, 86.0, 83.0, 84.0, 85.0, 85.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 150.0, 141.0, 142.0, 141.0, 145.0, 142.0, 151.0, 157.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 170.0, 170.0, 170.0, 170.0, 171.0, 169.0, 172.0, 167.0, 168.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 68.0, 67.0, 73.0, 67.0, 64.0, 69.0, 67.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1497.7, "alertThreshold": 2.0}]} 23:20:19 INFO - Return code: 0 23:20:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:20:19 ERROR - # TBPL SUCCESS # 23:20:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:20:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:20:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:20:19 INFO - 2016-04-07 23:20:19.685 screenresolution[1677:9477] starting screenresolution argv=screenresolution get 23:20:19 INFO - 2016-04-07 23:20:19.687 screenresolution[1677:9477] Display 0: 1600x1200x32@60 23:20:19 INFO - 2016-04-07 23:20:19.693 screenresolution[1678:9480] starting screenresolution argv=screenresolution list 23:20:19 INFO - Available Modes on Display 0 23:20:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:20:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:20:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:20:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:20:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:20:19 INFO - Intel Iris: 23:20:19 INFO - Chipset Model: Intel Iris 23:20:19 INFO - Type: GPU 23:20:19 INFO - Bus: Built-In 23:20:19 INFO - VRAM (Dynamic, Max): 1536 MB 23:20:19 INFO - Vendor: Intel (0x8086) 23:20:19 INFO - Device ID: 0x0a2e 23:20:19 INFO - Revision ID: 0x0009 23:20:19 INFO - Displays: 23:20:19 INFO - Display: 23:20:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:20:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:20:19 INFO - Display Serial Number: 1600x1200 60 23:20:19 INFO - Main Display: Yes 23:20:19 INFO - Mirror: Off 23:20:19 INFO - Online: Yes 23:20:19 INFO - Rotation: Supported 23:20:19 INFO - Return code: 0 23:20:19 INFO - Running post-action listener: _resource_record_post_action 23:20:19 INFO - Running post-run listener: _resource_record_post_run 23:20:20 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37230080; Write bytes: 692355072; Read time: 391; Write time: 1863 23:20:20 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 385569280; Write bytes: 378856960; Read time: 28361; Write time: 677 23:20:20 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 35411456; Write bytes: 298121728; Read time: 371; Write time: 1153 23:20:20 INFO - Running post-run listener: _upload_blobber_files 23:20:20 INFO - Blob upload gear active. 23:20:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:20:20 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 23:20:20 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'] 23:20:20 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 23:20:21 INFO - (blobuploader) - INFO - Open directory for files ... 23:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:22 INFO - (blobuploader) - INFO - Done attempting. 23:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:23 INFO - (blobuploader) - INFO - Done attempting. 23:20:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:20:23 INFO - Return code: 0 23:20:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:20:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:20:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ee34e65939387d94e9c22119e0d5a8172bba8121e09a0b8165b6c12276567a54be5ae6ed9e82dac9f396b8eceabc26ea1858d63fc89823db0f474431c7b3fdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fe8a8a064522a355c09da840a2e83c33e451ad85943b5ed8476902d87035b71771e33cc4d1f8d4f72b08a09ad5718c4e50b94252b5a748c5535a5a87c15c9e"} 23:20:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:20:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:20:23 INFO - Contents: 23:20:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ee34e65939387d94e9c22119e0d5a8172bba8121e09a0b8165b6c12276567a54be5ae6ed9e82dac9f396b8eceabc26ea1858d63fc89823db0f474431c7b3fdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fe8a8a064522a355c09da840a2e83c33e451ad85943b5ed8476902d87035b71771e33cc4d1f8d4f72b08a09ad5718c4e50b94252b5a748c5535a5a87c15c9e"} 23:20:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:20:23 INFO - Copying logs to upload dir... 23:20:23 INFO - mkdir: /builds/slave/test/build/upload/logs 23:20:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.166702 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-07 23:20:23.438698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 23:20:23.442924) ========= 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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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/5ee34e65939387d94e9c22119e0d5a8172bba8121e09a0b8165b6c12276567a54be5ae6ed9e82dac9f396b8eceabc26ea1858d63fc89823db0f474431c7b3fdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fe8a8a064522a355c09da840a2e83c33e451ad85943b5ed8476902d87035b71771e33cc4d1f8d4f72b08a09ad5718c4e50b94252b5a748c5535a5a87c15c9e"} build_url:https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010938 build_url: 'https://queue.taskcluster.net/v1/task/eARAgOM4TKGKsrAij7VXYg/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/5ee34e65939387d94e9c22119e0d5a8172bba8121e09a0b8165b6c12276567a54be5ae6ed9e82dac9f396b8eceabc26ea1858d63fc89823db0f474431c7b3fdb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28fe8a8a064522a355c09da840a2e83c33e451ad85943b5ed8476902d87035b71771e33cc4d1f8d4f72b08a09ad5718c4e50b94252b5a748c5535a5a87c15c9e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 23:20:23.480386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 23:20:23.480718) ========= 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.Hdm1nijO8q/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.u6OR9rDP3j/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005256 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 23:20:23.533700) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 23:20:23.534022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 23:20:23.534433) ========= ========= Total master_lag: 0.30 =========