builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0152 starttime: 1455224051.0 results: success (0) buildid: 20160211104134 builduid: 59c620b89531461b9a425c2f04d4e8f2 revision: 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:10.998741) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:10.999179) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:10.999489) ========= 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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005512 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.067067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.067401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.083433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.083695) ========= 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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005670 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.130988) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.131265) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.131610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.131888) ========= 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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-02-11 12:54:11-- 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% 154M=0s 2016-02-11 12:54:11 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.263857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.264175) ========= 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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.025402 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:11.315878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 12:54:11.316229) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-02-11 12:54:11,390 truncating revision to first 12 chars 2016-02-11 12:54:11,390 Setting DEBUG logging. 2016-02-11 12:54:11,391 attempt 1/10 2016-02-11 12:54:11,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/576a6dcde5b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 12:54:12,443 unpacking tar archive at: mozilla-central-576a6dcde5b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.298729 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 12:54:12.751699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:12.752051) ========= echo 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'576a6dcde5b68c2ea45324ed5ce1dabb7d833d09'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 program finished with exit code 0 elapsedTime=0.005786 script_repo_revision: '576a6dcde5b68c2ea45324ed5ce1dabb7d833d09' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:12.774324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:12.775107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 12:54:12.793312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-11 12:54:12.793660) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:12 INFO - MultiFileLogger online at 20160211 12:54:12 in /builds/slave/test 12:54:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:54:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:12 INFO - {'append_to_log': False, 12:54:12 INFO - 'base_work_dir': '/builds/slave/test', 12:54:12 INFO - 'blob_upload_branch': 'Firefox', 12:54:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:12 INFO - 'branch': 'Firefox', 12:54:12 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:12 INFO - 'config_files': ('talos/mac_config.py',), 12:54:12 INFO - 'default_actions': ('clobber', 12:54:12 INFO - 'read-buildbot-config', 12:54:12 INFO - 'download-and-extract', 12:54:12 INFO - 'populate-webroot', 12:54:12 INFO - 'create-virtualenv', 12:54:12 INFO - 'install', 12:54:12 INFO - 'run-tests'), 12:54:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:12 INFO - 'download_minidump_stackwalk': True, 12:54:12 INFO - 'download_symbols': 'ondemand', 12:54:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:12 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:12 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:12 INFO - 'installer_path': 'installer.exe', 12:54:12 INFO - 'log_level': 'info', 12:54:12 INFO - 'log_name': 'talos', 12:54:12 INFO - 'log_to_console': True, 12:54:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:54:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:54:12 INFO - 'opt_config_files': (), 12:54:12 INFO - 'pip_index': False, 12:54:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:54:12 INFO - 'cmd': ('bash', 12:54:12 INFO - '-c', 12:54:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:54:12 INFO - 'enabled': True, 12:54:12 INFO - 'halt_on_failure': False, 12:54:12 INFO - 'name': 'check_screen_resolution'},), 12:54:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:54:12 INFO - 'cmd': ('bash', 12:54:12 INFO - '-c', 12:54:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:54:12 INFO - 'enabled': True, 12:54:12 INFO - 'halt_on_failure': False, 12:54:12 INFO - 'name': 'check_screen_resolution'},), 12:54:12 INFO - 'run_cmd_checks_enabled': True, 12:54:12 INFO - 'sps_profile': False, 12:54:12 INFO - 'sps_profile_interval': 0, 12:54:12 INFO - 'suite': 'dromaeojs-e10s', 12:54:12 INFO - 'system_bits': '32', 12:54:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:12 INFO - 'title': 't-yosemite-r7-0152', 12:54:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:12 INFO - 'use_talos_json': True, 12:54:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:12 INFO - 'work_dir': 'build'} 12:54:12 INFO - ##### 12:54:12 INFO - ##### Running clobber step. 12:54:12 INFO - ##### 12:54:12 INFO - Running pre-action listener: _resource_record_pre_action 12:54:12 INFO - Running main action method: clobber 12:54:12 INFO - rmtree: /builds/slave/test/build 12:54:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:15 INFO - Running post-action listener: _resource_record_post_action 12:54:15 INFO - ##### 12:54:15 INFO - ##### Running read-buildbot-config step. 12:54:15 INFO - ##### 12:54:15 INFO - Running pre-action listener: _resource_record_pre_action 12:54:15 INFO - Running main action method: read_buildbot_config 12:54:15 INFO - Using buildbot properties: 12:54:15 INFO - { 12:54:15 INFO - "project": "", 12:54:15 INFO - "product": "firefox", 12:54:15 INFO - "script_repo_revision": "production", 12:54:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:54:15 INFO - "repository": "", 12:54:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:54:15 INFO - "buildid": "20160211104134", 12:54:15 INFO - "pgo_build": "False", 12:54:15 INFO - "basedir": "/builds/slave/test", 12:54:15 INFO - "buildnumber": 108, 12:54:15 INFO - "slavename": "t-yosemite-r7-0152", 12:54:15 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:54:15 INFO - "platform": "yosemite_r7", 12:54:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:54:15 INFO - "branch": "mozilla-central", 12:54:15 INFO - "repo_path": "mozilla-central", 12:54:15 INFO - "revision": "576a6dcde5b68c2ea45324ed5ce1dabb7d833d09", 12:54:15 INFO - "stage_platform": "macosx64", 12:54:15 INFO - "builduid": "59c620b89531461b9a425c2f04d4e8f2", 12:54:15 INFO - "slavebuilddir": "test" 12:54:15 INFO - } 12:54:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 12:54:15 INFO - Running post-action listener: _resource_record_post_action 12:54:15 INFO - ##### 12:54:15 INFO - ##### Running download-and-extract step. 12:54:15 INFO - ##### 12:54:15 INFO - Running pre-action listener: _resource_record_pre_action 12:54:15 INFO - Running main action method: download_and_extract 12:54:15 INFO - mkdir: /builds/slave/test/build/tests 12:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:15 INFO - https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/test_packages.json 12:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/test_packages.json 12:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:54:16 INFO - Downloaded 1277 bytes. 12:54:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:54:16 INFO - Using the following test package requirements: 12:54:16 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:54:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 12:54:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 12:54:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'jsshell-mac.zip'], 12:54:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 12:54:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:54:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 12:54:16 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 12:54:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 12:54:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:54:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:54:16 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 12:54:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:16 INFO - https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:54:17 INFO - Downloaded 17755023 bytes. 12:54:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:54:20 INFO - Return code: 0 12:54:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:20 INFO - https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:54:21 INFO - Downloaded 17755023 bytes. 12:54:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:54:24 INFO - Return code: 0 12:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:24 INFO - https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:54:25 INFO - Downloaded 10706547 bytes. 12:54:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:54:25 INFO - Return code: 0 12:54:25 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')]} 12:54:25 INFO - https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 12:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 12:54:28 INFO - Downloaded 111145698 bytes. 12:54:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:54:28 INFO - mkdir: /builds/slave/test/properties 12:54:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:28 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:28 INFO - Contents: 12:54:28 INFO - build_url:https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:54:29 INFO - Running post-action listener: _resource_record_post_action 12:54:29 INFO - Running post-action listener: set_extra_try_arguments 12:54:29 INFO - ##### 12:54:29 INFO - ##### Running populate-webroot step. 12:54:29 INFO - ##### 12:54:29 INFO - Running pre-action listener: _resource_record_pre_action 12:54:29 INFO - Running main action method: populate_webroot 12:54:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:29 INFO - '--tppagecycles', 12:54:29 INFO - '7'], 12:54:29 INFO - 'tests': ['tsvgm']}}, 12:54:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:54:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:54:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'tests': ['damp', 'tps']}, 12:54:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['damp', 'tps']}, 12:54:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:54:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:29 INFO - 'other': {'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore']}, 12:54:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore']}, 12:54:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore']}, 12:54:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore']}, 12:54:29 INFO - 'other_l64': {'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore']}, 12:54:29 INFO - 'other_nol64': {'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore']}, 12:54:29 INFO - 'svgr': {'tests': ['tsvgx', 12:54:29 INFO - 'tsvgr_opacity', 12:54:29 INFO - 'tart', 12:54:29 INFO - 'tscrollx', 12:54:29 INFO - 'cart']}, 12:54:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['tsvgx', 12:54:29 INFO - 'tsvgr_opacity', 12:54:29 INFO - 'tart', 12:54:29 INFO - 'tscrollx', 12:54:29 INFO - 'cart']}, 12:54:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'tests': ['tp5o']}, 12:54:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--e10s'], 12:54:29 INFO - 'tests': ['tp5o']}, 12:54:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--xperf_path', 12:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:29 INFO - 'tests': ['tp5n']}, 12:54:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--e10s', 12:54:29 INFO - '--xperf_path', 12:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:29 INFO - 'tests': ['tp5n']}}, 12:54:29 INFO - 'talos.zip': {'path': '', 12:54:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:29 INFO - Running post-action listener: _resource_record_post_action 12:54:29 INFO - ##### 12:54:29 INFO - ##### Running create-virtualenv step. 12:54:29 INFO - ##### 12:54:29 INFO - Running pre-action listener: _resource_record_pre_action 12:54:29 INFO - Running main action method: create_virtualenv 12:54:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:29 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 12:54:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:29 INFO - Using real prefix '/tools/python27' 12:54:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:33 INFO - Installing pip.................done. 12:54:33 INFO - Return code: 0 12:54:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:33 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:33 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 12:54:33 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 12:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:33 INFO - 'HOME': '/Users/cltbld', 12:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:33 INFO - 'LOGNAME': 'cltbld', 12:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:33 INFO - 'MOZ_NO_REMOTE': '1', 12:54:33 INFO - 'NO_EM_RESTART': '1', 12:54:33 INFO - 'PAGER': '/bin/cat', 12:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:33 INFO - 'PWD': '/builds/slave/test', 12:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:33 INFO - 'SHELL': '/bin/bash', 12:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:33 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:33 INFO - 'USER': 'cltbld', 12:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:33 INFO - 'XPC_FLAGS': '0x0', 12:54:33 INFO - 'XPC_SERVICE_NAME': '0', 12:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:33 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 12:54:33 INFO - Cleaning up... 12:54:33 INFO - Return code: 0 12:54:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:33 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:33 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 12:54:33 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 12:54:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:33 INFO - 'HOME': '/Users/cltbld', 12:54:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:33 INFO - 'LOGNAME': 'cltbld', 12:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:33 INFO - 'MOZ_NO_REMOTE': '1', 12:54:33 INFO - 'NO_EM_RESTART': '1', 12:54:33 INFO - 'PAGER': '/bin/cat', 12:54:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:33 INFO - 'PWD': '/builds/slave/test', 12:54:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:33 INFO - 'SHELL': '/bin/bash', 12:54:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:33 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:33 INFO - 'USER': 'cltbld', 12:54:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:33 INFO - 'XPC_FLAGS': '0x0', 12:54:33 INFO - 'XPC_SERVICE_NAME': '0', 12:54:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:34 INFO - Downloading/unpacking psutil>=0.7.1 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:36 INFO - Installing collected packages: psutil 12:54:36 INFO - Running setup.py install for psutil 12:54:36 INFO - building 'psutil._psutil_osx' extension 12:54:36 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 12:54:37 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 12:54:37 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 12:54:37 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 12:54:37 INFO - building 'psutil._psutil_posix' extension 12:54:37 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 12:54:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:54:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:54:37 INFO - ^ 12:54:37 INFO - 1 warning generated. 12:54:37 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 12:54:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:38 INFO - Successfully installed psutil 12:54:38 INFO - Cleaning up... 12:54:38 INFO - Return code: 0 12:54:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:38 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 12:54:38 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 12:54:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:38 INFO - 'HOME': '/Users/cltbld', 12:54:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:38 INFO - 'LOGNAME': 'cltbld', 12:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:38 INFO - 'MOZ_NO_REMOTE': '1', 12:54:38 INFO - 'NO_EM_RESTART': '1', 12:54:38 INFO - 'PAGER': '/bin/cat', 12:54:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:38 INFO - 'PWD': '/builds/slave/test', 12:54:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:38 INFO - 'SHELL': '/bin/bash', 12:54:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:38 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:38 INFO - 'USER': 'cltbld', 12:54:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:38 INFO - 'XPC_FLAGS': '0x0', 12:54:38 INFO - 'XPC_SERVICE_NAME': '0', 12:54:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:54:38 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 12:54:38 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 12:54:38 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 12:54:38 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 12:54:38 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 12:54:38 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 12:54:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:54:40 INFO - Installing collected packages: mozsystemmonitor 12:54:40 INFO - Running setup.py install for mozsystemmonitor 12:54:40 INFO - Successfully installed mozsystemmonitor 12:54:40 INFO - Cleaning up... 12:54:40 INFO - Return code: 0 12:54:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:40 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')]} 12:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:40 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')]} 12:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:40 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:40 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 12:54:40 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 12:54:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:40 INFO - 'HOME': '/Users/cltbld', 12:54:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:40 INFO - 'LOGNAME': 'cltbld', 12:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:40 INFO - 'MOZ_NO_REMOTE': '1', 12:54:40 INFO - 'NO_EM_RESTART': '1', 12:54:40 INFO - 'PAGER': '/bin/cat', 12:54:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:40 INFO - 'PWD': '/builds/slave/test', 12:54:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:40 INFO - 'SHELL': '/bin/bash', 12:54:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:40 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:40 INFO - 'USER': 'cltbld', 12:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:40 INFO - 'XPC_FLAGS': '0x0', 12:54:40 INFO - 'XPC_SERVICE_NAME': '0', 12:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - Downloading docopt-0.6.1.tar.gz 12:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:44 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:44 INFO - Running setup.py install for blobuploader 12:54:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:44 INFO - Running setup.py install for requests 12:54:45 INFO - Running setup.py install for docopt 12:54:45 INFO - Successfully installed blobuploader requests docopt 12:54:45 INFO - Cleaning up... 12:54:45 INFO - Return code: 0 12:54:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:45 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 12:54:45 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 12:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:45 INFO - 'HOME': '/Users/cltbld', 12:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:45 INFO - 'LOGNAME': 'cltbld', 12:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:45 INFO - 'MOZ_NO_REMOTE': '1', 12:54:45 INFO - 'NO_EM_RESTART': '1', 12:54:45 INFO - 'PAGER': '/bin/cat', 12:54:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:45 INFO - 'PWD': '/builds/slave/test', 12:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:45 INFO - 'SHELL': '/bin/bash', 12:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:45 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:45 INFO - 'USER': 'cltbld', 12:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:45 INFO - 'XPC_FLAGS': '0x0', 12:54:45 INFO - 'XPC_SERVICE_NAME': '0', 12:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:45 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4D9NxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:45 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-_SJ_Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4FkEmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-PCUuZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-fyWKV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-fdJQ7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-jONpYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GJnjIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-3clmlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-bzIPRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:46 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-OD3eZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-dYa7dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-bKNssI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-WJfsgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-qGptOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-oduYG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:47 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-dun3q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:47 INFO - Running setup.py install for manifestparser 12:54:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozcrash 12:54:47 INFO - Running setup.py install for mozdebug 12:54:48 INFO - Running setup.py install for mozdevice 12:54:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozfile 12:54:48 INFO - Running setup.py install for mozhttpd 12:54:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozinfo 12:54:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozInstall 12:54:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozleak 12:54:48 INFO - Running setup.py install for mozlog 12:54:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Running setup.py install for moznetwork 12:54:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Running setup.py install for mozprocess 12:54:49 INFO - Running setup.py install for mozprofile 12:54:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Running setup.py install for mozrunner 12:54:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Running setup.py install for mozscreenshot 12:54:49 INFO - Running setup.py install for moztest 12:54:50 INFO - Running setup.py install for mozversion 12:54:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:50 INFO - Cleaning up... 12:54:50 INFO - Return code: 0 12:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:50 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:50 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 12:54:50 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 12:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:50 INFO - 'HOME': '/Users/cltbld', 12:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:50 INFO - 'LOGNAME': 'cltbld', 12:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:50 INFO - 'MOZ_NO_REMOTE': '1', 12:54:50 INFO - 'NO_EM_RESTART': '1', 12:54:50 INFO - 'PAGER': '/bin/cat', 12:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:50 INFO - 'PWD': '/builds/slave/test', 12:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:50 INFO - 'SHELL': '/bin/bash', 12:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:50 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:50 INFO - 'USER': 'cltbld', 12:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:50 INFO - 'XPC_FLAGS': '0x0', 12:54:50 INFO - 'XPC_SERVICE_NAME': '0', 12:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-cZqemC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-6hYZ6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-HdbEFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ZPQ6Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-881pvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GPI7Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-KJTmJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-KkLfeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-M3hfdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-GqmLGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-jHzrJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-9uOxOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-n9sg5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-0oqAPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:51 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)) 12:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:51 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-aEy1YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:52 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)) 12:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:52 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-iKmvzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:52 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)) 12:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:52 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4L37Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:52 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)) 12:54:52 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:52 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:54 INFO - Downloading blessings-1.6.tar.gz 12:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:54 INFO - Installing collected packages: blessings 12:54:54 INFO - Running setup.py install for blessings 12:54:54 INFO - Successfully installed blessings 12:54:54 INFO - Cleaning up... 12:54:54 INFO - Return code: 0 12:54:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:55 INFO - Reading from file tmpfile_stdout 12:54:55 INFO - Current package versions: 12:54:55 INFO - blessings == 1.6 12:54:55 INFO - blobuploader == 1.2.4 12:54:55 INFO - docopt == 0.6.1 12:54:55 INFO - manifestparser == 1.1 12:54:55 INFO - mozInstall == 1.12 12:54:55 INFO - mozcrash == 0.16 12:54:55 INFO - mozdebug == 0.1 12:54:55 INFO - mozdevice == 0.48 12:54:55 INFO - mozfile == 1.2 12:54:55 INFO - mozhttpd == 0.7 12:54:55 INFO - mozinfo == 0.9 12:54:55 INFO - mozleak == 0.1 12:54:55 INFO - mozlog == 3.1 12:54:55 INFO - moznetwork == 0.27 12:54:55 INFO - mozprocess == 0.22 12:54:55 INFO - mozprofile == 0.28 12:54:55 INFO - mozrunner == 6.11 12:54:55 INFO - mozscreenshot == 0.1 12:54:55 INFO - mozsystemmonitor == 0.0 12:54:55 INFO - moztest == 0.7 12:54:55 INFO - mozversion == 1.4 12:54:55 INFO - psutil == 3.1.1 12:54:55 INFO - requests == 1.2.3 12:54:55 INFO - wsgiref == 0.1.2 12:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:55 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')]} 12:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:55 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')]} 12:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:55 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:55 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 12:54:55 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 12:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:55 INFO - 'HOME': '/Users/cltbld', 12:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:55 INFO - 'LOGNAME': 'cltbld', 12:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:55 INFO - 'MOZ_NO_REMOTE': '1', 12:54:55 INFO - 'NO_EM_RESTART': '1', 12:54:55 INFO - 'PAGER': '/bin/cat', 12:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:55 INFO - 'PWD': '/builds/slave/test', 12:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:55 INFO - 'SHELL': '/bin/bash', 12:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:55 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:55 INFO - 'USER': 'cltbld', 12:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:55 INFO - 'XPC_FLAGS': '0x0', 12:54:55 INFO - 'XPC_SERVICE_NAME': '0', 12:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 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)) 12:54:55 INFO - Cleaning up... 12:54:55 INFO - Return code: 0 12:54:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:55 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')]} 12:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:55 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')]} 12:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:55 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 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:55 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 12:54:55 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 12:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:55 INFO - 'HOME': '/Users/cltbld', 12:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:55 INFO - 'LOGNAME': 'cltbld', 12:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:55 INFO - 'MOZ_NO_REMOTE': '1', 12:54:55 INFO - 'NO_EM_RESTART': '1', 12:54:55 INFO - 'PAGER': '/bin/cat', 12:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:55 INFO - 'PWD': '/builds/slave/test', 12:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:55 INFO - 'SHELL': '/bin/bash', 12:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:55 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:55 INFO - 'USER': 'cltbld', 12:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:55 INFO - 'XPC_FLAGS': '0x0', 12:54:55 INFO - 'XPC_SERVICE_NAME': '0', 12:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:55 INFO - Downloading/unpacking jsonschema 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:57 INFO - Downloading/unpacking functools32 (from jsonschema) 12:54:57 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 12:54:57 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 12:54:57 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 12:54:57 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 12:54:57 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 12:54:57 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 12:54:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:58 INFO - warning: no files found matching '*.txt' 12:54:58 INFO - no previously-included directories found matching 'build' 12:54:58 INFO - no previously-included directories found matching 'dist' 12:54:58 INFO - no previously-included directories found matching '.git*' 12:54:58 INFO - Installing collected packages: jsonschema, functools32 12:54:58 INFO - Running setup.py install for functools32 12:54:58 INFO - warning: no files found matching '*.txt' 12:54:58 INFO - no previously-included directories found matching 'build' 12:54:58 INFO - no previously-included directories found matching 'dist' 12:54:58 INFO - no previously-included directories found matching '.git*' 12:54:58 INFO - Successfully installed jsonschema functools32 12:54:58 INFO - Cleaning up... 12:54:58 INFO - Return code: 0 12:54:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d81ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8224c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a04c16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, '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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 12:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:58 INFO - 'HOME': '/Users/cltbld', 12:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:58 INFO - 'LOGNAME': 'cltbld', 12:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:58 INFO - 'MOZ_NO_REMOTE': '1', 12:54:58 INFO - 'NO_EM_RESTART': '1', 12:54:58 INFO - 'PAGER': '/bin/cat', 12:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:58 INFO - 'PWD': '/builds/slave/test', 12:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:58 INFO - 'SHELL': '/bin/bash', 12:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:54:58 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:58 INFO - 'USER': 'cltbld', 12:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:58 INFO - 'XPC_FLAGS': '0x0', 12:54:58 INFO - 'XPC_SERVICE_NAME': '0', 12:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:58 INFO - Downloading/unpacking flake8 12:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:55:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:55:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:55:02 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 12:55:02 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 12:55:02 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 12:55:02 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 12:55:02 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 12:55:02 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 12:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:55:02 INFO - no previously-included directories found matching 'docs/_build' 12:55:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:55:02 INFO - Running setup.py install for pep8 12:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:55:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:55:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:55:02 INFO - no previously-included directories found matching 'docs/_build' 12:55:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:55:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:55:02 INFO - Cleaning up... 12:55:02 INFO - Return code: 0 12:55:02 INFO - Running post-action listener: _resource_record_post_action 12:55:02 INFO - Running post-action listener: _start_resource_monitoring 12:55:02 INFO - Starting resource monitoring. 12:55:02 INFO - ##### 12:55:02 INFO - ##### Running install step. 12:55:02 INFO - ##### 12:55:02 INFO - Running pre-action listener: _resource_record_pre_action 12:55:02 INFO - Running main action method: install 12:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:55:03 INFO - Reading from file tmpfile_stdout 12:55:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:55:03 INFO - Reading from file tmpfile_stdout 12:55:03 INFO - Output received: 12:55:03 INFO - Usage: mozinstall [options] installer 12:55:03 INFO - Options: 12:55:03 INFO - -h, --help show this help message and exit 12:55:03 INFO - -d DEST, --destination=DEST 12:55:03 INFO - Directory to install application into. [default: 12:55:03 INFO - "/builds/slave/test"] 12:55:03 INFO - --app=APP Application being installed. [default: firefox] 12:55:03 INFO - mkdir: /builds/slave/test/build/application 12:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:55:36 INFO - Reading from file tmpfile_stdout 12:55:36 INFO - Output received: 12:55:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:55:36 INFO - Running post-action listener: _resource_record_post_action 12:55:36 INFO - ##### 12:55:36 INFO - ##### Running run-tests step. 12:55:36 INFO - ##### 12:55:36 INFO - Running pre-action listener: _resource_record_pre_action 12:55:36 INFO - Running main action method: run_tests 12:55:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:55:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:55:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:55:36 INFO - 2016-02-11 12:55:36.820 screenresolution[1654:7422] starting screenresolution argv=screenresolution get 12:55:36 INFO - 2016-02-11 12:55:36.823 screenresolution[1654:7422] Display 0: 1600x1200x32@60 12:55:36 INFO - 2016-02-11 12:55:36.829 screenresolution[1655:7424] starting screenresolution argv=screenresolution list 12:55:36 INFO - Available Modes on Display 0 12:55:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:55:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:55:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:55:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:55:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:55:37 INFO - Intel Iris: 12:55:37 INFO - Chipset Model: Intel Iris 12:55:37 INFO - Type: GPU 12:55:37 INFO - Bus: Built-In 12:55:37 INFO - VRAM (Dynamic, Max): 1536 MB 12:55:37 INFO - Vendor: Intel (0x8086) 12:55:37 INFO - Device ID: 0x0a2e 12:55:37 INFO - Revision ID: 0x0009 12:55:37 INFO - Displays: 12:55:37 INFO - Display: 12:55:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:55:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:55:37 INFO - Display Serial Number: 1600x1200 60 12:55:37 INFO - Main Display: Yes 12:55:37 INFO - Mirror: Off 12:55:37 INFO - Online: Yes 12:55:37 INFO - Rotation: Supported 12:55:37 INFO - Return code: 0 12:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:37 INFO - Python 2.7.3 12:55:37 INFO - Return code: 0 12:55:37 INFO - grabbing minidump binary from tooltool 12:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:37 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 0x10d6bfd30>, '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 0x10d4e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6b6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:37 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 12:55:37 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 12:55:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:37 INFO - Return code: 0 12:55:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:55:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:55:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:55:38 INFO - Return code: 0 12:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.K5BtJ2bjjQ/Render', 12:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:55:38 INFO - 'HOME': '/Users/cltbld', 12:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:55:38 INFO - 'LOGNAME': 'cltbld', 12:55:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:38 INFO - 'MOZ_NO_REMOTE': '1', 12:55:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:38 INFO - 'NO_EM_RESTART': '1', 12:55:38 INFO - 'PAGER': '/bin/cat', 12:55:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:38 INFO - 'PWD': '/builds/slave/test', 12:55:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:55:38 INFO - 'SHELL': '/bin/bash', 12:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.izhkbQ7RJ8/Listeners', 12:55:38 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 12:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:55:38 INFO - 'USER': 'cltbld', 12:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:38 INFO - 'XPC_FLAGS': '0x0', 12:55:38 INFO - 'XPC_SERVICE_NAME': '0', 12:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:55:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:55:38 INFO - mozversion application_buildid: 20160211104134 12:55:38 INFO - mozversion application_changeset: 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 12:55:38 INFO - mozversion application_display_name: Nightly 12:55:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:38 INFO - mozversion application_name: Firefox 12:55:38 INFO - mozversion application_remotingname: firefox 12:55:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:55:38 INFO - mozversion application_vendor: Mozilla 12:55:38 INFO - mozversion application_version: 47.0a1 12:55:38 INFO - mozversion platform_buildid: 20160211104134 12:55:38 INFO - mozversion platform_changeset: 576a6dcde5b68c2ea45324ed5ce1dabb7d833d09 12:55:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:55:38 INFO - mozversion platform_version: 47.0a1 12:55:38 INFO - using testdate: 1455224138 12:55:38 INFO - actual date: 1455224138 12:55:39 INFO - starting webserver on 'localhost:49277' 12:55:39 INFO - SUITE-START | Running 2 tests 12:55:39 INFO - TEST-START | dromaeo_css 12:55:39 INFO - operating with platform_type : mac_ 12:55:39 INFO - Initialising browser for dromaeo_css test... 12:55:39 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmp1SIdBy/profile http://localhost:49277/getInfo.html) 12:55:41 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 12:55:41 INFO - PROCESS | 1673 | colorDepth:24 12:55:41 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 12:55:41 INFO - PROCESS | 1673 | __metrics 12:55:42 INFO - PROCESS | 1673 | 12:55:42 INFO - PROCESS | 1673 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 12:55:42 INFO - PROCESS | 1673 | 12:55:42 INFO - TEST-INFO | 1673: exit 0 12:55:42 INFO - Browser initialized. 12:55:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:42 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmp1SIdBy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:54 INFO - PROCESS | 1677 | RSS: Main: 258121728 12:55:54 INFO - PROCESS | 1677 | 12:56:44 INFO - PROCESS | 1677 | 1455224204453 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] 12:58:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 12:58:55 INFO - PROCESS | 1677 | RSS: Main: 272642048 12:58:55 INFO - PROCESS | 1677 | 13:01:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 13:01:58 INFO - PROCESS | 1677 | RSS: Main: 282460160 13:01:58 INFO - PROCESS | 1677 | 13:05:00 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 13:05:00 INFO - PROCESS | 1677 | RSS: Main: 284532736 13:05:00 INFO - PROCESS | 1677 | 13:08:02 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 13:08:02 INFO - PROCESS | 1677 | RSS: Main: 286224384 13:08:03 INFO - PROCESS | 1677 | 13:11:05 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 13:11:06 INFO - PROCESS | 1677 | RSS: Main: 287592448 13:11:06 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 13:14:08 INFO - PROCESS | 1677 | RSS: Main: 290574336 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | __start_tp_report 13:14:08 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 13:14:08 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 13:14:08 INFO - PROCESS | 1677 | |i|pagename|runs| 13:14:08 INFO - PROCESS | 1677 | |0;dojo.html;3349.7605885822236;3474.2704032153247;3486.337595856787;3524.541809564756;3556.164301389174;5650.9717451412735;5721.856953576153;5725.484706376431;5731.541476681866;5744.16709577111;5571.331440227178;5681.318241810978;5718.77124915004;5774.942250577493;5892.970535147329;5132.794688212476;5174.611904107188;5190;5192.480751924815;5239.580833533309;529.3760211141679;5053.5451809337155;5138.306328645641;5158.148905430599;5165.741712914358;4390.802413891351;4942.9258561121615;5165.457626949173;5181;5198;5160.6129540284255;5177.094008548489;5200.063988482072;5208.687478751287;5210.869728256786;5056.988602279522;5075.5178258065425;5124;5176.2235664650225;5179.792808287664;5569.721513924287;5624.690642014688;5647.3505546862225;5651.632643878134;5668.603197776158;6052.757889684407;6137.376985335611;6256.718447669866;6257.7184026718905;6270.937290627081;6279.748810047593;6289.937100628981;6297.086922396273;6302.55882088254;6345.42891139795;5808.82573522795;5837.474627283565;5850.707464626837;5862.824115276549;5893.675847828367;5391.757370918318;6154.046122850965;6336.556441049082;6350;6379.936200638027;6116.816495505142;6141.048137538689;6160.10678451622;6161.7227224775;6185.8144255671505;6084.209052823105;6296.874062518816;6301;6305.337939516285;6315.778947736807;6145.9692701536205;6254.8123556293385;6255.843603909848;6270.090836828635;6272.749090036347;6157.8460538486;6203.193584833943;6245.718942647592;6252.749890004349;6261.279952805395;4797.352357431771;4866.683665561727;4908.092002979461;4953.083679519301;4968.652194346361;4220.978895105566;4368.213721530155;4390.648748100144;4403.3174857897075;4437.800298986489;5681.971590142023;5709.914351284734;5741.5119714824705;5755.85610359736;5761.107028410603;6122.215193971364;6215.627062376272;6301.054841773771;6314.305426403092;6317.684115794192;5719.628224165416;5734.111212762028;5746.02317606008;5758.856028599234;5834.649921004753;5254.789808407697;5337.759800808973;5406.864828379322;5429.891402171935;5430.728463576806;5673.631213970996;6217.756448710276;6332.810015699536;6340.7463701451425;6385.48916086712;5655.604107712421;5788.652680839163;6285.874282514233;6308.179936608211;6327.873442531216;5199.818006369759;6299.811005669837;6300.275468321019;6370.90443643355;6386.137871387489;6205.5345849060595;6252.3122456530655;6259.123722678738;6284.340144284967;6310.936890631035;5486.698231597141;6116.0010150213275;6307.400796924285;6310;6313.96843015782;5034.86715489012;5866.6480011199465;6041.124037014696;6045.425684559959;6056.333803281724;5977.22296101504;5978.073398623221;5987.491063259672;6054.606450580698;6054.66699331541;5856.677882716492;5904.350521442552;5913.438223368773;5913.46778789911;5925.111233314865;5908.350081490947;5994.730237139252;6046.425589568984;6047.697615119315;6065.211522502046;5075.264086707481;5878.265216847894;5895.9115613266695;5918.615290006136;5926.2295901532525 13:14:08 INFO - PROCESS | 1677 | |1;ext.html;499.2860209899844;509.74003258338234;528.3685995235693;571.2117278156144;602.2201249382052;36890.44664330034;37042.88871333857;37103.628963710355;37251.25497490048;37532.62467375326;38227.235455290946;38275.80862095692;38551.42172867409;38568;38732;9380.296477764177;9559.761005974837;9567.952160239189;9580.52097395131;9605.855912161323;9410.52947352633;9594.896586892526;9627.374220675669;9715.174210192143;9729.513524323791;9702.369345992487;9760.609575616967;9802.166815820663;9804.31369804114;9828.950855245714;9632.711018669452;9705.854412183822;9723.854142187802;9737.659181928599;9757.12185903265;9520.381175223589;9621.567029483691;9626.807463850753;9651.276154288456;9668.129868311815;37147.442788358196;37395.87812365634;37448.43827342592;37649.435258471145;37660.43509347362;3230.4346739320526;3319.40250754864;3418.162550175223;3459.619441861393;3633.8001409922445;27968.300792480146;28432.28919277014;28612.570811437847;28782.280442989093;28854;2716.8641567921527;2774.4728501584636;2859.571064340345;2872.956905646417;2971.227480854972;477429;477465;477556;477608.6119569415;477867;63095.05357419643;63273;63445.682771585845;63508;63758.68120659367;65618;66378.33621663818;66527.66736166288;66742.99885501721;67072;15808.36766529349;16115.435959741353;16280.10459424743;16324;16350.50948471524;12483.50065997368;12526.436310366056;12531.43608537618;12536.749265014649;12579.993600511938;17037.7444338335;19250;19794;19807.801921980885;19883.60232795365;8002.439829212016;8057.395695322874;8167.387445941578;8189.7133600323705;8199.877001844978;859.7463748194298;899.7795540092719;1075.833245846895;1093.4259513755183;1130.3387518301722;28643.2839179018;29001.98493052733;29307.706922930924;29440;29620.40759184804;1053.2469284461647;1057.069778594847;1068.2148620763733;1076.9515371808288;1077.0737166037202;12632;13588.320583970763;13767.655808604864;13886.305684715724;14051.71896562063;496273;535241;539002;544502;544567;55299;55660;55670.72164639232;55811.72094139585;55936;1259.0053857452692;1402.8597140286095;1412.5762271318563;1434.1968497641353;1445.898787084894;21499.2475263365;27205.047823326087;27495.817343255614;27697.307567310978;27991.0203142889;47433.28850067183;47457.05085898194;47504.287435689184;47834;48048.759756201;397066;397099;398868;398947;399281;30235.546466802574;30319.848400757855;30652.386952261277;30653.693463065083;30660;43074.784626077926;43267.56732432761;43647.56352436562;43698.781506092266;44160.33759493546;36153;36418.45372319364;36541.45187822131;36724.3587834011;36959.44560831536;29276.56085158682;35862.64137358697;36500.45249321315;36902.8154859224;37021.25957480889;28495;31033;33833.323333533684;34404.655953440146;36540.451893222154;26913;30033.84983075158;31271.53092703657;32004.839975799972;32060.67939320577;23209.83950802487;24001.879990599937;24371.39071523226;24730;24942.62586061247 13:14:08 INFO - PROCESS | 1677 | |2;jquery.html;369.78737226094984;370.67936235156594;372.30564996281925;375.13157041449045;378.2831534242609;14566;17921;18467.261309547637;19771.901140494294;19814.60370792585;18293.7255941161;18758.06209689517;18866.905665471688;18918;18987.860728356307;5549.112142057262;5854.73653685583;5856.121581762727;5863.677497737623;5878.50032747217;4169.020280234143;4725.952740472586;6180.814575562717;6456.22525296965;6461.19235095613;4656.697314674552;5783.537317014629;6336.112944187817;6387.489000879942;6387.616742995412;5543.390227075019;5675.886482270352;5700.515456186229;5710.971445142789;5824.592278540504;5634.746436410331;5641.971790141064;5654.886902261932;5656.943430565683;5675.233843431125;14510.927445362811;23795.048198072058;23803;23808.285751427484;24041;2300.413394584387;2309.3880121767743;2449.971012174873;2482.2305085423395;2525.2929179829675;9577.712668619952;10311.690649280534;14334.068285561405;14337.49818756349;14595.343209555596;1790.3017823049022;1792.829681180286;1875.1936667233085;1891.5365735394917;1952.7754308254448;97096.51451742767;101719.49140254325;101949;102513.48743256311;102541.48729256455;9645.662401815904;10862.479252904599;10922.453877306103;11187.72030699239;11280.717982050515;11298.378589177673;13151.868481315256;13184.934075329562;13191.47234110644;13207.66980825487;7197.388222001188;7265.564066156047;7568.129665088475;7979.241972012649;8298.792530186673;7175.103112110986;8071.273585377344;8271.793205169919;8284.047334556482;8319.916800831914;4064.9390259146135;4254.31930891056;4405.383246345515;4453;4464.441944756905;1835.954101147482;1896.2983696032557;1902.077492416177;1916.2622390379804;1938.185961896007;844.2106630300689;867.6724611344653;880.9911900881037;987.807377561383;992.1814503035025;14334.426622934965;18526.888386696573;18720.157592908352;18767.249310027444;18919.243230270637;912.977175570616;922.9723108306762;932.1377725603925;954.9379290346105;998.4159266828841;9219.769505762275;10594.046535811814;10603;10660.573577056986;10678.145748340114;624802;630748;638652;639160;750673;111274.44362778134;116302;117806;120553;125141;1110.8555887734542;1143.9027682647068;1171.6133675886938;1172.7009612548745;1197.8921897029136;17719.379821706178;18036.188371523574;18063;18173.45479635613;18271.903685778896;49023;49132.75433622809;49184.50815491942;50583.74708126436;51606;70212.648936755;72524.63737681278;72662.63668681834;73157;74763.62618186875;7423.740169094056;7678.577678227751;7704.30661240491;7706;7763.72826951054;9865.210783137476;10824.4046577439;11368.488418021374;11845.052395808487;11976.760464790481;9169.633214671338;10194.388336699525;10517.631882884063;10633.043026127376;10691.732706682395;10044.648437304659;10391.1167550756;10574.577016919236;10624.36253824773;10854.40300783433;10231.795364092528;10597.89402106;10729.302595331279;10824.458777061272;10894.400807955639;6348.460380867678;7607.35337496319;7703.959965404599;7704.576248306397;7730.574818385043;9364.765880853032;10579.735506612396;10584.84122738175;10777.568897244022;10875.891241087487 13:14:08 INFO - PROCESS | 1677 | |3;mootools.html;1528.8776897848172;1533.8696210822084;1752.702040653089;1770.7166853303474;1867.4304337177164;7790.337821285198;8375.623096960637;8577.142285771428;8732.8690069649;8742.650293988248;8510.872336914952;8548.786280342994;8642.222200002;8653.350998675109;8729.214370706635;2100.453881990678;2472.0606169655507;2478.946447759695;2491.4643351679383;2493.4265119022634;2463.7289898111285;2478.3432390416556;2510.598304271317;2515.383730985911;2519.86140762258;2160.3626930055593;2428.3322086426197;2469.555480013597;2490;2492.239866840613;2434.6226334918115;2447.608382658775;2476.7863746764137;2476.863772492521;2484.3416494628937;2215.3021798133695;2446.9355830213913;2453.9877300613384;2472.6909136357954;2494.3639371960217;8452.957735211347;8479.66081356745;8482.236598706146;8526.957365213197;8545.230929216339;5218.243354713583;5395.78416863325;5410.756515956791;5438.293021907127;5442.455754424565;3666.633336666339;3667.0832291927018;3718.367877460811;3756.417755247941;3796.791176485292;1064.9520771565299;1072.1727411518345;1072.5388083124253;1088.983665245022;1098.7912296663608;11374.545018199262;11481;11505.712357191054;11532.192746507748;11549.13381496391;4870.829520966749;4889.902201955941;4993.400791904922;4994.250862370601;5006.324146240211;9959.850602240973;10004.749881253027;10039;10056.59773609062;10060.24548158891;5422.267993820784;5457.781688732485;5460.126379779216;5483.341998960071;5484.095124304525;4914.754262286871;4917.237828136645;4953.876153096201;4974.577160941288;4994.675346102492;3850.0759817643566;3871.535415750128;3876.476675648751;3882.9223415531533;3903.8048097595006;1204.9819252711216;1252.7431876465303;1289.426205338634;1319.9142055766345;1339.638297659646;1122.6688127002553;1123.4831977290376;1142.1548054439654;1260.2753416785201;1315.579014715282;6377.904331434939;6873;7784.649690763816;7805.2194780521495;7898;570.1618620627671;604.8990836677293;648.24803228255;650.7462089784988;792.0772300270236;5833.504152147115;6003.939960600338;6050.42520960508;6065;6066.423689749467;8796.516191609395;10083.848742268872;10323.587056517656;10350.430726309974;10633.734156646145;9044.457332560067;10318.896811031944;10461.529231184462;10522.894771052344;10602.416867072385;8127.268545830903;8224.917750822535;8233.17668233184;8256.215659512216;8308.376871734645;7641.083070031409;7670.961645191738;7709.4603377763015;7735.342495887912;7749.65126569317;9223.815523689354;9458.527073646152;9486.95256523713;9551.713448596553;9590.760230994281;8329.12544182852;9637.9036209637;9843.064908833649;9868.457234851865;9936.105750482202;7382;7399.630018499161;7474.588897610466;7475.588842613491;7521.172671006294;8071.192880711882;8126.431149819456;8141.104478507478;8154.14381489935;8170.550619715973;7566.167721550515;7701.499402538817;7766.817121085191;7804.648790804314;7824.256695613907;7477.925220747723;7539.924600753922;7576.4317676173405;7669.808254793675;7673.8848917267405;7622.009138811919;7680.193579674054;7732.072151341875;7739.651715672696;7740.767776966475;6977;6984.476164287597;6998.300169982961;7057.964710176621;7088.0785497884945;7071.929280707127;7136.250693677089;7164.570125792469;7169;7174.390176835028 13:14:08 INFO - PROCESS | 1677 | |4;prototype.html;313.22008199583036;332.7321506187518;336.6364326527351;337.5712844687246;344.0555674673021;6743.932560674391;6770.119884415031;6834.31656834317;6880.690368933398;6889.517733758633;5700.97382471155;5935.605132793801;6610;6883.552569083006;6933.445324374051;4614.238650622643;4718.079974404993;5083.18669012958;5085.745712714368;5110.8466745997675;4882.97558512207;5071.061853557086;5092.159793634046;5095.0319439306595;5112.488751124895;4939.28380384844;5005.9499405005845;5009.674371165863;5021.6986980781085;5025.422076461217;5003.799848006075;5005.399352077774;5006.924896126561;5013.924791128136;5025.899482010358;4057.9594204057876;4197.790110494494;4285.807138678767;4288.935665965013;4304.698671093025;6547.574407663486;6608.636524991123;6617.7022034008105;6632.568883022636;6640.701168447432;4980.775865086043;5943.257092863392;5980.700964951779;5983.282006159288;5995.1906492623375;7113.110861142357;7320.743773967939;7325.816854578625;7332.926670733278;7338.96330518344;4362.781860906974;4804.20730579454;4834.903301933941;4853.951460485385;4854.805807767685;7724.884126738103;7733.7679869604;7738.4969976951315;7746.5352078874885;7755.185705500954;4061.7156799024374;4764.595009424169;4910.975445122752;4940.6788558743565;4941.234108713155;4041.6160464755803;4541.568550987651;5020.297158397827;5027.396712394536;5038.521340472723;5937.940620593825;5941.613795103304;5951.940480595225;5961.433663801932;5963.970180149072;7387.630618469055;7397.297256760599;7407.2222416646555;7409.036825212688;7427.18300986891;1417.971640567183;1755.1399814091003;1755.7190849464025;1756.920938557768;1761.207456644515;1013.2603199664286;1117.9105671546256;1128.8137457319615;1136.108155098244;1140;6503;6612.504062195355;6877.277885822016;6884.380405763405;6885.483588730865;7641.121271053788;7672.884906726404;7673.846523069507;7687.846243075219;7696.191899850547;6693.631850248185;6850.554713943578;6855.520113592001;6861.348171923659;6897.5512243878065;3900.9804950975063;3940.271049855786;4025.275450418953;4062.5734297898293;4072.124493233969;7839.725609603636;7902.920970790218;7907.5650839203245;7909.090454597795;7953.2842044216295;7890.210978902064;7928.801779955547;7930.524168549906;7935.444518883738;7968.561729104955;7719;7969.242921922524;7995.560244186509;7999.680012799423;8013.4791238569305;7671.156172821097;7683.270089341504;7689.269519395649;7689.8462030757955;7696.8460630788195;7228.49400541957;7510.624468776648;7521.435892307989;7528.811779705551;7552.773416797505;8015.358771298399;8033.317168040782;8042.03495580534;8044.994375703037;8059.677612895419;4943.9505604944925;4966.155753521838;4983.476734942778;5001.474845141208;5004.499550045112;7396.3343299103335;7602.885956710765;7614.771556853303;7734.187910269566;7746.380289576933;7399.852002959803;7405.370543503863;7419.740309089156;7429.182789893;7444.292792184734;7167.964160179165;7422.517536360119;7423.331900129015;7423.591702456417;7435.739749108971;7240.420766338575;7242.89135662955;7247.13034435871;7247.9637601811655;7254.89117663246;7395.334419902235;7401.48189626721;7414.110306763223;7433;7441.144268409203;6977.1278590176225;7157.498975071695;7224.783256502314;7249.166345870292;7267.345938865527 13:14:08 INFO - PROCESS | 1677 | |5;yui.html;623.146289583271;673.7944926797328;686.3171144711014;715.7781087862763;734.3354264390729;14735.557933262005;14875.181864997421;15005.174715390649;15009.774853377208;15026.624334391645;13716.65708357289;13750.449982000733;13755.105918115316;13761.31193440329;13771.24258165803;684.6953105867866;835.908050114487;836.0761358698642;836.10119121944;857.4469467193657;788.7436583110483;829.1832544943226;848.0586548930683;848.8132610825609;852.2329903087209;881.0792721605906;883.7923088074298;895.6059333893098;900.1358695652182;903.6475774447971;880.216607219575;887.3256325192835;893.2987604730288;897.627484593896;901.1349104859343;581.1573218832667;649.0588646462649;669.718718138383;670.0518765946229;671.1241829412614;14377.281135943265;14386;14404.423823047066;14426.495072672406;14446.494372696905;12820.935895320463;12829.486820527167;12928.224306541637;13040.347982600832;13111.86888131116;9858.211343092607;9950;10032.423615531485;10081.546330415149;10091.89908100917;3498.300339931998;3567.94648080279;3588.0671025533547;3599.94600080999;3605.369060414417;66694;67267.66366168138;67647;68111.97832032523;68569.65715171442;9232.63356030013;9329;9343;9571.473568953774;9876.209903207726;19909.701354479694;19936.70094948577;20013.39959801208;20052.598948020957;20056;7233.421326293884;7347.63261836906;7361.742339018108;7464.1416237132335;7486.887696684554;4050.4936882889638;4065.4308396824467;4103.733257338264;4117.135401565645;4144.730592511477;3468.236987862666;3498.632643572439;3517.0503963929596;3534.699550538233;3553.1117220694828;632.0961025733154;638.2086213095728;645.6674812471581;661.2692974263466;664.7972368427676;555.686037388874;570.7231992483643;597.7429705226795;598.0550729846832;616.3035769580346;8717.476951382938;8856.601452934634;9006.279497640173;9050.909490905007;9095.045020272908;502.7561632608182;509.47269575988673;530.1279395394554;547.2393373211239;624.6470744029609;3763.9435408468894;3801.878445858423;3839.731218814656;4014.5383280922483;4101.302778527657;62157;74620;84809;86272;86307;61989;73273;77554.61222693851;80156;80945;59811;68735.65632171708;68747.65626171937;69067.61864762676;69529.65235173792;7500.812479688051;8729.825403492021;8763.25512331459;8870.73387798367;8973.192412682889;46564.06871862476;46796.532034679214;46807.53192468032;47801;47816.7609161952;62323.376766233574;63090.36909630845;64367;64509;64761.35238647553;10792.946035269773;10927.125829933746;11010.614628487965;11146.164037697366;11614.419279036183;11919.880801191877;12017.699557511132;12382.318972456242;12882.549110781078;13059;11128.44306453297;11401.486933087865;11798.233114847508;11807.409629518661;12332.136750427384;11017.228793984345;11466.77066458683;11507.712307192387;11653.626391128779;11858.940705296418;10931.289466184673;11181.72045698864;11296.6046188383;11536;11541;9005.684801032194;9239.76900577491;9295.86056209171;9436.197923176333;9834.360766550151;9218.907810921804;9285.442873427615;9316.95341523315;9478.715638530855;10108.696739097839 13:14:08 INFO - PROCESS | 1677 | __end_tp_report 13:14:08 INFO - PROCESS | 1677 | __start_cc_report 13:14:08 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,369 13:14:08 INFO - PROCESS | 1677 | __end_cc_report 13:14:08 INFO - PROCESS | 1677 | __startTimestamp1455225248846__endTimestamp 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | ------- Summary: start ------- 13:14:08 INFO - PROCESS | 1677 | Number of tests: 6 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5672.18 Median:5866.65 stddev:760.35 (13.0%) stddev-sans-first:740.54 13:14:08 INFO - PROCESS | 1677 | Values: 3349.8 3474.3 3486.3 3524.5 3556.2 5651.0 5721.9 5725.5 5731.5 5744.2 5571.3 5681.3 5718.8 5774.9 5893.0 5132.8 5174.6 5190.0 5192.5 5239.6 529.4 5053.5 5138.3 5158.1 5165.7 4390.8 4942.9 5165.5 5181.0 5198.0 5160.6 5177.1 5200.1 5208.7 5210.9 5057.0 5075.5 5124.0 5176.2 5179.8 5569.7 5624.7 5647.4 5651.6 5668.6 6052.8 6137.4 6256.7 6257.7 6270.9 6279.7 6289.9 6297.1 6302.6 6345.4 5808.8 5837.5 5850.7 5862.8 5893.7 5391.8 6154.0 6336.6 6350.0 6379.9 6116.8 6141.0 6160.1 6161.7 6185.8 6084.2 6296.9 6301.0 6305.3 6315.8 6146.0 6254.8 6255.8 6270.1 6272.7 6157.8 6203.2 6245.7 6252.7 6261.3 4797.4 4866.7 4908.1 4953.1 4968.7 4221.0 4368.2 4390.6 4403.3 4437.8 5682.0 5709.9 5741.5 5755.9 5761.1 6122.2 6215.6 6301.1 6314.3 6317.7 5719.6 5734.1 5746.0 5758.9 5834.6 5254.8 5337.8 5406.9 5429.9 5430.7 5673.6 6217.8 6332.8 6340.7 6385.5 5655.6 5788.7 6285.9 6308.2 6327.9 5199.8 6299.8 6300.3 6370.9 6386.1 6205.5 6252.3 6259.1 6284.3 6310.9 5486.7 6116.0 6307.4 6310.0 6314.0 5034.9 5866.6 6041.1 6045.4 6056.3 5977.2 5978.1 5987.5 6054.6 6054.7 5856.7 5904.4 5913.4 5913.5 5925.1 5908.4 5994.7 6046.4 6047.7 6065.2 5075.3 5878.3 5895.9 5918.6 5926.2 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:61099.63 Median:37125.54 stddev:125688.24 (338.5%) stddev-sans-first:125958.47 13:14:08 INFO - PROCESS | 1677 | Values: 499.3 509.7 528.4 571.2 602.2 36890.4 37042.9 37103.6 37251.3 37532.6 38227.2 38275.8 38551.4 38568.0 38732.0 9380.3 9559.8 9568.0 9580.5 9605.9 9410.5 9594.9 9627.4 9715.2 9729.5 9702.4 9760.6 9802.2 9804.3 9829.0 9632.7 9705.9 9723.9 9737.7 9757.1 9520.4 9621.6 9626.8 9651.3 9668.1 37147.4 37395.9 37448.4 37649.4 37660.4 3230.4 3319.4 3418.2 3459.6 3633.8 27968.3 28432.3 28612.6 28782.3 28854.0 2716.9 2774.5 2859.6 2873.0 2971.2 477429.0 477465.0 477556.0 477608.6 477867.0 63095.1 63273.0 63445.7 63508.0 63758.7 65618.0 66378.3 66527.7 66743.0 67072.0 15808.4 16115.4 16280.1 16324.0 16350.5 12483.5 12526.4 12531.4 12536.7 12580.0 17037.7 19250.0 19794.0 19807.8 19883.6 8002.4 8057.4 8167.4 8189.7 8199.9 859.7 899.8 1075.8 1093.4 1130.3 28643.3 29002.0 29307.7 29440.0 29620.4 1053.2 1057.1 1068.2 1077.0 1077.1 12632.0 13588.3 13767.7 13886.3 14051.7 496273.0 535241.0 539002.0 544502.0 544567.0 55299.0 55660.0 55670.7 55811.7 55936.0 1259.0 1402.9 1412.6 1434.2 1445.9 21499.2 27205.0 27495.8 27697.3 27991.0 47433.3 47457.1 47504.3 47834.0 48048.8 397066.0 397099.0 398868.0 398947.0 399281.0 30235.5 30319.8 30652.4 30653.7 30660.0 43074.8 43267.6 43647.6 43698.8 44160.3 36153.0 36418.5 36541.5 36724.4 36959.4 29276.6 35862.6 36500.5 36902.8 37021.3 28495.0 31033.0 33833.3 34404.7 36540.5 26913.0 30033.8 31271.5 32004.8 32060.7 23209.8 24001.9 24371.4 24730.0 24942.6 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:35178.03 Median:2466.10 stddev:108888.35 (4415.4%) stddev-sans-first:109162.44 13:14:08 INFO - PROCESS | 1677 | Values: 369.8 370.7 372.3 375.1 378.3 14566.0 17921.0 18467.3 19771.9 19814.6 18293.7 18758.1 18866.9 18918.0 18987.9 5549.1 5854.7 5856.1 5863.7 5878.5 4169.0 4726.0 6180.8 6456.2 6461.2 4656.7 5783.5 6336.1 6387.5 6387.6 5543.4 5675.9 5700.5 5711.0 5824.6 5634.7 5642.0 5654.9 5656.9 5675.2 14510.9 23795.0 23803.0 23808.3 24041.0 2300.4 2309.4 2450.0 2482.2 2525.3 9577.7 10311.7 14334.1 14337.5 14595.3 1790.3 1792.8 1875.2 1891.5 1952.8 97096.5 101719.5 101949.0 102513.5 102541.5 9645.7 10862.5 10922.5 11187.7 11280.7 11298.4 13151.9 13184.9 13191.5 13207.7 7197.4 7265.6 7568.1 7979.2 8298.8 7175.1 8071.3 8271.8 8284.0 8319.9 4064.9 4254.3 4405.4 4453.0 4464.4 1836.0 1896.3 1902.1 1916.3 1938.2 844.2 867.7 881.0 987.8 992.2 14334.4 18526.9 18720.2 18767.2 18919.2 913.0 923.0 932.1 954.9 998.4 9219.8 10594.0 10603.0 10660.6 10678.1 624802.0 630748.0 638652.0 639160.0 750673.0 111274.4 116302.0 117806.0 120553.0 125141.0 1110.9 1143.9 1171.6 1172.7 1197.9 17719.4 18036.2 18063.0 18173.5 18271.9 49023.0 49132.8 49184.5 50583.7 51606.0 70212.6 72524.6 72662.6 73157.0 74763.6 7423.7 7678.6 7704.3 7706.0 7763.7 9865.2 10824.4 11368.5 11845.1 11976.8 9169.6 10194.4 10517.6 10633.0 10691.7 10044.6 10391.1 10574.6 10624.4 10854.4 10231.8 10597.9 10729.3 10824.5 10894.4 6348.5 7607.4 7704.0 7704.6 7730.6 9364.8 10579.7 10584.8 10777.6 10875.9 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5965.87 Median:5483.72 stddev:3105.31 (56.6%) stddev-sans-first:3096.11 13:14:08 INFO - PROCESS | 1677 | Values: 1528.9 1533.9 1752.7 1770.7 1867.4 7790.3 8375.6 8577.1 8732.9 8742.7 8510.9 8548.8 8642.2 8653.4 8729.2 2100.5 2472.1 2478.9 2491.5 2493.4 2463.7 2478.3 2510.6 2515.4 2519.9 2160.4 2428.3 2469.6 2490.0 2492.2 2434.6 2447.6 2476.8 2476.9 2484.3 2215.3 2446.9 2454.0 2472.7 2494.4 8453.0 8479.7 8482.2 8527.0 8545.2 5218.2 5395.8 5410.8 5438.3 5442.5 3666.6 3667.1 3718.4 3756.4 3796.8 1065.0 1072.2 1072.5 1089.0 1098.8 11374.5 11481.0 11505.7 11532.2 11549.1 4870.8 4889.9 4993.4 4994.3 5006.3 9959.9 10004.7 10039.0 10056.6 10060.2 5422.3 5457.8 5460.1 5483.3 5484.1 4914.8 4917.2 4953.9 4974.6 4994.7 3850.1 3871.5 3876.5 3882.9 3903.8 1205.0 1252.7 1289.4 1319.9 1339.6 1122.7 1123.5 1142.2 1260.3 1315.6 6377.9 6873.0 7784.6 7805.2 7898.0 570.2 604.9 648.2 650.7 792.1 5833.5 6003.9 6050.4 6065.0 6066.4 8796.5 10083.8 10323.6 10350.4 10633.7 9044.5 10318.9 10461.5 10522.9 10602.4 8127.3 8224.9 8233.2 8256.2 8308.4 7641.1 7671.0 7709.5 7735.3 7749.7 9223.8 9458.5 9487.0 9551.7 9590.8 8329.1 9637.9 9843.1 9868.5 9936.1 7382.0 7399.6 7474.6 7475.6 7521.2 8071.2 8126.4 8141.1 8154.1 8170.6 7566.2 7701.5 7766.8 7804.6 7824.3 7477.9 7539.9 7576.4 7669.8 7673.9 7622.0 7680.2 7732.1 7739.7 7740.8 6977.0 6984.5 6998.3 7058.0 7088.1 7071.9 7136.3 7164.6 7169.0 7174.4 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:6027.88 Median:6858.43 stddev:1951.14 (28.4%) stddev-sans-first:1908.88 13:14:08 INFO - PROCESS | 1677 | Values: 313.2 332.7 336.6 337.6 344.1 6743.9 6770.1 6834.3 6880.7 6889.5 5701.0 5935.6 6610.0 6883.6 6933.4 4614.2 4718.1 5083.2 5085.7 5110.8 4883.0 5071.1 5092.2 5095.0 5112.5 4939.3 5005.9 5009.7 5021.7 5025.4 5003.8 5005.4 5006.9 5013.9 5025.9 4058.0 4197.8 4285.8 4288.9 4304.7 6547.6 6608.6 6617.7 6632.6 6640.7 4980.8 5943.3 5980.7 5983.3 5995.2 7113.1 7320.7 7325.8 7332.9 7339.0 4362.8 4804.2 4834.9 4854.0 4854.8 7724.9 7733.8 7738.5 7746.5 7755.2 4061.7 4764.6 4911.0 4940.7 4941.2 4041.6 4541.6 5020.3 5027.4 5038.5 5937.9 5941.6 5951.9 5961.4 5964.0 7387.6 7397.3 7407.2 7409.0 7427.2 1418.0 1755.1 1755.7 1756.9 1761.2 1013.3 1117.9 1128.8 1136.1 1140.0 6503.0 6612.5 6877.3 6884.4 6885.5 7641.1 7672.9 7673.8 7687.8 7696.2 6693.6 6850.6 6855.5 6861.3 6897.6 3901.0 3940.3 4025.3 4062.6 4072.1 7839.7 7902.9 7907.6 7909.1 7953.3 7890.2 7928.8 7930.5 7935.4 7968.6 7719.0 7969.2 7995.6 7999.7 8013.5 7671.2 7683.3 7689.3 7689.8 7696.8 7228.5 7510.6 7521.4 7528.8 7552.8 8015.4 8033.3 8042.0 8045.0 8059.7 4944.0 4966.2 4983.5 5001.5 5004.5 7396.3 7602.9 7614.8 7734.2 7746.4 7399.9 7405.4 7419.7 7429.2 7444.3 7168.0 7422.5 7423.3 7423.6 7435.7 7240.4 7242.9 7247.1 7248.0 7254.9 7395.3 7401.5 7414.1 7433.0 7441.1 6977.1 7157.5 7224.8 7249.2 7267.3 13:14:08 INFO - PROCESS | 1677 | 13:14:08 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:17175.83 Median:62073.00 stddev:23173.56 (37.3%) stddev-sans-first:23205.24 13:14:08 INFO - PROCESS | 1677 | Values: 623.1 673.8 686.3 715.8 734.3 14735.6 14875.2 15005.2 15009.8 15026.6 13716.7 13750.4 13755.1 13761.3 13771.2 684.7 835.9 836.1 836.1 857.4 788.7 829.2 848.1 848.8 852.2 881.1 883.8 895.6 900.1 903.6 880.2 887.3 893.3 897.6 901.1 581.2 649.1 669.7 670.1 671.1 14377.3 14386.0 14404.4 14426.5 14446.5 12820.9 12829.5 12928.2 13040.3 13111.9 9858.2 9950.0 10032.4 10081.5 10091.9 3498.3 3567.9 3588.1 3599.9 3605.4 66694.0 67267.7 67647.0 68112.0 68569.7 9232.6 9329.0 9343.0 9571.5 9876.2 19909.7 19936.7 20013.4 20052.6 20056.0 7233.4 7347.6 7361.7 7464.1 7486.9 4050.5 4065.4 4103.7 4117.1 4144.7 3468.2 3498.6 3517.1 3534.7 3553.1 632.1 638.2 645.7 661.3 664.8 555.7 570.7 597.7 598.1 616.3 8717.5 8856.6 9006.3 9050.9 9095.0 502.8 509.5 530.1 547.2 624.6 3763.9 3801.9 3839.7 4014.5 4101.3 62157.0 74620.0 84809.0 86272.0 86307.0 61989.0 73273.0 77554.6 80156.0 80945.0 59811.0 68735.7 68747.7 69067.6 69529.7 7500.8 8729.8 8763.3 8870.7 8973.2 46564.1 46796.5 46807.5 47801.0 47816.8 62323.4 63090.4 64367.0 64509.0 64761.4 10792.9 10927.1 11010.6 11146.2 11614.4 11919.9 12017.7 12382.3 12882.5 13059.0 11128.4 11401.5 11798.2 11807.4 12332.1 11017.2 11466.8 11507.7 11653.6 11858.9 10931.3 11181.7 11296.6 11536.0 11541.0 9005.7 9239.8 9295.9 9436.2 9834.4 9218.9 9285.4 9317.0 9478.7 10108.7 13:14:08 INFO - PROCESS | 1677 | -------- Summary: end -------- 13:14:08 INFO - PROCESS | 1677 | 13:14:09 INFO - TEST-INFO | 1677: exit 0 13:14:09 INFO - TEST-OK | dromaeo_css | took 1110406ms 13:14:09 INFO - TEST-START | kraken 13:14:09 INFO - operating with platform_type : mac_ 13:14:09 INFO - Initialising browser for kraken test... 13:14:09 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmph6T_65/profile http://localhost:49277/getInfo.html) 13:14:12 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 13:14:12 INFO - PROCESS | 1689 | colorDepth:24 13:14:12 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 13:14:12 INFO - PROCESS | 1689 | __metrics 13:14:12 INFO - PROCESS | 1689 | 13:14:12 INFO - PROCESS | 1689 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 13:14:12 INFO - PROCESS | 1689 | 13:14:12 INFO - TEST-INFO | 1689: exit 0 13:14:12 INFO - Browser initialized. 13:14:12 INFO - Running cycle 1/1 for kraken test... 13:14:12 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmph6T_65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:24 INFO - PROCESS | 1692 | RSS: Main: 256954368 13:14:24 INFO - PROCESS | 1692 | 13:14:27 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:28 INFO - PROCESS | 1692 | RSS: Main: 270114816 13:14:28 INFO - PROCESS | 1692 | 13:14:30 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 13:14:31 INFO - PROCESS | 1692 | RSS: Main: 278773760 13:14:31 INFO - PROCESS | 1692 | 13:14:34 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 13:14:35 INFO - PROCESS | 1692 | RSS: Main: 282599424 13:14:35 INFO - PROCESS | 1692 | 13:14:37 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 13:14:37 INFO - PROCESS | 1692 | RSS: Main: 283955200 13:14:37 INFO - PROCESS | 1692 | 13:14:39 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:40 INFO - PROCESS | 1692 | RSS: Main: 285769728 13:14:40 INFO - PROCESS | 1692 | 13:14:43 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:43 INFO - PROCESS | 1692 | RSS: Main: 285552640 13:14:43 INFO - PROCESS | 1692 | 13:14:46 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:47 INFO - PROCESS | 1692 | RSS: Main: 285347840 13:14:47 INFO - PROCESS | 1692 | 13:14:50 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 13:14:50 INFO - PROCESS | 1692 | RSS: Main: 285446144 13:14:50 INFO - PROCESS | 1692 | 13:14:52 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:52 INFO - PROCESS | 1692 | RSS: Main: 284327936 13:14:52 INFO - PROCESS | 1692 | 13:14:54 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:55 INFO - PROCESS | 1692 | RSS: Main: 284434432 13:14:55 INFO - PROCESS | 1692 | 13:14:57 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:57 INFO - PROCESS | 1692 | RSS: Main: 284020736 13:14:57 INFO - PROCESS | 1692 | 13:15:00 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:01 INFO - PROCESS | 1692 | RSS: Main: 284725248 13:15:01 INFO - PROCESS | 1692 | 13:15:03 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:04 INFO - PROCESS | 1692 | RSS: Main: 284790784 13:15:04 INFO - PROCESS | 1692 | 13:15:05 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 13:15:06 INFO - PROCESS | 1692 | RSS: Main: 286752768 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | __start_tp_report 13:15:06 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 13:15:06 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 13:15:06 INFO - PROCESS | 1692 | |i|pagename|runs| 13:15:06 INFO - PROCESS | 1692 | |0;ai-astar;112;106;124;158;126;125;113;118;117;115 13:15:06 INFO - PROCESS | 1692 | |1;audio-beat-detection;139;124;147;151;133;163;142;122;150;123 13:15:06 INFO - PROCESS | 1692 | |2;audio-dft;193;200;199;203;203;228;263;183;263;194 13:15:06 INFO - PROCESS | 1692 | |3;audio-fft;64;78;70;108;57;56;57;58;107;57 13:15:06 INFO - PROCESS | 1692 | |4;audio-oscillator;84;84;115;95;103;86;114;80;84;137 13:15:06 INFO - PROCESS | 1692 | |5;imaging-gaussian-blur;86;92;88;91;87;106;116;109;86;90 13:15:06 INFO - PROCESS | 1692 | |6;imaging-darkroom;95;94;95;96;95;95;93;95;95;95 13:15:06 INFO - PROCESS | 1692 | |7;imaging-desaturate;91;93;90;89;89;138;134;125;89;108 13:15:06 INFO - PROCESS | 1692 | |8;json-parse-financial;54;57;56;57;55;56;55;64;54;53 13:15:06 INFO - PROCESS | 1692 | |9;json-stringify-tinderbox;63;64;92;108;69;62;63;77;76;65 13:15:06 INFO - PROCESS | 1692 | |10;stanford-crypto-aes;86;85;86;83;85;84;87;84;86;85 13:15:06 INFO - PROCESS | 1692 | |11;stanford-crypto-ccm;125;127;116;131;144;157;134;133;133;147 13:15:06 INFO - PROCESS | 1692 | |12;stanford-crypto-pbkdf2;137;139;142;142;145;145;144;139;137;150 13:15:06 INFO - PROCESS | 1692 | |13;stanford-crypto-sha256-iterative;68;67;69;65;69;68;66;69;70;67 13:15:06 INFO - PROCESS | 1692 | __end_tp_report 13:15:06 INFO - PROCESS | 1692 | __start_cc_report 13:15:06 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,902 13:15:06 INFO - PROCESS | 1692 | __end_cc_report 13:15:06 INFO - PROCESS | 1692 | __startTimestamp1455225306196__endTimestamp 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | ------- Summary: start ------- 13:15:06 INFO - PROCESS | 1692 | Number of tests: 14 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#0] ai-astar Cycles:10 Average:121.40 Median:121.00 stddev:14.33 (11.8%) stddev-sans-first:14.79 13:15:06 INFO - PROCESS | 1692 | Values: 112.0 106.0 124.0 158.0 126.0 125.0 113.0 118.0 117.0 115.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:144.50 stddev:13.82 (9.6%) stddev-sans-first:14.66 13:15:06 INFO - PROCESS | 1692 | Values: 139.0 124.0 147.0 151.0 133.0 163.0 142.0 122.0 150.0 123.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#2] audio-dft Cycles:10 Average:212.90 Median:203.00 stddev:28.77 (14.2%) stddev-sans-first:29.60 13:15:06 INFO - PROCESS | 1692 | Values: 193.0 200.0 199.0 203.0 203.0 228.0 263.0 183.0 263.0 194.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#3] audio-fft Cycles:10 Average:71.20 Median:57.50 stddev:20.40 (35.5%) stddev-sans-first:21.47 13:15:06 INFO - PROCESS | 1692 | Values: 64.0 78.0 70.0 108.0 57.0 56.0 57.0 58.0 107.0 57.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:84.00 stddev:18.72 (22.3%) stddev-sans-first:19.14 13:15:06 INFO - PROCESS | 1692 | Values: 84.0 84.0 115.0 95.0 103.0 86.0 114.0 80.0 84.0 137.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:87.50 stddev:10.97 (12.5%) stddev-sans-first:11.13 13:15:06 INFO - PROCESS | 1692 | Values: 86.0 92.0 88.0 91.0 87.0 106.0 116.0 109.0 86.0 90.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 13:15:06 INFO - PROCESS | 1692 | Values: 95.0 94.0 95.0 96.0 95.0 95.0 93.0 95.0 95.0 95.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#7] imaging-desaturate Cycles:10 Average:104.60 Median:89.00 stddev:20.19 (22.7%) stddev-sans-first:20.81 13:15:06 INFO - PROCESS | 1692 | Values: 91.0 93.0 90.0 89.0 89.0 138.0 134.0 125.0 89.0 108.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:3.07 (5.5%) stddev-sans-first:3.16 13:15:06 INFO - PROCESS | 1692 | Values: 54.0 57.0 56.0 57.0 55.0 56.0 55.0 64.0 54.0 53.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:67.00 stddev:15.22 (22.7%) stddev-sans-first:15.62 13:15:06 INFO - PROCESS | 1692 | Values: 63.0 64.0 92.0 108.0 69.0 62.0 63.0 77.0 76.0 65.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:1.20 (1.4%) stddev-sans-first:1.22 13:15:06 INFO - PROCESS | 1692 | Values: 86.0 85.0 86.0 83.0 85.0 84.0 87.0 84.0 86.0 85.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:133.50 stddev:11.82 (8.9%) stddev-sans-first:12.01 13:15:06 INFO - PROCESS | 1692 | Values: 125.0 127.0 116.0 131.0 144.0 157.0 134.0 133.0 133.0 147.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:143.00 stddev:4.14 (2.9%) stddev-sans-first:3.97 13:15:06 INFO - PROCESS | 1692 | Values: 137.0 139.0 142.0 142.0 145.0 145.0 144.0 139.0 137.0 150.0 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - PROCESS | 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.55 (2.3%) stddev-sans-first:1.64 13:15:06 INFO - PROCESS | 1692 | Values: 68.0 67.0 69.0 65.0 69.0 68.0 66.0 69.0 70.0 67.0 13:15:06 INFO - PROCESS | 1692 | -------- Summary: end -------- 13:15:06 INFO - PROCESS | 1692 | 13:15:06 INFO - TEST-INFO | 1692: exit 0 13:15:06 INFO - TEST-OK | kraken | took 57468ms 13:15:06 INFO - SUITE-END | took 1167s 13:15:07 INFO - Completed test suite (00:19:28) 13:15:07 INFO - Working with test: dromaeo_css 13:15:07 INFO - Generating results file: dromaeo_css 13:15:07 INFO - Working with test: kraken 13:15:07 INFO - Generating results file: kraken 13:15:07 INFO - javascript benchmark 13:15:07 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:15:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 13:15:07 INFO - process_Request line: dromaeo_css 7465.71 graph.html#tests=[[72,1,61]] 13:15:07 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:15:07 INFO - process_Request line: kraken 1497.20 graph.html#tests=[[232,1,61]] 13:15:07 INFO - RETURN: dromaeo_css: 7465.71 13:15:07 INFO - RETURN: kraken: 1497.20 13:15:07 INFO - javascript benchmark 13:15:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3349.7605885822236, 3474.2704032153247, 3486.337595856787, 3524.541809564756, 3556.164301389174, 5650.9717451412735, 5721.856953576153, 5725.484706376431, 5731.541476681866, 5744.16709577111, 5571.331440227178, 5681.318241810978, 5718.77124915004, 5774.942250577493, 5892.970535147329, 5132.794688212476, 5174.611904107188, 5190.0, 5192.480751924815, 5239.580833533309, 529.3760211141679, 5053.5451809337155, 5138.306328645641, 5158.148905430599, 5165.741712914358, 4390.802413891351, 4942.9258561121615, 5165.457626949173, 5181.0, 5198.0, 5160.6129540284255, 5177.094008548489, 5200.063988482072, 5208.687478751287, 5210.869728256786, 5056.988602279522, 5075.5178258065425, 5124.0, 5176.2235664650225, 5179.792808287664, 5569.721513924287, 5624.690642014688, 5647.3505546862225, 5651.632643878134, 5668.603197776158, 6052.757889684407, 6137.376985335611, 6256.718447669866, 6257.7184026718905, 6270.937290627081, 6279.748810047593, 6289.937100628981, 6297.086922396273, 6302.55882088254, 6345.42891139795, 5808.82573522795, 5837.474627283565, 5850.707464626837, 5862.824115276549, 5893.675847828367, 5391.757370918318, 6154.046122850965, 6336.556441049082, 6350.0, 6379.936200638027, 6116.816495505142, 6141.048137538689, 6160.10678451622, 6161.7227224775, 6185.8144255671505, 6084.209052823105, 6296.874062518816, 6301.0, 6305.337939516285, 6315.778947736807, 6145.9692701536205, 6254.8123556293385, 6255.843603909848, 6270.090836828635, 6272.749090036347, 6157.8460538486, 6203.193584833943, 6245.718942647592, 6252.749890004349, 6261.279952805395, 4797.352357431771, 4866.683665561727, 4908.092002979461, 4953.083679519301, 4968.652194346361, 4220.978895105566, 4368.213721530155, 4390.648748100144, 4403.3174857897075, 4437.800298986489, 5681.971590142023, 5709.914351284734, 5741.5119714824705, 5755.85610359736, 5761.107028410603, 6122.215193971364, 6215.627062376272, 6301.054841773771, 6314.305426403092, 6317.684115794192, 5719.628224165416, 5734.111212762028, 5746.02317606008, 5758.856028599234, 5834.649921004753, 5254.789808407697, 5337.759800808973, 5406.864828379322, 5429.891402171935, 5430.728463576806, 5673.631213970996, 6217.756448710276, 6332.810015699536, 6340.7463701451425, 6385.48916086712, 5655.604107712421, 5788.652680839163, 6285.874282514233, 6308.179936608211, 6327.873442531216, 5199.818006369759, 6299.811005669837, 6300.275468321019, 6370.90443643355, 6386.137871387489, 6205.5345849060595, 6252.3122456530655, 6259.123722678738, 6284.340144284967, 6310.936890631035, 5486.698231597141, 6116.0010150213275, 6307.400796924285, 6310.0, 6313.96843015782, 5034.86715489012, 5866.6480011199465, 6041.124037014696, 6045.425684559959, 6056.333803281724, 5977.22296101504, 5978.073398623221, 5987.491063259672, 6054.606450580698, 6054.66699331541, 5856.677882716492, 5904.350521442552, 5913.438223368773, 5913.46778789911, 5925.111233314865, 5908.350081490947, 5994.730237139252, 6046.425589568984, 6047.697615119315, 6065.211522502046, 5075.264086707481, 5878.265216847894, 5895.9115613266695, 5918.615290006136, 5926.2295901532525], "unit": "score", "name": "dojo.html", "value": 5626.90883480891}, {"lowerIsBetter": false, "replicates": [499.2860209899844, 509.74003258338234, 528.3685995235693, 571.2117278156144, 602.2201249382052, 36890.44664330034, 37042.88871333857, 37103.628963710355, 37251.25497490048, 37532.62467375326, 38227.235455290946, 38275.80862095692, 38551.42172867409, 38568.0, 38732.0, 9380.296477764177, 9559.761005974837, 9567.952160239189, 9580.52097395131, 9605.855912161323, 9410.52947352633, 9594.896586892526, 9627.374220675669, 9715.174210192143, 9729.513524323791, 9702.369345992487, 9760.609575616967, 9802.166815820663, 9804.31369804114, 9828.950855245714, 9632.711018669452, 9705.854412183822, 9723.854142187802, 9737.659181928599, 9757.12185903265, 9520.381175223589, 9621.567029483691, 9626.807463850753, 9651.276154288456, 9668.129868311815, 37147.442788358196, 37395.87812365634, 37448.43827342592, 37649.435258471145, 37660.43509347362, 3230.4346739320526, 3319.40250754864, 3418.162550175223, 3459.619441861393, 3633.8001409922445, 27968.300792480146, 28432.28919277014, 28612.570811437847, 28782.280442989093, 28854.0, 2716.8641567921527, 2774.4728501584636, 2859.571064340345, 2872.956905646417, 2971.227480854972, 477429.0, 477465.0, 477556.0, 477608.6119569415, 477867.0, 63095.05357419643, 63273.0, 63445.682771585845, 63508.0, 63758.68120659367, 65618.0, 66378.33621663818, 66527.66736166288, 66742.99885501721, 67072.0, 15808.36766529349, 16115.435959741353, 16280.10459424743, 16324.0, 16350.50948471524, 12483.50065997368, 12526.436310366056, 12531.43608537618, 12536.749265014649, 12579.993600511938, 17037.7444338335, 19250.0, 19794.0, 19807.801921980885, 19883.60232795365, 8002.439829212016, 8057.395695322874, 8167.387445941578, 8189.7133600323705, 8199.877001844978, 859.7463748194298, 899.7795540092719, 1075.833245846895, 1093.4259513755183, 1130.3387518301722, 28643.2839179018, 29001.98493052733, 29307.706922930924, 29440.0, 29620.40759184804, 1053.2469284461647, 1057.069778594847, 1068.2148620763733, 1076.9515371808288, 1077.0737166037202, 12632.0, 13588.320583970763, 13767.655808604864, 13886.305684715724, 14051.71896562063, 496273.0, 535241.0, 539002.0, 544502.0, 544567.0, 55299.0, 55660.0, 55670.72164639232, 55811.72094139585, 55936.0, 1259.0053857452692, 1402.8597140286095, 1412.5762271318563, 1434.1968497641353, 1445.898787084894, 21499.2475263365, 27205.047823326087, 27495.817343255614, 27697.307567310978, 27991.0203142889, 47433.28850067183, 47457.05085898194, 47504.287435689184, 47834.0, 48048.759756201, 397066.0, 397099.0, 398868.0, 398947.0, 399281.0, 30235.546466802574, 30319.848400757855, 30652.386952261277, 30653.693463065083, 30660.0, 43074.784626077926, 43267.56732432761, 43647.56352436562, 43698.781506092266, 44160.33759493546, 36153.0, 36418.45372319364, 36541.45187822131, 36724.3587834011, 36959.44560831536, 29276.56085158682, 35862.64137358697, 36500.45249321315, 36902.8154859224, 37021.25957480889, 28495.0, 31033.0, 33833.323333533684, 34404.655953440146, 36540.451893222154, 26913.0, 30033.84983075158, 31271.53092703657, 32004.839975799972, 32060.67939320577, 23209.83950802487, 24001.879990599937, 24371.39071523226, 24730.0, 24942.62586061247], "unit": "score", "name": "ext.html", "value": 19195.72276294385}, {"lowerIsBetter": false, "replicates": [369.78737226094984, 370.67936235156594, 372.30564996281925, 375.13157041449045, 378.2831534242609, 14566.0, 17921.0, 18467.261309547637, 19771.901140494294, 19814.60370792585, 18293.7255941161, 18758.06209689517, 18866.905665471688, 18918.0, 18987.860728356307, 5549.112142057262, 5854.73653685583, 5856.121581762727, 5863.677497737623, 5878.50032747217, 4169.020280234143, 4725.952740472586, 6180.814575562717, 6456.22525296965, 6461.19235095613, 4656.697314674552, 5783.537317014629, 6336.112944187817, 6387.489000879942, 6387.616742995412, 5543.390227075019, 5675.886482270352, 5700.515456186229, 5710.971445142789, 5824.592278540504, 5634.746436410331, 5641.971790141064, 5654.886902261932, 5656.943430565683, 5675.233843431125, 14510.927445362811, 23795.048198072058, 23803.0, 23808.285751427484, 24041.0, 2300.413394584387, 2309.3880121767743, 2449.971012174873, 2482.2305085423395, 2525.2929179829675, 9577.712668619952, 10311.690649280534, 14334.068285561405, 14337.49818756349, 14595.343209555596, 1790.3017823049022, 1792.829681180286, 1875.1936667233085, 1891.5365735394917, 1952.7754308254448, 97096.51451742767, 101719.49140254325, 101949.0, 102513.48743256311, 102541.48729256455, 9645.662401815904, 10862.479252904599, 10922.453877306103, 11187.72030699239, 11280.717982050515, 11298.378589177673, 13151.868481315256, 13184.934075329562, 13191.47234110644, 13207.66980825487, 7197.388222001188, 7265.564066156047, 7568.129665088475, 7979.241972012649, 8298.792530186673, 7175.103112110986, 8071.273585377344, 8271.793205169919, 8284.047334556482, 8319.916800831914, 4064.9390259146135, 4254.31930891056, 4405.383246345515, 4453.0, 4464.441944756905, 1835.954101147482, 1896.2983696032557, 1902.077492416177, 1916.2622390379804, 1938.185961896007, 844.2106630300689, 867.6724611344653, 880.9911900881037, 987.807377561383, 992.1814503035025, 14334.426622934965, 18526.888386696573, 18720.157592908352, 18767.249310027444, 18919.243230270637, 912.977175570616, 922.9723108306762, 932.1377725603925, 954.9379290346105, 998.4159266828841, 9219.769505762275, 10594.046535811814, 10603.0, 10660.573577056986, 10678.145748340114, 624802.0, 630748.0, 638652.0, 639160.0, 750673.0, 111274.44362778134, 116302.0, 117806.0, 120553.0, 125141.0, 1110.8555887734542, 1143.9027682647068, 1171.6133675886938, 1172.7009612548745, 1197.8921897029136, 17719.379821706178, 18036.188371523574, 18063.0, 18173.45479635613, 18271.903685778896, 49023.0, 49132.75433622809, 49184.50815491942, 50583.74708126436, 51606.0, 70212.648936755, 72524.63737681278, 72662.63668681834, 73157.0, 74763.62618186875, 7423.740169094056, 7678.577678227751, 7704.30661240491, 7706.0, 7763.72826951054, 9865.210783137476, 10824.4046577439, 11368.488418021374, 11845.052395808487, 11976.760464790481, 9169.633214671338, 10194.388336699525, 10517.631882884063, 10633.043026127376, 10691.732706682395, 10044.648437304659, 10391.1167550756, 10574.577016919236, 10624.36253824773, 10854.40300783433, 10231.795364092528, 10597.89402106, 10729.302595331279, 10824.458777061272, 10894.400807955639, 6348.460380867678, 7607.35337496319, 7703.959965404599, 7704.576248306397, 7730.574818385043, 9364.765880853032, 10579.735506612396, 10584.84122738175, 10777.568897244022, 10875.891241087487], "unit": "score", "name": "jquery.html", "value": 9198.82994547472}, {"lowerIsBetter": false, "replicates": [1528.8776897848172, 1533.8696210822084, 1752.702040653089, 1770.7166853303474, 1867.4304337177164, 7790.337821285198, 8375.623096960637, 8577.142285771428, 8732.8690069649, 8742.650293988248, 8510.872336914952, 8548.786280342994, 8642.222200002, 8653.350998675109, 8729.214370706635, 2100.453881990678, 2472.0606169655507, 2478.946447759695, 2491.4643351679383, 2493.4265119022634, 2463.7289898111285, 2478.3432390416556, 2510.598304271317, 2515.383730985911, 2519.86140762258, 2160.3626930055593, 2428.3322086426197, 2469.555480013597, 2490.0, 2492.239866840613, 2434.6226334918115, 2447.608382658775, 2476.7863746764137, 2476.863772492521, 2484.3416494628937, 2215.3021798133695, 2446.9355830213913, 2453.9877300613384, 2472.6909136357954, 2494.3639371960217, 8452.957735211347, 8479.66081356745, 8482.236598706146, 8526.957365213197, 8545.230929216339, 5218.243354713583, 5395.78416863325, 5410.756515956791, 5438.293021907127, 5442.455754424565, 3666.633336666339, 3667.0832291927018, 3718.367877460811, 3756.417755247941, 3796.791176485292, 1064.9520771565299, 1072.1727411518345, 1072.5388083124253, 1088.983665245022, 1098.7912296663608, 11374.545018199262, 11481.0, 11505.712357191054, 11532.192746507748, 11549.13381496391, 4870.829520966749, 4889.902201955941, 4993.400791904922, 4994.250862370601, 5006.324146240211, 9959.850602240973, 10004.749881253027, 10039.0, 10056.59773609062, 10060.24548158891, 5422.267993820784, 5457.781688732485, 5460.126379779216, 5483.341998960071, 5484.095124304525, 4914.754262286871, 4917.237828136645, 4953.876153096201, 4974.577160941288, 4994.675346102492, 3850.0759817643566, 3871.535415750128, 3876.476675648751, 3882.9223415531533, 3903.8048097595006, 1204.9819252711216, 1252.7431876465303, 1289.426205338634, 1319.9142055766345, 1339.638297659646, 1122.6688127002553, 1123.4831977290376, 1142.1548054439654, 1260.2753416785201, 1315.579014715282, 6377.904331434939, 6873.0, 7784.649690763816, 7805.2194780521495, 7898.0, 570.1618620627671, 604.8990836677293, 648.24803228255, 650.7462089784988, 792.0772300270236, 5833.504152147115, 6003.939960600338, 6050.42520960508, 6065.0, 6066.423689749467, 8796.516191609395, 10083.848742268872, 10323.587056517656, 10350.430726309974, 10633.734156646145, 9044.457332560067, 10318.896811031944, 10461.529231184462, 10522.894771052344, 10602.416867072385, 8127.268545830903, 8224.917750822535, 8233.17668233184, 8256.215659512216, 8308.376871734645, 7641.083070031409, 7670.961645191738, 7709.4603377763015, 7735.342495887912, 7749.65126569317, 9223.815523689354, 9458.527073646152, 9486.95256523713, 9551.713448596553, 9590.760230994281, 8329.12544182852, 9637.9036209637, 9843.064908833649, 9868.457234851865, 9936.105750482202, 7382.0, 7399.630018499161, 7474.588897610466, 7475.588842613491, 7521.172671006294, 8071.192880711882, 8126.431149819456, 8141.104478507478, 8154.14381489935, 8170.550619715973, 7566.167721550515, 7701.499402538817, 7766.817121085191, 7804.648790804314, 7824.256695613907, 7477.925220747723, 7539.924600753922, 7576.4317676173405, 7669.808254793675, 7673.8848917267405, 7622.009138811919, 7680.193579674054, 7732.072151341875, 7739.651715672696, 7740.767776966475, 6977.0, 6984.476164287597, 6998.300169982961, 7057.964710176621, 7088.0785497884945, 7071.929280707127, 7136.250693677089, 7164.570125792469, 7169.0, 7174.390176835028], "unit": "score", "name": "mootools.html", "value": 4828.00226489522}, {"lowerIsBetter": false, "replicates": [313.22008199583036, 332.7321506187518, 336.6364326527351, 337.5712844687246, 344.0555674673021, 6743.932560674391, 6770.119884415031, 6834.31656834317, 6880.690368933398, 6889.517733758633, 5700.97382471155, 5935.605132793801, 6610.0, 6883.552569083006, 6933.445324374051, 4614.238650622643, 4718.079974404993, 5083.18669012958, 5085.745712714368, 5110.8466745997675, 4882.97558512207, 5071.061853557086, 5092.159793634046, 5095.0319439306595, 5112.488751124895, 4939.28380384844, 5005.9499405005845, 5009.674371165863, 5021.6986980781085, 5025.422076461217, 5003.799848006075, 5005.399352077774, 5006.924896126561, 5013.924791128136, 5025.899482010358, 4057.9594204057876, 4197.790110494494, 4285.807138678767, 4288.935665965013, 4304.698671093025, 6547.574407663486, 6608.636524991123, 6617.7022034008105, 6632.568883022636, 6640.701168447432, 4980.775865086043, 5943.257092863392, 5980.700964951779, 5983.282006159288, 5995.1906492623375, 7113.110861142357, 7320.743773967939, 7325.816854578625, 7332.926670733278, 7338.96330518344, 4362.781860906974, 4804.20730579454, 4834.903301933941, 4853.951460485385, 4854.805807767685, 7724.884126738103, 7733.7679869604, 7738.4969976951315, 7746.5352078874885, 7755.185705500954, 4061.7156799024374, 4764.595009424169, 4910.975445122752, 4940.6788558743565, 4941.234108713155, 4041.6160464755803, 4541.568550987651, 5020.297158397827, 5027.396712394536, 5038.521340472723, 5937.940620593825, 5941.613795103304, 5951.940480595225, 5961.433663801932, 5963.970180149072, 7387.630618469055, 7397.297256760599, 7407.2222416646555, 7409.036825212688, 7427.18300986891, 1417.971640567183, 1755.1399814091003, 1755.7190849464025, 1756.920938557768, 1761.207456644515, 1013.2603199664286, 1117.9105671546256, 1128.8137457319615, 1136.108155098244, 1140.0, 6503.0, 6612.504062195355, 6877.277885822016, 6884.380405763405, 6885.483588730865, 7641.121271053788, 7672.884906726404, 7673.846523069507, 7687.846243075219, 7696.191899850547, 6693.631850248185, 6850.554713943578, 6855.520113592001, 6861.348171923659, 6897.5512243878065, 3900.9804950975063, 3940.271049855786, 4025.275450418953, 4062.5734297898293, 4072.124493233969, 7839.725609603636, 7902.920970790218, 7907.5650839203245, 7909.090454597795, 7953.2842044216295, 7890.210978902064, 7928.801779955547, 7930.524168549906, 7935.444518883738, 7968.561729104955, 7719.0, 7969.242921922524, 7995.560244186509, 7999.680012799423, 8013.4791238569305, 7671.156172821097, 7683.270089341504, 7689.269519395649, 7689.8462030757955, 7696.8460630788195, 7228.49400541957, 7510.624468776648, 7521.435892307989, 7528.811779705551, 7552.773416797505, 8015.358771298399, 8033.317168040782, 8042.03495580534, 8044.994375703037, 8059.677612895419, 4943.9505604944925, 4966.155753521838, 4983.476734942778, 5001.474845141208, 5004.499550045112, 7396.3343299103335, 7602.885956710765, 7614.771556853303, 7734.187910269566, 7746.380289576933, 7399.852002959803, 7405.370543503863, 7419.740309089156, 7429.182789893, 7444.292792184734, 7167.964160179165, 7422.517536360119, 7423.331900129015, 7423.591702456417, 7435.739749108971, 7240.420766338575, 7242.89135662955, 7247.13034435871, 7247.9637601811655, 7254.89117663246, 7395.334419902235, 7401.48189626721, 7414.110306763223, 7433.0, 7441.144268409203, 6977.1278590176225, 7157.498975071695, 7224.783256502314, 7249.166345870292, 7267.345938865527], "unit": "score", "name": "prototype.html", "value": 5368.755313773571}, {"lowerIsBetter": false, "replicates": [623.146289583271, 673.7944926797328, 686.3171144711014, 715.7781087862763, 734.3354264390729, 14735.557933262005, 14875.181864997421, 15005.174715390649, 15009.774853377208, 15026.624334391645, 13716.65708357289, 13750.449982000733, 13755.105918115316, 13761.31193440329, 13771.24258165803, 684.6953105867866, 835.908050114487, 836.0761358698642, 836.10119121944, 857.4469467193657, 788.7436583110483, 829.1832544943226, 848.0586548930683, 848.8132610825609, 852.2329903087209, 881.0792721605906, 883.7923088074298, 895.6059333893098, 900.1358695652182, 903.6475774447971, 880.216607219575, 887.3256325192835, 893.2987604730288, 897.627484593896, 901.1349104859343, 581.1573218832667, 649.0588646462649, 669.718718138383, 670.0518765946229, 671.1241829412614, 14377.281135943265, 14386.0, 14404.423823047066, 14426.495072672406, 14446.494372696905, 12820.935895320463, 12829.486820527167, 12928.224306541637, 13040.347982600832, 13111.86888131116, 9858.211343092607, 9950.0, 10032.423615531485, 10081.546330415149, 10091.89908100917, 3498.300339931998, 3567.94648080279, 3588.0671025533547, 3599.94600080999, 3605.369060414417, 66694.0, 67267.66366168138, 67647.0, 68111.97832032523, 68569.65715171442, 9232.63356030013, 9329.0, 9343.0, 9571.473568953774, 9876.209903207726, 19909.701354479694, 19936.70094948577, 20013.39959801208, 20052.598948020957, 20056.0, 7233.421326293884, 7347.63261836906, 7361.742339018108, 7464.1416237132335, 7486.887696684554, 4050.4936882889638, 4065.4308396824467, 4103.733257338264, 4117.135401565645, 4144.730592511477, 3468.236987862666, 3498.632643572439, 3517.0503963929596, 3534.699550538233, 3553.1117220694828, 632.0961025733154, 638.2086213095728, 645.6674812471581, 661.2692974263466, 664.7972368427676, 555.686037388874, 570.7231992483643, 597.7429705226795, 598.0550729846832, 616.3035769580346, 8717.476951382938, 8856.601452934634, 9006.279497640173, 9050.909490905007, 9095.045020272908, 502.7561632608182, 509.47269575988673, 530.1279395394554, 547.2393373211239, 624.6470744029609, 3763.9435408468894, 3801.878445858423, 3839.731218814656, 4014.5383280922483, 4101.302778527657, 62157.0, 74620.0, 84809.0, 86272.0, 86307.0, 61989.0, 73273.0, 77554.61222693851, 80156.0, 80945.0, 59811.0, 68735.65632171708, 68747.65626171937, 69067.61864762676, 69529.65235173792, 7500.812479688051, 8729.825403492021, 8763.25512331459, 8870.73387798367, 8973.192412682889, 46564.06871862476, 46796.532034679214, 46807.53192468032, 47801.0, 47816.7609161952, 62323.376766233574, 63090.36909630845, 64367.0, 64509.0, 64761.35238647553, 10792.946035269773, 10927.125829933746, 11010.614628487965, 11146.164037697366, 11614.419279036183, 11919.880801191877, 12017.699557511132, 12382.318972456242, 12882.549110781078, 13059.0, 11128.44306453297, 11401.486933087865, 11798.233114847508, 11807.409629518661, 12332.136750427384, 11017.228793984345, 11466.77066458683, 11507.712307192387, 11653.626391128779, 11858.940705296418, 10931.289466184673, 11181.72045698864, 11296.6046188383, 11536.0, 11541.0, 9005.684801032194, 9239.76900577491, 9295.86056209171, 9436.197923176333, 9834.360766550151, 9218.907810921804, 9285.442873427615, 9316.95341523315, 9478.715638530855, 10108.696739097839], "unit": "score", "name": "yui.html", "value": 6722.713253459801}], "name": "dromaeo_css", "value": 7465.708083861558}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 124.0, 158.0, 126.0, 125.0, 113.0, 118.0, 117.0, 115.0], "unit": "score", "name": "ai-astar", "value": 121.4}, {"lowerIsBetter": true, "replicates": [139.0, 124.0, 147.0, 151.0, 133.0, 163.0, 142.0, 122.0, 150.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 139.4}, {"lowerIsBetter": true, "replicates": [193.0, 200.0, 199.0, 203.0, 203.0, 228.0, 263.0, 183.0, 263.0, 194.0], "unit": "score", "name": "audio-dft", "value": 212.9}, {"lowerIsBetter": true, "replicates": [64.0, 78.0, 70.0, 108.0, 57.0, 56.0, 57.0, 58.0, 107.0, 57.0], "unit": "score", "name": "audio-fft", "value": 71.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 115.0, 95.0, 103.0, 86.0, 114.0, 80.0, 84.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 98.2}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 88.0, 91.0, 87.0, 106.0, 116.0, 109.0, 86.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 93.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.8}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 90.0, 89.0, 89.0, 138.0, 134.0, 125.0, 89.0, 108.0], "unit": "score", "name": "imaging-desaturate", "value": 104.6}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 56.0, 57.0, 55.0, 56.0, 55.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 92.0, 108.0, 69.0, 62.0, 63.0, 77.0, 76.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 83.0, 85.0, 84.0, 87.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [125.0, 127.0, 116.0, 131.0, 144.0, 157.0, 134.0, 133.0, 133.0, 147.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.7}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 142.0, 142.0, 145.0, 145.0, 144.0, 139.0, 137.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 65.0, 69.0, 68.0, 66.0, 69.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1497.2}]} 13:15:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1497.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7465.71"}}} 13:15:08 INFO - Return code: 0 13:15:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:15:08 INFO - # TBPL SUCCESS # 13:15:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:15:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:15:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:15:08 INFO - 2016-02-11 13:15:08.157 screenresolution[1697:10349] starting screenresolution argv=screenresolution get 13:15:08 INFO - 2016-02-11 13:15:08.159 screenresolution[1697:10349] Display 0: 1600x1200x32@60 13:15:08 INFO - 2016-02-11 13:15:08.165 screenresolution[1698:10352] starting screenresolution argv=screenresolution list 13:15:08 INFO - Available Modes on Display 0 13:15:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:15:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:15:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:15:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:15:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:15:08 INFO - Intel Iris: 13:15:08 INFO - Chipset Model: Intel Iris 13:15:08 INFO - Type: GPU 13:15:08 INFO - Bus: Built-In 13:15:08 INFO - VRAM (Dynamic, Max): 1536 MB 13:15:08 INFO - Vendor: Intel (0x8086) 13:15:08 INFO - Device ID: 0x0a2e 13:15:08 INFO - Revision ID: 0x0009 13:15:08 INFO - Displays: 13:15:08 INFO - Display: 13:15:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:15:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:15:08 INFO - Display Serial Number: 1600x1200 60 13:15:08 INFO - Main Display: Yes 13:15:08 INFO - Mirror: Off 13:15:08 INFO - Online: Yes 13:15:08 INFO - Rotation: Supported 13:15:08 INFO - Return code: 0 13:15:08 INFO - Running post-action listener: _resource_record_post_action 13:15:08 INFO - Running post-run listener: _resource_record_post_run 13:15:09 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39261696; Write bytes: 709711360; Read time: 423; Write time: 2019 13:15:09 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 384588288; Write bytes: 377697792; Read time: 28441; Write time: 657 13:15:09 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 38307328; Write bytes: 303470592; Read time: 409; Write time: 1298 13:15:09 INFO - Running post-run listener: _upload_blobber_files 13:15:09 INFO - Blob upload gear active. 13:15:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:15:09 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 13:15:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:15:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:15:09 INFO - (blobuploader) - INFO - Open directory for files ... 13:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:10 INFO - (blobuploader) - INFO - Done attempting. 13:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:11 INFO - (blobuploader) - INFO - Done attempting. 13:15:11 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:11 INFO - Return code: 0 13:15:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162670fbf29b444b16918b860957bbc97b2a54353f5c484716bacbcb4ba774f8074db88d3a6759b4e44fbfdac79c368c95dfe8ec6f78f28d03130ec167e3ebd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51b84c988c27d216e4d3649f7215bc4638e2daaf81f6fe319be71a2a643cc92fd0f24ce6019b6fb45632af0fc1f5f18c05f55bd0d2202df49c2ca5d0aa5e008"} 13:15:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:11 INFO - Contents: 13:15:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162670fbf29b444b16918b860957bbc97b2a54353f5c484716bacbcb4ba774f8074db88d3a6759b4e44fbfdac79c368c95dfe8ec6f78f28d03130ec167e3ebd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51b84c988c27d216e4d3649f7215bc4638e2daaf81f6fe319be71a2a643cc92fd0f24ce6019b6fb45632af0fc1f5f18c05f55bd0d2202df49c2ca5d0aa5e008"} 13:15:11 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:11 INFO - Copying logs to upload dir... 13:15:11 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.000700 ========= master_lag: 2.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-11 13:15:14.666767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 13:15:14.669845) ========= 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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162670fbf29b444b16918b860957bbc97b2a54353f5c484716bacbcb4ba774f8074db88d3a6759b4e44fbfdac79c368c95dfe8ec6f78f28d03130ec167e3ebd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51b84c988c27d216e4d3649f7215bc4638e2daaf81f6fe319be71a2a643cc92fd0f24ce6019b6fb45632af0fc1f5f18c05f55bd0d2202df49c2ca5d0aa5e008"} build_url:https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/IDM_1HYwQ0SZT3o4Lm4ieg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162670fbf29b444b16918b860957bbc97b2a54353f5c484716bacbcb4ba774f8074db88d3a6759b4e44fbfdac79c368c95dfe8ec6f78f28d03130ec167e3ebd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51b84c988c27d216e4d3649f7215bc4638e2daaf81f6fe319be71a2a643cc92fd0f24ce6019b6fb45632af0fc1f5f18c05f55bd0d2202df49c2ca5d0aa5e008"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 13:15:14.846444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:15:14.846764) ========= 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.K5BtJ2bjjQ/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.izhkbQ7RJ8/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005055 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:15:14.868344) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 13:15:14.868637) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 13:15:14.869828) ========= ========= Total master_lag: 3.36 =========