builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0182 starttime: 1455163853.46 results: success (0) buildid: 20160210191531 builduid: ad01fbc983d4494aba5b1e44f4af2b40 revision: 1b7bbed6b080ed5dedc8247a162b3269040d245f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.461512) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.461976) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.462279) ========= 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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005579 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.484453) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.484763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.556858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.557447) ========= 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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005089 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.605895) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.606165) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.606511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:53.606786) ========= 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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-10 20:10:53-- 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% 8.35M=0.001s 2016-02-10 20:10:54 (8.35 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.529848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:54.155340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:54.155636) ========= 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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.019079 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:54.320443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 20:10:54.320795) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b7bbed6b080ed5dedc8247a162b3269040d245f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1b7bbed6b080ed5dedc8247a162b3269040d245f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-10 20:10:54,391 truncating revision to first 12 chars 2016-02-10 20:10:54,391 Setting DEBUG logging. 2016-02-10 20:10:54,391 attempt 1/10 2016-02-10 20:10:54,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b7bbed6b080?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 20:10:55,451 unpacking tar archive at: fx-team-1b7bbed6b080/testing/mozharness/ program finished with exit code 0 elapsedTime=1.304375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 20:10:55.643763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:55.644079) ========= echo 1b7bbed6b080ed5dedc8247a162b3269040d245f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1b7bbed6b080ed5dedc8247a162b3269040d245f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 1b7bbed6b080ed5dedc8247a162b3269040d245f program finished with exit code 0 elapsedTime=0.005004 script_repo_revision: '1b7bbed6b080ed5dedc8247a162b3269040d245f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:55.693848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:55.694139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 20:10:55.707049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-02-10 20:10:55.707341) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:10:55 INFO - MultiFileLogger online at 20160210 20:10:55 in /builds/slave/test 20:10:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:10:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:55 INFO - {'append_to_log': False, 20:10:55 INFO - 'base_work_dir': '/builds/slave/test', 20:10:55 INFO - 'blob_upload_branch': 'Fx-Team', 20:10:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:55 INFO - 'branch': 'Fx-Team', 20:10:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:55 INFO - 'config_files': ('talos/mac_config.py',), 20:10:55 INFO - 'default_actions': ('clobber', 20:10:55 INFO - 'read-buildbot-config', 20:10:55 INFO - 'download-and-extract', 20:10:55 INFO - 'populate-webroot', 20:10:55 INFO - 'create-virtualenv', 20:10:55 INFO - 'install', 20:10:55 INFO - 'run-tests'), 20:10:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:55 INFO - 'download_minidump_stackwalk': True, 20:10:55 INFO - 'download_symbols': 'ondemand', 20:10:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:55 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:55 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:55 INFO - 'installer_path': 'installer.exe', 20:10:55 INFO - 'log_level': 'info', 20:10:55 INFO - 'log_name': 'talos', 20:10:55 INFO - 'log_to_console': True, 20:10:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:10:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:10:55 INFO - 'opt_config_files': (), 20:10:55 INFO - 'pip_index': False, 20:10:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:10:55 INFO - 'cmd': ('bash', 20:10:55 INFO - '-c', 20:10:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:10:55 INFO - 'enabled': True, 20:10:55 INFO - 'halt_on_failure': False, 20:10:55 INFO - 'name': 'check_screen_resolution'},), 20:10:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:10:55 INFO - 'cmd': ('bash', 20:10:55 INFO - '-c', 20:10:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:10:55 INFO - 'enabled': True, 20:10:55 INFO - 'halt_on_failure': False, 20:10:55 INFO - 'name': 'check_screen_resolution'},), 20:10:55 INFO - 'run_cmd_checks_enabled': True, 20:10:55 INFO - 'sps_profile': False, 20:10:55 INFO - 'sps_profile_interval': 0, 20:10:55 INFO - 'suite': 'dromaeojs-e10s', 20:10:55 INFO - 'system_bits': '32', 20:10:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:55 INFO - 'title': 't-yosemite-r7-0182', 20:10:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:55 INFO - 'use_talos_json': True, 20:10:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:55 INFO - 'work_dir': 'build'} 20:10:55 INFO - ##### 20:10:55 INFO - ##### Running clobber step. 20:10:55 INFO - ##### 20:10:55 INFO - Running pre-action listener: _resource_record_pre_action 20:10:55 INFO - Running main action method: clobber 20:10:55 INFO - rmtree: /builds/slave/test/build 20:10:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:57 INFO - Running post-action listener: _resource_record_post_action 20:10:57 INFO - ##### 20:10:57 INFO - ##### Running read-buildbot-config step. 20:10:57 INFO - ##### 20:10:57 INFO - Running pre-action listener: _resource_record_pre_action 20:10:57 INFO - Running main action method: read_buildbot_config 20:10:57 INFO - Using buildbot properties: 20:10:57 INFO - { 20:10:57 INFO - "project": "", 20:10:57 INFO - "product": "firefox", 20:10:57 INFO - "script_repo_revision": "production", 20:10:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:10:57 INFO - "repository": "", 20:10:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:10:57 INFO - "buildid": "20160210191531", 20:10:57 INFO - "pgo_build": "False", 20:10:57 INFO - "basedir": "/builds/slave/test", 20:10:57 INFO - "buildnumber": 361, 20:10:57 INFO - "slavename": "t-yosemite-r7-0182", 20:10:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:10:57 INFO - "platform": "yosemite_r7", 20:10:57 INFO - "scheduler": "tests-fx-team-macosx64-talos", 20:10:57 INFO - "branch": "fx-team", 20:10:57 INFO - "repo_path": "integration/fx-team", 20:10:57 INFO - "revision": "1b7bbed6b080ed5dedc8247a162b3269040d245f", 20:10:57 INFO - "stage_platform": "macosx64", 20:10:57 INFO - "builduid": "ad01fbc983d4494aba5b1e44f4af2b40", 20:10:57 INFO - "slavebuilddir": "test" 20:10:57 INFO - } 20:10:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 20:10:57 INFO - Running post-action listener: _resource_record_post_action 20:10:57 INFO - ##### 20:10:57 INFO - ##### Running download-and-extract step. 20:10:57 INFO - ##### 20:10:57 INFO - Running pre-action listener: _resource_record_pre_action 20:10:57 INFO - Running main action method: download_and_extract 20:10:57 INFO - mkdir: /builds/slave/test/build/tests 20:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:57 INFO - https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/test_packages.json 20:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/test_packages.json 20:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:11:21 INFO - Downloaded 1277 bytes. 20:11:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:11:21 INFO - Using the following test package requirements: 20:11:21 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:11:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 20:11:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 20:11:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'jsshell-mac.zip'], 20:11:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 20:11:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:11:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 20:11:21 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 20:11:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 20:11:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:11:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:11:21 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 20:11:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:21 INFO - https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:26 INFO - Downloaded 17750541 bytes. 20:11:26 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'] 20:11:26 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 20:11:29 INFO - Return code: 0 20:11:29 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 20:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:29 INFO - https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:30 INFO - Downloaded 17750541 bytes. 20:11:30 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'] 20:11:30 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 20:11:34 INFO - Return code: 0 20:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:34 INFO - https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:35 INFO - Downloaded 10706547 bytes. 20:11:35 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'] 20:11:35 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 20:11:35 INFO - Return code: 0 20:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:35 INFO - https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 20:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MatKC3EkT7C4O2h9KcEbeA/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 20:11:39 INFO - Downloaded 111185592 bytes. 20:11:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:11:39 INFO - mkdir: /builds/slave/test/properties 20:11:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:11:39 INFO - Writing to file /builds/slave/test/properties/build_url 20:11:39 INFO - Contents: 20:11:39 INFO - build_url:https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:11:40 INFO - Running post-action listener: _resource_record_post_action 20:11:40 INFO - Running post-action listener: set_extra_try_arguments 20:11:40 INFO - ##### 20:11:40 INFO - ##### Running populate-webroot step. 20:11:40 INFO - ##### 20:11:40 INFO - Running pre-action listener: _resource_record_pre_action 20:11:40 INFO - Running main action method: populate_webroot 20:11:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:11:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:11:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:11:40 INFO - '--tppagecycles', 20:11:40 INFO - '7'], 20:11:40 INFO - 'tests': ['tsvgm']}}, 20:11:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:11:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:11:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:11:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:11:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:11:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'tests': ['damp', 'tps']}, 20:11:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['damp', 'tps']}, 20:11:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:11:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:11:40 INFO - 'other': {'tests': ['a11yr', 20:11:40 INFO - 'ts_paint', 20:11:40 INFO - 'tpaint', 20:11:40 INFO - 'sessionrestore', 20:11:40 INFO - 'sessionrestore_no_auto_restore']}, 20:11:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['a11yr', 20:11:40 INFO - 'ts_paint', 20:11:40 INFO - 'tpaint', 20:11:40 INFO - 'sessionrestore', 20:11:40 INFO - 'sessionrestore_no_auto_restore']}, 20:11:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['a11yr', 20:11:40 INFO - 'ts_paint', 20:11:40 INFO - 'tpaint', 20:11:40 INFO - 'sessionrestore', 20:11:40 INFO - 'sessionrestore_no_auto_restore']}, 20:11:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['a11yr', 20:11:40 INFO - 'ts_paint', 20:11:40 INFO - 'tpaint', 20:11:40 INFO - 'sessionrestore', 20:11:40 INFO - 'sessionrestore_no_auto_restore']}, 20:11:40 INFO - 'other_l64': {'tests': ['a11yr', 20:11:40 INFO - 'ts_paint', 20:11:40 INFO - 'tpaint', 20:11:40 INFO - 'sessionrestore', 20:11:40 INFO - 'sessionrestore_no_auto_restore']}, 20:11:40 INFO - 'other_nol64': {'tests': ['a11yr', 20:11:40 INFO - 'ts_paint', 20:11:40 INFO - 'tpaint', 20:11:40 INFO - 'sessionrestore', 20:11:40 INFO - 'sessionrestore_no_auto_restore']}, 20:11:40 INFO - 'svgr': {'tests': ['tsvgx', 20:11:40 INFO - 'tsvgr_opacity', 20:11:40 INFO - 'tart', 20:11:40 INFO - 'tscrollx', 20:11:40 INFO - 'cart']}, 20:11:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['tsvgx', 20:11:40 INFO - 'tsvgr_opacity', 20:11:40 INFO - 'tart', 20:11:40 INFO - 'tscrollx', 20:11:40 INFO - 'cart']}, 20:11:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'tests': ['tp5o']}, 20:11:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'talos_options': ['--e10s'], 20:11:40 INFO - 'tests': ['tp5o']}, 20:11:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'talos_options': ['--xperf_path', 20:11:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:40 INFO - 'tests': ['tp5n']}, 20:11:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:11:40 INFO - 'talos_options': ['--e10s', 20:11:40 INFO - '--xperf_path', 20:11:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:11:40 INFO - 'tests': ['tp5n']}}, 20:11:40 INFO - 'talos.zip': {'path': '', 20:11:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:11:40 INFO - Running post-action listener: _resource_record_post_action 20:11:40 INFO - ##### 20:11:40 INFO - ##### Running create-virtualenv step. 20:11:40 INFO - ##### 20:11:40 INFO - Running pre-action listener: _resource_record_pre_action 20:11:40 INFO - Running main action method: create_virtualenv 20:11:40 INFO - Creating virtualenv /builds/slave/test/build/venv 20:11:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:11:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:11:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:11:40 INFO - Using real prefix '/tools/python27' 20:11:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:11:41 INFO - Installing distribute.............................................................................................................................................................................................done. 20:11:44 INFO - Installing pip.................done. 20:11:44 INFO - Return code: 0 20:11:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:44 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:11:44 INFO - 'HOME': '/Users/cltbld', 20:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:11:44 INFO - 'LOGNAME': 'cltbld', 20:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:44 INFO - 'MOZ_NO_REMOTE': '1', 20:11:44 INFO - 'NO_EM_RESTART': '1', 20:11:44 INFO - 'PAGER': '/bin/cat', 20:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:44 INFO - 'PWD': '/builds/slave/test', 20:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:11:44 INFO - 'SHELL': '/bin/bash', 20:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:11:44 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:11:44 INFO - 'USER': 'cltbld', 20:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:44 INFO - 'XPC_FLAGS': '0x0', 20:11:44 INFO - 'XPC_SERVICE_NAME': '0', 20:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:11:44 INFO - Cleaning up... 20:11:44 INFO - Return code: 0 20:11:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:44 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:11:44 INFO - 'HOME': '/Users/cltbld', 20:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:11:44 INFO - 'LOGNAME': 'cltbld', 20:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:44 INFO - 'MOZ_NO_REMOTE': '1', 20:11:44 INFO - 'NO_EM_RESTART': '1', 20:11:44 INFO - 'PAGER': '/bin/cat', 20:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:44 INFO - 'PWD': '/builds/slave/test', 20:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:11:44 INFO - 'SHELL': '/bin/bash', 20:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:11:44 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:11:44 INFO - 'USER': 'cltbld', 20:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:44 INFO - 'XPC_FLAGS': '0x0', 20:11:44 INFO - 'XPC_SERVICE_NAME': '0', 20:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:44 INFO - Downloading/unpacking psutil>=0.7.1 20:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:11:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:47 INFO - Installing collected packages: psutil 20:11:47 INFO - Running setup.py install for psutil 20:11:47 INFO - building 'psutil._psutil_osx' extension 20:11:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:11:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:11:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:11:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:11:48 INFO - building 'psutil._psutil_posix' extension 20:11:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:11:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:11:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:11:48 INFO - ^ 20:11:48 INFO - 1 warning generated. 20:11:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:11:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:11:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:11:48 INFO - Successfully installed psutil 20:11:48 INFO - Cleaning up... 20:11:48 INFO - Return code: 0 20:11:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:11:48 INFO - 'HOME': '/Users/cltbld', 20:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:11:48 INFO - 'LOGNAME': 'cltbld', 20:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:48 INFO - 'MOZ_NO_REMOTE': '1', 20:11:48 INFO - 'NO_EM_RESTART': '1', 20:11:48 INFO - 'PAGER': '/bin/cat', 20:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:48 INFO - 'PWD': '/builds/slave/test', 20:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:11:48 INFO - 'SHELL': '/bin/bash', 20:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:11:48 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:11:48 INFO - 'USER': 'cltbld', 20:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:48 INFO - 'XPC_FLAGS': '0x0', 20:11:48 INFO - 'XPC_SERVICE_NAME': '0', 20:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:11:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:11:52 INFO - Installing collected packages: mozsystemmonitor 20:11:52 INFO - Running setup.py install for mozsystemmonitor 20:11:52 INFO - Successfully installed mozsystemmonitor 20:11:52 INFO - Cleaning up... 20:11:52 INFO - Return code: 0 20:11:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:52 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:11:52 INFO - 'HOME': '/Users/cltbld', 20:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:11:52 INFO - 'LOGNAME': 'cltbld', 20:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:52 INFO - 'MOZ_NO_REMOTE': '1', 20:11:52 INFO - 'NO_EM_RESTART': '1', 20:11:52 INFO - 'PAGER': '/bin/cat', 20:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:52 INFO - 'PWD': '/builds/slave/test', 20:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:11:52 INFO - 'SHELL': '/bin/bash', 20:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:11:52 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:11:52 INFO - 'USER': 'cltbld', 20:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:52 INFO - 'XPC_FLAGS': '0x0', 20:11:52 INFO - 'XPC_SERVICE_NAME': '0', 20:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:11:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:11:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11: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 20:11:56 INFO - Downloading docopt-0.6.1.tar.gz 20:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:11:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:11:56 INFO - Running setup.py install for blobuploader 20:11:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:11:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:11:56 INFO - Running setup.py install for requests 20:11:57 INFO - Running setup.py install for docopt 20:11:57 INFO - Successfully installed blobuploader requests docopt 20:11:57 INFO - Cleaning up... 20:11:57 INFO - Return code: 0 20:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:11:57 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:11:57 INFO - 'HOME': '/Users/cltbld', 20:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:11:57 INFO - 'LOGNAME': 'cltbld', 20:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:57 INFO - 'MOZ_NO_REMOTE': '1', 20:11:57 INFO - 'NO_EM_RESTART': '1', 20:11:57 INFO - 'PAGER': '/bin/cat', 20:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:57 INFO - 'PWD': '/builds/slave/test', 20:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:11:57 INFO - 'SHELL': '/bin/bash', 20:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:11:57 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:11:57 INFO - 'USER': 'cltbld', 20:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:57 INFO - 'XPC_FLAGS': '0x0', 20:11:57 INFO - 'XPC_SERVICE_NAME': '0', 20:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:11:57 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-i9tuRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:11:57 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-NZom7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:11:57 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-1MluJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:11:57 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-8Vwe1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-nFpFxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-01bmmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-sV_JcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-gBdlfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-XIovDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-fk9OEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-leDub7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-mSS4kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Fcn6eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:11:58 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-9Lig16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:59 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-hwB10h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:11:59 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-j29vog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:11:59 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-XVbFOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:11:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:11:59 INFO - Running setup.py install for manifestparser 20:11:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:11:59 INFO - Running setup.py install for mozcrash 20:11:59 INFO - Running setup.py install for mozdebug 20:11:59 INFO - Running setup.py install for mozdevice 20:11:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:11:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:11:59 INFO - Running setup.py install for mozfile 20:12:00 INFO - Running setup.py install for mozhttpd 20:12:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Running setup.py install for mozinfo 20:12:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Running setup.py install for mozInstall 20:12:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Running setup.py install for mozleak 20:12:00 INFO - Running setup.py install for mozlog 20:12:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Running setup.py install for moznetwork 20:12:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:12:00 INFO - Running setup.py install for mozprocess 20:12:01 INFO - Running setup.py install for mozprofile 20:12:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:12:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:12:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:12:01 INFO - Running setup.py install for mozrunner 20:12:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:12:01 INFO - Running setup.py install for mozscreenshot 20:12:01 INFO - Running setup.py install for moztest 20:12:01 INFO - Running setup.py install for mozversion 20:12:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:12:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:12:01 INFO - Cleaning up... 20:12:01 INFO - Return code: 0 20:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:02 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:12:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:12:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:12:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:02 INFO - 'HOME': '/Users/cltbld', 20:12:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:02 INFO - 'LOGNAME': 'cltbld', 20:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:02 INFO - 'MOZ_NO_REMOTE': '1', 20:12:02 INFO - 'NO_EM_RESTART': '1', 20:12:02 INFO - 'PAGER': '/bin/cat', 20:12:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:02 INFO - 'PWD': '/builds/slave/test', 20:12:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:02 INFO - 'SHELL': '/bin/bash', 20:12:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:12:02 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:12:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:02 INFO - 'USER': 'cltbld', 20:12:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:02 INFO - 'XPC_FLAGS': '0x0', 20:12:02 INFO - 'XPC_SERVICE_NAME': '0', 20:12:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:02 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-qQhfty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:02 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-jskktK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:02 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)) 20:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:02 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-xj2LaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:02 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-zBSPQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-JPQ3La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Npy65H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-RfAn5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-LUF0I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-VbQsD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-PrhQYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-zHW1fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-W37odz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:03 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-82EPpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:04 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-IHpO_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:04 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-h3LLnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:04 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-j9HtVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:04 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-J_xHC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:12:04 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)) 20:12:04 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)) 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:12:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:07 INFO - Downloading blessings-1.6.tar.gz 20:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:12:07 INFO - Installing collected packages: blessings 20:12:07 INFO - Running setup.py install for blessings 20:12:07 INFO - Successfully installed blessings 20:12:07 INFO - Cleaning up... 20:12:07 INFO - Return code: 0 20:12:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:07 INFO - Reading from file tmpfile_stdout 20:12:07 INFO - Current package versions: 20:12:07 INFO - blessings == 1.6 20:12:07 INFO - blobuploader == 1.2.4 20:12:07 INFO - docopt == 0.6.1 20:12:07 INFO - manifestparser == 1.1 20:12:07 INFO - mozInstall == 1.12 20:12:07 INFO - mozcrash == 0.16 20:12:07 INFO - mozdebug == 0.1 20:12:07 INFO - mozdevice == 0.48 20:12:07 INFO - mozfile == 1.2 20:12:07 INFO - mozhttpd == 0.7 20:12:07 INFO - mozinfo == 0.9 20:12:07 INFO - mozleak == 0.1 20:12:07 INFO - mozlog == 3.1 20:12:07 INFO - moznetwork == 0.27 20:12:07 INFO - mozprocess == 0.22 20:12:07 INFO - mozprofile == 0.28 20:12:07 INFO - mozrunner == 6.11 20:12:07 INFO - mozscreenshot == 0.1 20:12:07 INFO - mozsystemmonitor == 0.0 20:12:07 INFO - moztest == 0.7 20:12:07 INFO - mozversion == 1.4 20:12:07 INFO - psutil == 3.1.1 20:12:07 INFO - requests == 1.2.3 20:12:07 INFO - wsgiref == 0.1.2 20:12:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:07 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:07 INFO - 'HOME': '/Users/cltbld', 20:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:07 INFO - 'LOGNAME': 'cltbld', 20:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:07 INFO - 'MOZ_NO_REMOTE': '1', 20:12:07 INFO - 'NO_EM_RESTART': '1', 20:12:07 INFO - 'PAGER': '/bin/cat', 20:12:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:07 INFO - 'PWD': '/builds/slave/test', 20:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:07 INFO - 'SHELL': '/bin/bash', 20:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:12:07 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:07 INFO - 'USER': 'cltbld', 20:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:07 INFO - 'XPC_FLAGS': '0x0', 20:12:07 INFO - 'XPC_SERVICE_NAME': '0', 20:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:12:08 INFO - Cleaning up... 20:12:08 INFO - Return code: 0 20:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:08 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 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:12:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:12:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:08 INFO - 'HOME': '/Users/cltbld', 20:12:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:08 INFO - 'LOGNAME': 'cltbld', 20:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:08 INFO - 'MOZ_NO_REMOTE': '1', 20:12:08 INFO - 'NO_EM_RESTART': '1', 20:12:08 INFO - 'PAGER': '/bin/cat', 20:12:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:08 INFO - 'PWD': '/builds/slave/test', 20:12:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:08 INFO - 'SHELL': '/bin/bash', 20:12:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:12:08 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:12:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:08 INFO - 'USER': 'cltbld', 20:12:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:08 INFO - 'XPC_FLAGS': '0x0', 20:12:08 INFO - 'XPC_SERVICE_NAME': '0', 20:12:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:08 INFO - Downloading/unpacking jsonschema 20:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:12:10 INFO - Downloading/unpacking functools32 (from jsonschema) 20:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:12:11 INFO - warning: no files found matching '*.txt' 20:12:11 INFO - no previously-included directories found matching 'build' 20:12:11 INFO - no previously-included directories found matching 'dist' 20:12:11 INFO - no previously-included directories found matching '.git*' 20:12:11 INFO - Installing collected packages: jsonschema, functools32 20:12:11 INFO - Running setup.py install for functools32 20:12:11 INFO - warning: no files found matching '*.txt' 20:12:11 INFO - no previously-included directories found matching 'build' 20:12:11 INFO - no previously-included directories found matching 'dist' 20:12:11 INFO - no previously-included directories found matching '.git*' 20:12:11 INFO - Successfully installed jsonschema functools32 20:12:11 INFO - Cleaning up... 20:12:11 INFO - Return code: 0 20:12:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:12:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104571a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac12d696b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, '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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:12:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:12:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:11 INFO - 'HOME': '/Users/cltbld', 20:12:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:11 INFO - 'LOGNAME': 'cltbld', 20:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:11 INFO - 'MOZ_NO_REMOTE': '1', 20:12:11 INFO - 'NO_EM_RESTART': '1', 20:12:11 INFO - 'PAGER': '/bin/cat', 20:12:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:11 INFO - 'PWD': '/builds/slave/test', 20:12:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:11 INFO - 'SHELL': '/bin/bash', 20:12:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:12:11 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:12:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:11 INFO - 'USER': 'cltbld', 20:12:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:11 INFO - 'XPC_FLAGS': '0x0', 20:12:11 INFO - 'XPC_SERVICE_NAME': '0', 20:12:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:11 INFO - Downloading/unpacking flake8 20:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:12:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:12:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:15 INFO - no previously-included directories found matching 'docs/_build' 20:12:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:12:15 INFO - Running setup.py install for pep8 20:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:12:15 INFO - no previously-included directories found matching 'docs/_build' 20:12:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:12:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:12:15 INFO - Cleaning up... 20:12:15 INFO - Return code: 0 20:12:15 INFO - Running post-action listener: _resource_record_post_action 20:12:15 INFO - Running post-action listener: _start_resource_monitoring 20:12:15 INFO - Starting resource monitoring. 20:12:15 INFO - ##### 20:12:15 INFO - ##### Running install step. 20:12:15 INFO - ##### 20:12:15 INFO - Running pre-action listener: _resource_record_pre_action 20:12:15 INFO - Running main action method: install 20:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:15 INFO - Reading from file tmpfile_stdout 20:12:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:12:15 INFO - Reading from file tmpfile_stdout 20:12:15 INFO - Output received: 20:12:15 INFO - Usage: mozinstall [options] installer 20:12:15 INFO - Options: 20:12:15 INFO - -h, --help show this help message and exit 20:12:15 INFO - -d DEST, --destination=DEST 20:12:15 INFO - Directory to install application into. [default: 20:12:15 INFO - "/builds/slave/test"] 20:12:15 INFO - --app=APP Application being installed. [default: firefox] 20:12:15 INFO - mkdir: /builds/slave/test/build/application 20:12:15 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'] 20:12:15 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 20:12:49 INFO - Reading from file tmpfile_stdout 20:12:49 INFO - Output received: 20:12:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:12:49 INFO - Running post-action listener: _resource_record_post_action 20:12:49 INFO - ##### 20:12:49 INFO - ##### Running run-tests step. 20:12:49 INFO - ##### 20:12:49 INFO - Running pre-action listener: _resource_record_pre_action 20:12:49 INFO - Running main action method: run_tests 20:12:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:12:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:12:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:12:49 INFO - 2016-02-10 20:12:49.339 screenresolution[1943:12017] starting screenresolution argv=screenresolution get 20:12:49 INFO - 2016-02-10 20:12:49.341 screenresolution[1943:12017] Display 0: 1600x1200x32@60 20:12:49 INFO - 2016-02-10 20:12:49.347 screenresolution[1944:12019] starting screenresolution argv=screenresolution list 20:12:49 INFO - Available Modes on Display 0 20:12:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:12:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:12:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:12:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:12:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:12:49 INFO - Intel Iris: 20:12:49 INFO - Chipset Model: Intel Iris 20:12:49 INFO - Type: GPU 20:12:49 INFO - Bus: Built-In 20:12:49 INFO - VRAM (Dynamic, Max): 1536 MB 20:12:49 INFO - Vendor: Intel (0x8086) 20:12:49 INFO - Device ID: 0x0a2e 20:12:49 INFO - Revision ID: 0x0009 20:12:49 INFO - Displays: 20:12:49 INFO - Display: 20:12:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:12:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:12:49 INFO - Display Serial Number: 1600x1200 60 20:12:49 INFO - Main Display: Yes 20:12:49 INFO - Mirror: Off 20:12:49 INFO - Online: Yes 20:12:49 INFO - Rotation: Supported 20:12:49 INFO - Return code: 0 20:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:12:49 INFO - Python 2.7.3 20:12:49 INFO - Return code: 0 20:12:49 INFO - grabbing minidump binary from tooltool 20:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:49 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 0x104415d30>, '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 0x104239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10440cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:12:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:12:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:12:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:12:49 INFO - Return code: 0 20:12:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:12:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:12:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:12:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:12:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:12:50 INFO - Return code: 0 20:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 20:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 20:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ALQ2mKDqsR/Render', 20:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:12:50 INFO - 'HOME': '/Users/cltbld', 20:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:12:50 INFO - 'LOGNAME': 'cltbld', 20:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:50 INFO - 'MOZ_NO_REMOTE': '1', 20:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:12:50 INFO - 'NO_EM_RESTART': '1', 20:12:50 INFO - 'PAGER': '/bin/cat', 20:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:50 INFO - 'PWD': '/builds/slave/test', 20:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:12:50 INFO - 'SHELL': '/bin/bash', 20:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EArWGcWIQd/Listeners', 20:12:50 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 20:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:12:50 INFO - 'USER': 'cltbld', 20:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:50 INFO - 'XPC_FLAGS': '0x0', 20:12:50 INFO - 'XPC_SERVICE_NAME': '0', 20:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:12:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 20:12:51 INFO - mozversion application_buildid: 20160210191531 20:12:51 INFO - mozversion application_changeset: 1b7bbed6b080ed5dedc8247a162b3269040d245f 20:12:51 INFO - mozversion application_display_name: Nightly 20:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:12:51 INFO - mozversion application_name: Firefox 20:12:51 INFO - mozversion application_remotingname: firefox 20:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:12:51 INFO - mozversion application_vendor: Mozilla 20:12:51 INFO - mozversion application_version: 47.0a1 20:12:51 INFO - mozversion platform_buildid: 20160210191531 20:12:51 INFO - mozversion platform_changeset: 1b7bbed6b080ed5dedc8247a162b3269040d245f 20:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:12:51 INFO - mozversion platform_version: 47.0a1 20:12:51 INFO - using testdate: 1455163971 20:12:51 INFO - actual date: 1455163971 20:12:51 INFO - starting webserver on 'localhost:49727' 20:12:51 INFO - SUITE-START | Running 2 tests 20:12:51 INFO - TEST-START | dromaeo_css 20:12:51 INFO - operating with platform_type : mac_ 20:12:51 INFO - Initialising browser for dromaeo_css test... 20:12:51 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpN2NDEM/profile http://localhost:49727/getInfo.html) 20:12:54 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 20:12:54 INFO - PROCESS | 1962 | colorDepth:24 20:12:54 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 20:12:54 INFO - PROCESS | 1962 | __metrics 20:12:55 INFO - TEST-INFO | 1962: exit 0 20:12:55 INFO - Browser initialized. 20:12:55 INFO - Running cycle 1/1 for dromaeo_css test... 20:12:55 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpN2NDEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:07 INFO - PROCESS | 1967 | RSS: Main: 258781184 20:13:07 INFO - PROCESS | 1967 | 20:13:56 INFO - PROCESS | 1967 | 1455164036814 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:16:07 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49727/tests/dromaeo/cssquery-ext.html) 20:16:08 INFO - PROCESS | 1967 | RSS: Main: 271081472 20:16:08 INFO - PROCESS | 1967 | 20:19:10 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-ext.html (next: http://localhost:49727/tests/dromaeo/cssquery-jquery.html) 20:19:11 INFO - PROCESS | 1967 | RSS: Main: 283287552 20:19:11 INFO - PROCESS | 1967 | 20:22:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49727/tests/dromaeo/cssquery-mootools.html) 20:22:13 INFO - PROCESS | 1967 | RSS: Main: 284708864 20:22:13 INFO - PROCESS | 1967 | 20:25:15 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49727/tests/dromaeo/cssquery-prototype.html) 20:25:16 INFO - PROCESS | 1967 | RSS: Main: 286683136 20:25:16 INFO - PROCESS | 1967 | 20:28:18 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49727/tests/dromaeo/cssquery-yui.html) 20:28:19 INFO - PROCESS | 1967 | RSS: Main: 288182272 20:28:19 INFO - PROCESS | 1967 | 20:31:21 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-yui.html (next: http://localhost:49727/tests/dromaeo/cssquery-dojo.html) 20:31:22 INFO - PROCESS | 1967 | RSS: Main: 291557376 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | __start_tp_report 20:31:22 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 20:31:22 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 20:31:22 INFO - PROCESS | 1967 | |i|pagename|runs| 20:31:22 INFO - PROCESS | 1967 | |0;dojo.html;3464.3937310970573;3520.1903562180696;3540.5397298351195;3590.8025058621784;3592.2815436912624;5716.685582292977;5729.255196824417;5749.338826035002;5751.511121554662;5824.039033559463;5715.2855893013375;5853.239078919734;5867.354590994998;5897.380775018615;6036.849078773022;5213.113770658997;5279.762410691509;5301.231321458386;5313.282706834567;5336.119540275849;5269.973650131744;5333.066713325153;5346.198070289449;5347.679139251638;5410.269613602172;5199;5299.788008479656;5314.867128321785;5339.813106541272;5356;5168.948310516885;5296.867578310535;5308.362996440414;5328.120860058086;5336.706481143536;5246.475352464761;5255.86860328491;5289.338832645919;5298;5319.20211968204;5618.325800903876;5658.349289831681;5749.425057494259;5769.798057067983;5808.796692115798;6188.440253331438;6284.654344011077;6287;6288.528360372945;6297.685115744194;6293.213348331458;6302.432781049728;6306;6308.779192728279;6318.74725010999;5785.913211301834;5828.766849326022;5912.793052243151;5918.260217472816;5980.521558275371;6318.557700960889;6371.52213583983;6373.426391624776;6380.744770209232;6396.1684980953105;6101.15649972706;6195.287541932646;6285.779997700059;6305.432511074026;6315.494760419156;5213.218017297359;6291.748330066837;6294.496440284766;6296.401841825019;6310.242770867525;6228.5017198624;6259.342769009279;6263.71813268404;6300.558960872695;6319.905201421982;6161.784337548254;6194.59735117225;6204.410580994799;6287.465565426898;6311.684415779193;4892.559669629751;4943.72809495474;4946.777395017233;4965.652404331734;4975.5522003019905;4370.650347972155;4532.4334458192725;4540.182767101954;4547.47704014036;4573.314002899591;5762.711864406763;5785.652860828363;5786.103154011135;5812.360640329561;5880.14737863016;6234.594751341148;6252;6262.405071518198;6274.686265686697;6275.1842260506755;5653.265075540154;5789.1026890831145;5798.652080875161;5842.561807864342;5861.824145275648;5466.098093814476;5486.067368547357;5488.012157811632;5491.670499770026;5493.587980901449;6430.099786029959;6454.838629034218;6469.708863101077;6474.417302442803;6485.254195767453;6191.628502289877;6213.596116252429;6268.2478102626155;6271.592346497463;6290.182276304235;5432.456754324536;6409.935900640934;6432.2281326241155;6453.903191452038;6469.611823290617;5257.316548848626;6175.62946223228;6241.937580624136;6291.02489114188;6301.086342480223;5230.293910322058;6212.751489940532;6265.154204182377;6283.057541368831;6296.748130074929;5323.1216849219445;5489.505944465017;5531.197976293495;5850.297964244318;6101.7559297627595;6121.84695382619;6143.204841797061;6246;6252.562320637512;6254.906176407267;6066.393360663898;6082.22412946318;6088.726007329769;6121.785737499166;6127.2034635498885;6139.0495723773565;6142;6190.473809726043;6202.34875338083;6205.2553693557065;5985.551083668655;6119.112728654409;6171.7531298749345;6193.318734939243;6219.875602488016 20:31:22 INFO - PROCESS | 1967 | |1;ext.html;444.3800897747642;462.9930551041735;464.7304563353255;472.1100725133123;548.5940404100966;37704.05739856505;37992.43011354828;38082;38135.80932095343;38368.61631383685;38857.222855542874;39397.60602393975;39466.80266598663;39470.21059578807;39560.802195989054;9330.580123894424;9552.379095358814;9591.136797688207;9602.183814375787;9612.855807162898;9270.582823772946;9535.380200286994;9553;9560.665376711817;9568.856467152964;8167.183281671844;9462.432254064744;9494.715158545254;9539.807524059492;9629.133377995979;9558.713238602853;9564.043595640414;9606.615735370577;9613.807723845519;9613.90386096137;9543;9546.045395460467;9605.759856003586;9685.225181985425;9692.51537423126;38391.23217535634;38439.615603843886;38451.615483845366;38818.22363552713;38995.41506877399;2820.3795165063652;3227.2415982244156;3301.2572171261513;3322.2026713588807;3465.4108801503803;26729;27370.45259094807;27475.17574472769;28086.859565702245;28634.713652863415;2455.7667021632915;2799.664040315155;2841.105051908663;2849.244950088228;2870.641169853768;428582.8570857157;456888;489239;489442;490115;58006;58973.82052358929;67410.66294668496;67727;68721.65639171773;54834.72582637141;64675.35324646787;64882;65275.67362163254;65453;15966.121863297398;16095.919520402324;16181.19094045293;16335.428260010842;16347.59131021734;12281.447334869952;12383.318917459626;12421.627351179479;12515.687107822378;12530.624081277576;21101.577968440546;21284.467888302916;21387;21397;21412;7429.62851857405;8944.195022448012;8977.596008179517;8980.775480612907;8984.460932343949;943.9008904065112;977;984.7685793838442;985.8422652375585;1071.5606601293432;29515.262118447212;29608.851955740083;29846.552301715492;30011;30073;1058.8941105889503;1066.7226521104415;1114.7491814341709;1142.8857114288505;1171.5196769324536;15056.548303550911;15155.166465844264;15166.772498412533;15368.769468457982;15401.22993850303;537790;540001;540256;543372;547482;57745.711271443375;57760.71119644459;58315;58493;58541.707291464125;1418.1491105336715;1439.8344190418236;1447.370393878645;1468.5007097586872;1473.1823837769925;29095.563566546094;29201.123966281044;29442.17659916382;29852;29854.70145298606;50463.24305135352;50809.983800324524;50867;50872.49127508677;50895;494899;505235.47382262856;505380.4730976322;507056;507367;33610.49584256287;43270;44239.336409953234;44889.77555112204;44912.550874492146;43576.56423435725;43923.78038109789;45532.31701524414;46108.077838443714;46205.306920395546;36996.44505332476;37591.43612845755;37936.62063379441;38053;38525.8442246733;28811.711882880903;36977.81511092535;37251.6274837259;37324.62675373212;37780.811095944344;36906.5712114548;37301;37380;37658;37673.434898476;30924.845375772977;33058.00825975225;33341.66658333482;33393.99818005464;33443;24750;24763.88562514655;25156.874215628806;25223.11719089823;25297.62053569161 20:31:22 INFO - PROCESS | 1967 | |2;jquery.html;316.9556262123303;365.5394203303838;368.58718235576157;369.8243334416152;372.82290911816875;15293.617659558517;18643.1610577524;19234.80765192348;19571.315003974847;20753.896230518843;9586.376885502437;11881.346525941091;12090.939545302283;12108.515659373614;19487.123079461424;4356.803943822528;5244.816431424901;5777.537796976232;5813.912791308134;5818.621789583684;5692.800751973682;5723.112917497794;5732.197492351074;5742.827715168552;5859.355470898197;3852.5569559500595;5673.687947162925;5773.249477567911;5804.59367844251;5820.883582328372;5843.590948633598;5851.502622277111;5879.911801322962;5889.293284805829;5893.086571581412;4546.568076032771;5565.165225216209;5574.9721251393485;5629;5646.322441307028;12785;15125.470608528649;23206.7679323208;23356.883215583814;23525.88237058804;1943.1255934829383;2107.420459373669;2128.074287684862;2184.322859913432;2234.3743751749535;10053.447060411674;10075.697729068139;12627.43176557057;14530.346134423977;14877.776833347509;1774.2459454731816;1808.5117018404958;1815.5914919143088;1816.8546516278666;1842.3551756884983;93634.06365936322;101673;102685;102794;104785.47607261992;10809.135269178447;11088.55645774176;11156.609518666808;11204.66386008421;11336.036436902956;13157.407916643773;13301.534446294334;13367.799483007762;13450.596482105553;13454.52909148175;8266.628001739937;8339.666413343399;8416.368772342099;8427.157284271523;8457.492550446992;8490.702825401082;8549.401541892132;8553.700620478254;8607.22534971843;8627.396082274307;4448.110377924428;4451.955480445219;4475.6643251755595;4502.729836209838;4508.278675411918;1862.2085613614431;1915.1286164794985;1929.6237233739287;1931.169597073272;1954.1792447172222;396.942443345719;411.38087178795723;419.1093925408446;441.3313829548237;457.83060267701165;9889.606249003591;11808.468618911998;11960.76078478443;11987;12035.699107522207;444.3334997503744;466.37039996005797;472.68094036525207;472.75416783272505;474.29567092867063;6167.597322485842;6167.691615419211;6202.627842329474;6252.874942501125;6280.371962803683;730698;736334;740450;741013;754584;106522.46738766412;116985;117672;118494.63010739909;121476;490.93863267091615;495.67285591510154;496.2184559319087;497.1796535716025;498.61357447977383;9222.44665320083;11140.888591113986;11184.384858832842;11229.71925701864;11236.04493618019;48229.381082755506;48684.513154868;48849.26726099182;49280.014399711086;49459.7635059112;70732;70964.64517677379;71072.15711371487;71342;71974;7084.681189346388;7178.461615378972;7323;7324.681557319734;7360.742374016883;10302.896971030194;11370.94314528422;11418.82871756941;11818.290902545874;12223.388830558615;7895.171007044178;9561.665341713007;9933.453660048477;10362.326448780805;10553.63062292816;10053.597856085675;10242.334248273839;10392.688219353431;10419.687409377731;10614.310069845435;10181.541830617492;10403.167746580406;10468.682872243557;10812.891871081189;10867.891321087005;7492.7752167435065;7624.885626715714;7650.273224043707;7652.349550288288;7696.8460630788195;9353.625854965725;10559.841602375816;10584.206184536344;10621.681349559525;10757.408342540923 20:31:22 INFO - PROCESS | 1967 | |3;mootools.html;1363.4478036395258;1414.370605080739;1702.7956645202578;1774.290283886446;1784.464660601819;7467.141278752945;7807.687692492308;8475.57622118894;8675.652973881046;8693.565321733911;7662.425318101137;8522.957385213065;8528.976522817271;8572.442791218566;8581.613827377767;2436.317831007321;2453.950920981579;2466.654668346424;2476.616124500705;2478.50429914017;2392.9760702393014;2486.105002199207;2488.6515887775727;2496.163785131983;2502.637117617944;2155.913763449468;2405.386626410263;2456.066694656028;2473.764992325735;2477.838940468873;2444.841085329448;2449.1672831237374;2460.200434858678;2460.3480077779404;2483.2177863972793;2441.829071964963;2442.1818690738623;2444.792192663608;2446.376174075617;2449.0326321103244;8414.621342039623;8510.957445212796;8588.656453741844;8595.570221488962;8643.049264580892;5290.1800220965815;5417.674939503642;5448.673079615236;5454.8909021819345;5458.808941687022;3539.5752509699;3609.747317687763;3638.6725194732335;3704.9073773155887;3705.962940370589;1051.2063392138962;1067.487605949141;1074.6883403812885;1084.2735367303926;1100.0924237504091;11789.115816313812;11828.290302581787;11838.881611183864;11885.643430697006;11899.702507437296;4770.928436073462;4875.609951203895;4928.48250933654;4931.630127740434;4947.158982972904;9803.264755143393;9895.554700038516;9912;9953.303268771117;9996;5299.284596579412;5379.435159308295;5406.270153529302;5446.455354464521;5449.918251226235;4901.4805410322915;4928.260760885896;4943.826966056171;4949.1586430306215;4973.303737476684;3367.5285460035616;3926.09699769049;3932.0563064864227;3940.763554186758;3945.11234972129;1238.3003602964297;1323.6293837725452;1329.222404893129;1347.8921686265076;1358.0832937767166;1083.6965649618119;1085.3813326404031;1115.1859142825783;1219.9085068619888;1303.2050449225965;7773.68905243784;7776;7820.335271501986;7875.251851074253;7909.406794490436;1037.725002874239;1174.6358628825092;1178.281248438452;1183.3136780667364;1189.3815216087587;5965.3139888912465;6071.180390647294;6114.9694251529345;6130.2030736004035;6148.723307451175;9984.500774961223;10357.689269321932;10604.522796474177;10607.893921060844;10630.521626526825;10278.640247591298;10296.124829389437;10387.961203879551;10394.740131496774;10403.47982600867;7962.522248665098;8020.558869262247;8036.839263214703;8100.149484304181;8146.022477302643;7619;7619.771406857803;7663;7673.616319183907;7702.730404435818;9099.49952752605;9346.392484488486;9349.205317547812;9404.482753448627;9475.384100033476;8250.504969701837;9521.238300936047;9799.657012004545;9828.950855245677;9880.35777674449;7203.747868824566;7250.782476525713;7255.673494692857;7283.053203083565;7332.9266707332245;7891.84216315659;7960.721374751856;8062.9518162640825;8068.87896681562;8076.676932922617;6769.932300677127;7581.6209189541405;7668.80827979305;7681.7695469136015;7748;7365.852682946418;7430.665620047002;7509.061367329084;7554.395648348009;7568.243175682388;7523;7555.055618047744;7626.542407455348;7629.923700762922;7632.69469221225;6793.456523478011;6817.761378351734;6869.965650171717;6896.379325860697;6954.826129346807;5853.385394533512;6556.442702370352;7028.753993610199;7084.752033678797;7090.964545177241 20:31:22 INFO - PROCESS | 1967 | |4;prototype.html;324.5261917600304;329.7329163377664;333.85477317366934;335.7632868827476;340.9863605455782;4944.480829512903;5432.72836358182;6814.080099186608;6819.283975182597;6822.7612033578835;6647.235567909692;6736.259011508742;6746.257911629717;6761.763338283161;6776.559523630973;5076.086304465195;5083.440821509631;5093.745312734367;5093.847184584469;5107.7701503432245;4971.328870602477;5081.568066714333;5087.465816089313;5107.923381149286;5122.436531981479;4685.617742765892;4815.590674792629;4983.676061056038;5014.473480284572;5026.170681837492;4435.889102772424;4677.812887484513;5004.299398084271;5023.397192336943;5026.673266237683;3535.8232088395475;4328.04782947751;4328.956710432887;4330.415393921843;4353.782310884443;6385.47962112231;6404.519661025395;6518.57629254097;6571.57284776488;6576.210854697467;5963.463288304073;5973.671448070354;5979.970100149515;5982.102684597302;5994.010988186944;7255.927440725578;7273.927260727378;7279.344858962719;7290.708371665127;7303.269673032707;4817.78319975602;4841.467438581753;4846.200376937801;4848.951510484885;4862.5380588844;6689.33106689332;7246.130464344313;7429.777106686808;7636.42726795487;7671.424643151786;4636.5131661175765;4707.340972263886;4732.1718699227495;4735.739534325577;4741.122892264942;4002.3396139636634;4803;4830.106430310404;4833.685810422311;4850.490698476609;4637.373954516097;5642.153676948491;5774.902768473977;5851.912221316684;5864.853378665567;6326.46225070865;6435.324290949477;7234.74678386254;7366.079240094989;7373.262673732584;1338.7389459055585;1712.9914350428169;1759.366628013914;1761.1282415204555;1764.4353806781962;1009.4599389326675;1116.4864162485185;1137.7951968645723;1154.7459558897028;1155.0124643429915;5174.793008279702;6346.11154438379;6731.596104233761;6733.730650774012;6749.122614060141;7567.886481702779;7572.2049184835905;7578.772636820904;7594.392448604099;7598.848023039619;6471.320511346335;6692.6988285526295;6712.563683360566;6717.328267173243;6730.226024007204;4004.5194576650406;4018.6383225509844;4028.67770578353;4029.738067025634;4035.8183881725395;6940.75066488037;7440.4419668524;7876.409269304825;7904.841903161904;7926.564038977912;6198.752049918043;6572.80281591553;7811.960940195263;7842.764717058383;7881.684732610746;6469.218236158403;8054.154313797084;8058.919410805817;8072.273495385443;8088.312493438006;6030.216071910623;7311.524750891175;7661.6552255147535;7727.536347819148;7742.883856742266;7374.483786134919;7585.469017168745;7586.658600363107;7589.924100759143;7590.39276857839;8020.358371330396;8039.638216280398;8042.638081286474;8042.798930026796;8054.275115239657;3992.2813893499447;4327.978360108179;4751.714897106046;4773.546513081252;4797.976010119927;6331.366863313632;7284.198738138906;7419.258074192538;7437.219091995263;7570.583617900848;7325.816854578678;7346.228645992094;7388.778336649909;7408.333250007525;7418.146913105062;7359.852802944019;7363.484556081023;7363.668634911334;7364.96317518409;7374.004509391163;6730.798076057726;6951;7166.068411106523;7169.354758071799;7176.892346614909;5609.467100625434;7063.6821343038655;7326.3406293433845;7368.59472729005;7370.705171793068;5847.970760146172;7043.2604576518725;7220.494565380373;7224.2414546473965;7226.096737907762 20:31:22 INFO - PROCESS | 1967 | |5;yui.html;671.0303611281694;684.9349311815376;707.9150501939765;728.8214387475066;735.2720806401662;14521.564353069412;14521.92739036306;14878.47925322614;14879.553613391601;14885;13563.254021028839;13623.04638675293;13624.318784060782;13649.249291288976;13692.17846929185;705.8623568404163;865.0657290126649;866.8093019535708;884.1777147253052;889.550776857686;866.6360128745911;880.6609455359669;892.8214357128568;892.830362231174;894.1505569708803;929.2148134826061;936.1434287626813;937.4843835890233;938.9342746007748;942.8114377124602;908.9636414543444;921.6221349246811;936.1106948399048;937.4656445825882;938.8357037518407;668.348360348661;669.8559809640902;692.7471472912401;693.7953303775398;695.7738734911175;10680;14267.357968891425;14396.424143034266;14428;14525.837932965338;12742.36288185587;12873.742525149444;12893.033022523254;13151.342432878319;13330.533431329857;9943.651972180938;10133.290669653128;10136.594536218543;10194.796104077952;10194.898051019543;3494;3557.484164796116;3564.821758912044;3564.8395822187804;3569.7322700797545;58237.126443103385;60458.697706511186;76639.85040224402;78568.21431785666;78713.60643196804;9568.856467152998;9578.233741300679;9846.458444785605;9924;10189.337693050076;21296.361109166748;21455.67816482754;21473;21530.892345538174;21663;7335.816604584821;7478.700851965969;7483.139438964588;7705.653245603961;7852.214778522216;4059.4113853491667;4100.979495102505;4143.129942712064;4334.13317336534;4350.71720338177;3455.4644030175364;3455.652295604716;3475.1138459692615;3495.7727747696317;3501.5447991760907;559.8271620954094;561.332014902265;570.6690119730546;573.5125143627882;582.7465052702088;520.2560338715673;520.9166533354645;591.3672370563456;594.1859652276408;632.3234139470723;8280.544570048705;8450.830983380298;8523.190296921906;8656.697015604424;8755.91244087551;506.09914352452694;515.2271592611083;531.6278604976532;547.4361407750024;551.892380985712;4049.331860243086;4093.5906409358827;4149;4196.097838964637;4199.181159673834;87328;88404.55797721099;88537;89070;93661.5316923411;76020;76907;77406;77413.6129319361;78109.82835257475;65776.67111664411;67201.65596688137;68371.97442038274;68458.65770671115;68809.65595171992;8832;8838.758319727096;8911.2425443838;9014.459132452073;9122.498262595622;48876.26685599648;48956;49074.018519630125;49382.25926611032;49600.50399496103;64471.71056578936;65227;65753.34246657472;66392.67214655776;68787.96818047833;10100.797984040424;10128.898711012796;10145.695629130843;10252.128569071712;10481.685549433529;11546.364949927834;11933.164678472423;12193.51225950952;12335.876641233473;12634.431450584929;11617.244879083171;11643.243189192675;11653.242539234923;11674.94162529182;11906.285622862655;10306.381617102697;11492.253003554742;11670;11690.88309116898;11918.642440726791;11225.214235003472;11254.790702304645;11408.82886756716;11451.370174640475;11505.022073123879;8973.955130224307;9677.806443871224;9711.66009189675;9717.319787614799;9804.1666458349;9068.591913363782;9369.437833729726;9413.717588472357;9511.57197926081;9994.850077248702 20:31:22 INFO - PROCESS | 1967 | __end_tp_report 20:31:22 INFO - PROCESS | 1967 | __start_cc_report 20:31:22 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,367 20:31:22 INFO - PROCESS | 1967 | __end_cc_report 20:31:22 INFO - PROCESS | 1967 | __startTimestamp1455165082101__endTimestamp 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | ------- Summary: start ------- 20:31:22 INFO - PROCESS | 1967 | Number of tests: 6 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5793.35 Median:5985.55 stddev:626.66 (10.5%) stddev-sans-first:601.36 20:31:22 INFO - PROCESS | 1967 | Values: 3464.4 3520.2 3540.5 3590.8 3592.3 5716.7 5729.3 5749.3 5751.5 5824.0 5715.3 5853.2 5867.4 5897.4 6036.8 5213.1 5279.8 5301.2 5313.3 5336.1 5270.0 5333.1 5346.2 5347.7 5410.3 5199.0 5299.8 5314.9 5339.8 5356.0 5168.9 5296.9 5308.4 5328.1 5336.7 5246.5 5255.9 5289.3 5298.0 5319.2 5618.3 5658.3 5749.4 5769.8 5808.8 6188.4 6284.7 6287.0 6288.5 6297.7 6293.2 6302.4 6306.0 6308.8 6318.7 5785.9 5828.8 5912.8 5918.3 5980.5 6318.6 6371.5 6373.4 6380.7 6396.2 6101.2 6195.3 6285.8 6305.4 6315.5 5213.2 6291.7 6294.5 6296.4 6310.2 6228.5 6259.3 6263.7 6300.6 6319.9 6161.8 6194.6 6204.4 6287.5 6311.7 4892.6 4943.7 4946.8 4965.7 4975.6 4370.7 4532.4 4540.2 4547.5 4573.3 5762.7 5785.7 5786.1 5812.4 5880.1 6234.6 6252.0 6262.4 6274.7 6275.2 5653.3 5789.1 5798.7 5842.6 5861.8 5466.1 5486.1 5488.0 5491.7 5493.6 6430.1 6454.8 6469.7 6474.4 6485.3 6191.6 6213.6 6268.2 6271.6 6290.2 5432.5 6409.9 6432.2 6453.9 6469.6 5257.3 6175.6 6241.9 6291.0 6301.1 5230.3 6212.8 6265.2 6283.1 6296.7 5323.1 5489.5 5531.2 5850.3 6101.8 6121.8 6143.2 6246.0 6252.6 6254.9 6066.4 6082.2 6088.7 6121.8 6127.2 6139.0 6142.0 6190.5 6202.3 6205.3 5985.6 6119.1 6171.8 6193.3 6219.9 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:65084.81 Median:38837.72 stddev:134722.64 (346.9%) stddev-sans-first:135013.15 20:31:22 INFO - PROCESS | 1967 | Values: 444.4 463.0 464.7 472.1 548.6 37704.1 37992.4 38082.0 38135.8 38368.6 38857.2 39397.6 39466.8 39470.2 39560.8 9330.6 9552.4 9591.1 9602.2 9612.9 9270.6 9535.4 9553.0 9560.7 9568.9 8167.2 9462.4 9494.7 9539.8 9629.1 9558.7 9564.0 9606.6 9613.8 9613.9 9543.0 9546.0 9605.8 9685.2 9692.5 38391.2 38439.6 38451.6 38818.2 38995.4 2820.4 3227.2 3301.3 3322.2 3465.4 26729.0 27370.5 27475.2 28086.9 28634.7 2455.8 2799.7 2841.1 2849.2 2870.6 428582.9 456888.0 489239.0 489442.0 490115.0 58006.0 58973.8 67410.7 67727.0 68721.7 54834.7 64675.4 64882.0 65275.7 65453.0 15966.1 16095.9 16181.2 16335.4 16347.6 12281.4 12383.3 12421.6 12515.7 12530.6 21101.6 21284.5 21387.0 21397.0 21412.0 7429.6 8944.2 8977.6 8980.8 8984.5 943.9 977.0 984.8 985.8 1071.6 29515.3 29608.9 29846.6 30011.0 30073.0 1058.9 1066.7 1114.7 1142.9 1171.5 15056.5 15155.2 15166.8 15368.8 15401.2 537790.0 540001.0 540256.0 543372.0 547482.0 57745.7 57760.7 58315.0 58493.0 58541.7 1418.1 1439.8 1447.4 1468.5 1473.2 29095.6 29201.1 29442.2 29852.0 29854.7 50463.2 50810.0 50867.0 50872.5 50895.0 494899.0 505235.5 505380.5 507056.0 507367.0 33610.5 43270.0 44239.3 44889.8 44912.6 43576.6 43923.8 45532.3 46108.1 46205.3 36996.4 37591.4 37936.6 38053.0 38525.8 28811.7 36977.8 37251.6 37324.6 37780.8 36906.6 37301.0 37380.0 37658.0 37673.4 30924.8 33058.0 33341.7 33394.0 33443.0 24750.0 24763.9 25156.9 25223.1 25297.6 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:36636.48 Median:2387.96 stddev:122152.07 (5115.3%) stddev-sans-first:122464.29 20:31:22 INFO - PROCESS | 1967 | Values: 317.0 365.5 368.6 369.8 372.8 15293.6 18643.2 19234.8 19571.3 20753.9 9586.4 11881.3 12090.9 12108.5 19487.1 4356.8 5244.8 5777.5 5813.9 5818.6 5692.8 5723.1 5732.2 5742.8 5859.4 3852.6 5673.7 5773.2 5804.6 5820.9 5843.6 5851.5 5879.9 5889.3 5893.1 4546.6 5565.2 5575.0 5629.0 5646.3 12785.0 15125.5 23206.8 23356.9 23525.9 1943.1 2107.4 2128.1 2184.3 2234.4 10053.4 10075.7 12627.4 14530.3 14877.8 1774.2 1808.5 1815.6 1816.9 1842.4 93634.1 101673.0 102685.0 102794.0 104785.5 10809.1 11088.6 11156.6 11204.7 11336.0 13157.4 13301.5 13367.8 13450.6 13454.5 8266.6 8339.7 8416.4 8427.2 8457.5 8490.7 8549.4 8553.7 8607.2 8627.4 4448.1 4452.0 4475.7 4502.7 4508.3 1862.2 1915.1 1929.6 1931.2 1954.2 396.9 411.4 419.1 441.3 457.8 9889.6 11808.5 11960.8 11987.0 12035.7 444.3 466.4 472.7 472.8 474.3 6167.6 6167.7 6202.6 6252.9 6280.4 730698.0 736334.0 740450.0 741013.0 754584.0 106522.5 116985.0 117672.0 118494.6 121476.0 490.9 495.7 496.2 497.2 498.6 9222.4 11140.9 11184.4 11229.7 11236.0 48229.4 48684.5 48849.3 49280.0 49459.8 70732.0 70964.6 71072.2 71342.0 71974.0 7084.7 7178.5 7323.0 7324.7 7360.7 10302.9 11370.9 11418.8 11818.3 12223.4 7895.2 9561.7 9933.5 10362.3 10553.6 10053.6 10242.3 10392.7 10419.7 10614.3 10181.5 10403.2 10468.7 10812.9 10867.9 7492.8 7624.9 7650.3 7652.3 7696.8 9353.6 10559.8 10584.2 10621.7 10757.4 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5950.11 Median:5449.30 stddev:3093.68 (56.8%) stddev-sans-first:3083.14 20:31:22 INFO - PROCESS | 1967 | Values: 1363.4 1414.4 1702.8 1774.3 1784.5 7467.1 7807.7 8475.6 8675.7 8693.6 7662.4 8523.0 8529.0 8572.4 8581.6 2436.3 2454.0 2466.7 2476.6 2478.5 2393.0 2486.1 2488.7 2496.2 2502.6 2155.9 2405.4 2456.1 2473.8 2477.8 2444.8 2449.2 2460.2 2460.3 2483.2 2441.8 2442.2 2444.8 2446.4 2449.0 8414.6 8511.0 8588.7 8595.6 8643.0 5290.2 5417.7 5448.7 5454.9 5458.8 3539.6 3609.7 3638.7 3704.9 3706.0 1051.2 1067.5 1074.7 1084.3 1100.1 11789.1 11828.3 11838.9 11885.6 11899.7 4770.9 4875.6 4928.5 4931.6 4947.2 9803.3 9895.6 9912.0 9953.3 9996.0 5299.3 5379.4 5406.3 5446.5 5449.9 4901.5 4928.3 4943.8 4949.2 4973.3 3367.5 3926.1 3932.1 3940.8 3945.1 1238.3 1323.6 1329.2 1347.9 1358.1 1083.7 1085.4 1115.2 1219.9 1303.2 7773.7 7776.0 7820.3 7875.3 7909.4 1037.7 1174.6 1178.3 1183.3 1189.4 5965.3 6071.2 6115.0 6130.2 6148.7 9984.5 10357.7 10604.5 10607.9 10630.5 10278.6 10296.1 10388.0 10394.7 10403.5 7962.5 8020.6 8036.8 8100.1 8146.0 7619.0 7619.8 7663.0 7673.6 7702.7 9099.5 9346.4 9349.2 9404.5 9475.4 8250.5 9521.2 9799.7 9829.0 9880.4 7203.7 7250.8 7255.7 7283.1 7332.9 7891.8 7960.7 8063.0 8068.9 8076.7 6769.9 7581.6 7668.8 7681.8 7748.0 7365.9 7430.7 7509.1 7554.4 7568.2 7523.0 7555.1 7626.5 7629.9 7632.7 6793.5 6817.8 6870.0 6896.4 6954.8 5853.4 6556.4 7028.8 7084.8 7091.0 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:5872.33 Median:6545.07 stddev:1898.53 (29.0%) stddev-sans-first:1857.63 20:31:22 INFO - PROCESS | 1967 | Values: 324.5 329.7 333.9 335.8 341.0 4944.5 5432.7 6814.1 6819.3 6822.8 6647.2 6736.3 6746.3 6761.8 6776.6 5076.1 5083.4 5093.7 5093.8 5107.8 4971.3 5081.6 5087.5 5107.9 5122.4 4685.6 4815.6 4983.7 5014.5 5026.2 4435.9 4677.8 5004.3 5023.4 5026.7 3535.8 4328.0 4329.0 4330.4 4353.8 6385.5 6404.5 6518.6 6571.6 6576.2 5963.5 5973.7 5980.0 5982.1 5994.0 7255.9 7273.9 7279.3 7290.7 7303.3 4817.8 4841.5 4846.2 4849.0 4862.5 6689.3 7246.1 7429.8 7636.4 7671.4 4636.5 4707.3 4732.2 4735.7 4741.1 4002.3 4803.0 4830.1 4833.7 4850.5 4637.4 5642.2 5774.9 5851.9 5864.9 6326.5 6435.3 7234.7 7366.1 7373.3 1338.7 1713.0 1759.4 1761.1 1764.4 1009.5 1116.5 1137.8 1154.7 1155.0 5174.8 6346.1 6731.6 6733.7 6749.1 7567.9 7572.2 7578.8 7594.4 7598.8 6471.3 6692.7 6712.6 6717.3 6730.2 4004.5 4018.6 4028.7 4029.7 4035.8 6940.8 7440.4 7876.4 7904.8 7926.6 6198.8 6572.8 7812.0 7842.8 7881.7 6469.2 8054.2 8058.9 8072.3 8088.3 6030.2 7311.5 7661.7 7727.5 7742.9 7374.5 7585.5 7586.7 7589.9 7590.4 8020.4 8039.6 8042.6 8042.8 8054.3 3992.3 4328.0 4751.7 4773.5 4798.0 6331.4 7284.2 7419.3 7437.2 7570.6 7325.8 7346.2 7388.8 7408.3 7418.1 7359.9 7363.5 7363.7 7365.0 7374.0 6730.8 6951.0 7166.1 7169.4 7176.9 5609.5 7063.7 7326.3 7368.6 7370.7 5848.0 7043.3 7220.5 7224.2 7226.1 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:17764.51 Median:578.13 stddev:24539.13 (4244.6%) stddev-sans-first:24574.40 20:31:22 INFO - PROCESS | 1967 | Values: 671.0 684.9 707.9 728.8 735.3 14521.6 14521.9 14878.5 14879.6 14885.0 13563.3 13623.0 13624.3 13649.2 13692.2 705.9 865.1 866.8 884.2 889.6 866.6 880.7 892.8 892.8 894.2 929.2 936.1 937.5 938.9 942.8 909.0 921.6 936.1 937.5 938.8 668.3 669.9 692.7 693.8 695.8 10680.0 14267.4 14396.4 14428.0 14525.8 12742.4 12873.7 12893.0 13151.3 13330.5 9943.7 10133.3 10136.6 10194.8 10194.9 3494.0 3557.5 3564.8 3564.8 3569.7 58237.1 60458.7 76639.9 78568.2 78713.6 9568.9 9578.2 9846.5 9924.0 10189.3 21296.4 21455.7 21473.0 21530.9 21663.0 7335.8 7478.7 7483.1 7705.7 7852.2 4059.4 4101.0 4143.1 4334.1 4350.7 3455.5 3455.7 3475.1 3495.8 3501.5 559.8 561.3 570.7 573.5 582.7 520.3 520.9 591.4 594.2 632.3 8280.5 8450.8 8523.2 8656.7 8755.9 506.1 515.2 531.6 547.4 551.9 4049.3 4093.6 4149.0 4196.1 4199.2 87328.0 88404.6 88537.0 89070.0 93661.5 76020.0 76907.0 77406.0 77413.6 78109.8 65776.7 67201.7 68372.0 68458.7 68809.7 8832.0 8838.8 8911.2 9014.5 9122.5 48876.3 48956.0 49074.0 49382.3 49600.5 64471.7 65227.0 65753.3 66392.7 68788.0 10100.8 10128.9 10145.7 10252.1 10481.7 11546.4 11933.2 12193.5 12335.9 12634.4 11617.2 11643.2 11653.2 11674.9 11906.3 10306.4 11492.3 11670.0 11690.9 11918.6 11225.2 11254.8 11408.8 11451.4 11505.0 8974.0 9677.8 9711.7 9717.3 9804.2 9068.6 9369.4 9413.7 9511.6 9994.9 20:31:22 INFO - PROCESS | 1967 | -------- Summary: end -------- 20:31:22 INFO - PROCESS | 1967 | 20:31:22 INFO - TEST-INFO | 1967: exit 0 20:31:22 INFO - TEST-OK | dromaeo_css | took 1111125ms 20:31:22 INFO - TEST-START | kraken 20:31:22 INFO - operating with platform_type : mac_ 20:31:22 INFO - Initialising browser for kraken test... 20:31:22 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpMzxPs9/profile http://localhost:49727/getInfo.html) 20:31:25 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 20:31:25 INFO - PROCESS | 1976 | colorDepth:24 20:31:25 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 20:31:25 INFO - PROCESS | 1976 | __metrics 20:31:26 INFO - TEST-INFO | 1976: exit 0 20:31:26 INFO - Browser initialized. 20:31:26 INFO - Running cycle 1/1 for kraken test... 20:31:26 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpMzxPs9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:38 INFO - PROCESS | 1979 | RSS: Main: 258772992 20:31:38 INFO - PROCESS | 1979 | 20:31:41 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-beat-detection) 20:31:41 INFO - PROCESS | 1979 | RSS: Main: 270729216 20:31:41 INFO - PROCESS | 1979 | 20:31:44 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-dft) 20:31:45 INFO - PROCESS | 1979 | RSS: Main: 280215552 20:31:45 INFO - PROCESS | 1979 | 20:31:48 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-fft) 20:31:49 INFO - PROCESS | 1979 | RSS: Main: 282767360 20:31:49 INFO - PROCESS | 1979 | 20:31:50 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-oscillator) 20:31:51 INFO - PROCESS | 1979 | RSS: Main: 283267072 20:31:51 INFO - PROCESS | 1979 | 20:31:53 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:31:54 INFO - PROCESS | 1979 | RSS: Main: 283893760 20:31:54 INFO - PROCESS | 1979 | 20:31:57 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-darkroom) 20:31:57 INFO - PROCESS | 1979 | RSS: Main: 285052928 20:31:57 INFO - PROCESS | 1979 | 20:32:00 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-desaturate) 20:32:01 INFO - PROCESS | 1979 | RSS: Main: 284930048 20:32:01 INFO - PROCESS | 1979 | 20:32:04 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49727/tests/kraken/driver.html?testName=json-parse-financial) 20:32:05 INFO - PROCESS | 1979 | RSS: Main: 285450240 20:32:05 INFO - PROCESS | 1979 | 20:32:06 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:32:07 INFO - PROCESS | 1979 | RSS: Main: 285163520 20:32:07 INFO - PROCESS | 1979 | 20:32:09 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:32:09 INFO - PROCESS | 1979 | RSS: Main: 284131328 20:32:09 INFO - PROCESS | 1979 | 20:32:12 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:32:12 INFO - PROCESS | 1979 | RSS: Main: 286068736 20:32:12 INFO - PROCESS | 1979 | 20:32:15 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:32:15 INFO - PROCESS | 1979 | RSS: Main: 286044160 20:32:15 INFO - PROCESS | 1979 | 20:32:18 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:32:18 INFO - PROCESS | 1979 | RSS: Main: 286019584 20:32:18 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49727/tests/kraken/driver.html?testName=ai-astar) 20:32:20 INFO - PROCESS | 1979 | RSS: Main: 285835264 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | __start_tp_report 20:32:20 INFO - PROCESS | 1979 | _x_x_mozilla_page_load 20:32:20 INFO - PROCESS | 1979 | _x_x_mozilla_page_load_details 20:32:20 INFO - PROCESS | 1979 | |i|pagename|runs| 20:32:20 INFO - PROCESS | 1979 | |0;ai-astar;113;109;121;155;145;126;113;112;113;113 20:32:20 INFO - PROCESS | 1979 | |1;audio-beat-detection;150;122;147;186;142;166;173;157;182;124 20:32:20 INFO - PROCESS | 1979 | |2;audio-dft;197;191;194;207;204;262;196;272;280;201 20:32:20 INFO - PROCESS | 1979 | |3;audio-fft;81;72;75;125;57;55;58;60;89;59 20:32:20 INFO - PROCESS | 1979 | |4;audio-oscillator;81;82;123;80;83;81;118;81;82;119 20:32:20 INFO - PROCESS | 1979 | |5;imaging-gaussian-blur;87;93;108;121;132;113;86;93;87;93 20:32:20 INFO - PROCESS | 1979 | |6;imaging-darkroom;94;96;95;136;107;91;148;150;96;96 20:32:20 INFO - PROCESS | 1979 | |7;imaging-desaturate;96;151;95;142;76;100;145;144;146;93 20:32:20 INFO - PROCESS | 1979 | |8;json-parse-financial;49;64;81;85;56;58;58;65;56;56 20:32:20 INFO - PROCESS | 1979 | |9;json-stringify-tinderbox;63;87;69;67;74;70;68;74;56;66 20:32:20 INFO - PROCESS | 1979 | |10;stanford-crypto-aes;110;114;79;96;111;75;106;114;113;109 20:32:20 INFO - PROCESS | 1979 | |11;stanford-crypto-ccm;124;133;124;125;132;117;132;144;112;153 20:32:20 INFO - PROCESS | 1979 | |12;stanford-crypto-pbkdf2;142;138;143;146;141;146;143;144;143;131 20:32:20 INFO - PROCESS | 1979 | |13;stanford-crypto-sha256-iterative;70;69;66;70;57;67;95;95;87;67 20:32:20 INFO - PROCESS | 1979 | __end_tp_report 20:32:20 INFO - PROCESS | 1979 | __start_cc_report 20:32:20 INFO - PROCESS | 1979 | _x_x_mozilla_cycle_collect,915 20:32:20 INFO - PROCESS | 1979 | __end_cc_report 20:32:20 INFO - PROCESS | 1979 | __startTimestamp1455165140918__endTimestamp 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | ------- Summary: start ------- 20:32:20 INFO - PROCESS | 1979 | Number of tests: 14 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#0] ai-astar Cycles:10 Average:122.00 Median:117.00 stddev:15.73 (13.4%) stddev-sans-first:16.35 20:32:20 INFO - PROCESS | 1979 | Values: 113.0 109.0 121.0 155.0 145.0 126.0 113.0 112.0 113.0 113.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:161.50 stddev:22.23 (13.8%) stddev-sans-first:23.51 20:32:20 INFO - PROCESS | 1979 | Values: 150.0 122.0 147.0 186.0 142.0 166.0 173.0 157.0 182.0 124.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#2] audio-dft Cycles:10 Average:220.40 Median:205.50 stddev:35.71 (17.4%) stddev-sans-first:36.85 20:32:20 INFO - PROCESS | 1979 | Values: 197.0 191.0 194.0 207.0 204.0 262.0 196.0 272.0 280.0 201.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#3] audio-fft Cycles:10 Average:73.10 Median:66.00 stddev:21.60 (32.7%) stddev-sans-first:22.72 20:32:20 INFO - PROCESS | 1979 | Values: 81.0 72.0 75.0 125.0 57.0 55.0 58.0 60.0 89.0 59.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:81.00 stddev:18.69 (23.1%) stddev-sans-first:19.31 20:32:20 INFO - PROCESS | 1979 | Values: 81.0 82.0 123.0 80.0 83.0 81.0 118.0 81.0 82.0 119.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:87.00 stddev:16.20 (18.6%) stddev-sans-first:16.34 20:32:20 INFO - PROCESS | 1979 | Values: 87.0 93.0 108.0 121.0 132.0 113.0 86.0 93.0 87.0 93.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:94.50 stddev:23.92 (25.3%) stddev-sans-first:24.58 20:32:20 INFO - PROCESS | 1979 | Values: 94.0 96.0 95.0 136.0 107.0 91.0 148.0 150.0 96.0 96.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#7] imaging-desaturate Cycles:10 Average:118.80 Median:113.50 stddev:29.01 (25.6%) stddev-sans-first:29.57 20:32:20 INFO - PROCESS | 1979 | Values: 96.0 151.0 95.0 142.0 76.0 100.0 145.0 144.0 146.0 93.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:61.00 stddev:11.57 (19.0%) stddev-sans-first:11.15 20:32:20 INFO - PROCESS | 1979 | Values: 49.0 64.0 81.0 85.0 56.0 58.0 58.0 65.0 56.0 56.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:8.11 (11.7%) stddev-sans-first:8.27 20:32:20 INFO - PROCESS | 1979 | Values: 63.0 87.0 69.0 67.0 74.0 70.0 68.0 74.0 56.0 66.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#10] stanford-crypto-aes Cycles:10 Average:102.70 Median:114.00 stddev:14.56 (12.8%) stddev-sans-first:15.20 20:32:20 INFO - PROCESS | 1979 | Values: 110.0 114.0 79.0 96.0 111.0 75.0 106.0 114.0 113.0 109.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:132.00 stddev:12.16 (9.2%) stddev-sans-first:12.73 20:32:20 INFO - PROCESS | 1979 | Values: 124.0 133.0 124.0 125.0 132.0 117.0 132.0 144.0 112.0 153.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.00 stddev:4.42 (3.1%) stddev-sans-first:4.69 20:32:20 INFO - PROCESS | 1979 | Values: 142.0 138.0 143.0 146.0 141.0 146.0 143.0 144.0 143.0 131.0 20:32:20 INFO - PROCESS | 1979 | 20:32:20 INFO - PROCESS | 1979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:70.00 stddev:13.16 (18.8%) stddev-sans-first:13.86 20:32:20 INFO - PROCESS | 1979 | Values: 70.0 69.0 66.0 70.0 57.0 67.0 95.0 95.0 87.0 67.0 20:32:20 INFO - PROCESS | 1979 | -------- Summary: end -------- 20:32:20 INFO - PROCESS | 1979 | 20:32:21 INFO - TEST-INFO | 1979: exit 0 20:32:21 INFO - TEST-OK | kraken | took 59018ms 20:32:21 INFO - SUITE-END | took 1170s 20:32:22 INFO - Completed test suite (00:19:30) 20:32:22 INFO - Working with test: dromaeo_css 20:32:22 INFO - Generating results file: dromaeo_css 20:32:22 INFO - Working with test: kraken 20:32:22 INFO - Generating results file: kraken 20:32:22 INFO - javascript benchmark 20:32:22 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:32:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 20:32:22 INFO - process_Request line: dromaeo_css 7382.81 graph.html#tests=[[72,64,61]] 20:32:22 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:32:22 INFO - process_Request line: kraken 1574.90 graph.html#tests=[[232,64,61]] 20:32:22 INFO - RETURN: dromaeo_css: 7382.81 20:32:22 INFO - RETURN: kraken: 1574.90 20:32:22 INFO - javascript benchmark 20:32:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3464.3937310970573, 3520.1903562180696, 3540.5397298351195, 3590.8025058621784, 3592.2815436912624, 5716.685582292977, 5729.255196824417, 5749.338826035002, 5751.511121554662, 5824.039033559463, 5715.2855893013375, 5853.239078919734, 5867.354590994998, 5897.380775018615, 6036.849078773022, 5213.113770658997, 5279.762410691509, 5301.231321458386, 5313.282706834567, 5336.119540275849, 5269.973650131744, 5333.066713325153, 5346.198070289449, 5347.679139251638, 5410.269613602172, 5199.0, 5299.788008479656, 5314.867128321785, 5339.813106541272, 5356.0, 5168.948310516885, 5296.867578310535, 5308.362996440414, 5328.120860058086, 5336.706481143536, 5246.475352464761, 5255.86860328491, 5289.338832645919, 5298.0, 5319.20211968204, 5618.325800903876, 5658.349289831681, 5749.425057494259, 5769.798057067983, 5808.796692115798, 6188.440253331438, 6284.654344011077, 6287.0, 6288.528360372945, 6297.685115744194, 6293.213348331458, 6302.432781049728, 6306.0, 6308.779192728279, 6318.74725010999, 5785.913211301834, 5828.766849326022, 5912.793052243151, 5918.260217472816, 5980.521558275371, 6318.557700960889, 6371.52213583983, 6373.426391624776, 6380.744770209232, 6396.1684980953105, 6101.15649972706, 6195.287541932646, 6285.779997700059, 6305.432511074026, 6315.494760419156, 5213.218017297359, 6291.748330066837, 6294.496440284766, 6296.401841825019, 6310.242770867525, 6228.5017198624, 6259.342769009279, 6263.71813268404, 6300.558960872695, 6319.905201421982, 6161.784337548254, 6194.59735117225, 6204.410580994799, 6287.465565426898, 6311.684415779193, 4892.559669629751, 4943.72809495474, 4946.777395017233, 4965.652404331734, 4975.5522003019905, 4370.650347972155, 4532.4334458192725, 4540.182767101954, 4547.47704014036, 4573.314002899591, 5762.711864406763, 5785.652860828363, 5786.103154011135, 5812.360640329561, 5880.14737863016, 6234.594751341148, 6252.0, 6262.405071518198, 6274.686265686697, 6275.1842260506755, 5653.265075540154, 5789.1026890831145, 5798.652080875161, 5842.561807864342, 5861.824145275648, 5466.098093814476, 5486.067368547357, 5488.012157811632, 5491.670499770026, 5493.587980901449, 6430.099786029959, 6454.838629034218, 6469.708863101077, 6474.417302442803, 6485.254195767453, 6191.628502289877, 6213.596116252429, 6268.2478102626155, 6271.592346497463, 6290.182276304235, 5432.456754324536, 6409.935900640934, 6432.2281326241155, 6453.903191452038, 6469.611823290617, 5257.316548848626, 6175.62946223228, 6241.937580624136, 6291.02489114188, 6301.086342480223, 5230.293910322058, 6212.751489940532, 6265.154204182377, 6283.057541368831, 6296.748130074929, 5323.1216849219445, 5489.505944465017, 5531.197976293495, 5850.297964244318, 6101.7559297627595, 6121.84695382619, 6143.204841797061, 6246.0, 6252.562320637512, 6254.906176407267, 6066.393360663898, 6082.22412946318, 6088.726007329769, 6121.785737499166, 6127.2034635498885, 6139.0495723773565, 6142.0, 6190.473809726043, 6202.34875338083, 6205.2553693557065, 5985.551083668655, 6119.112728654409, 6171.7531298749345, 6193.318734939243, 6219.875602488016], "unit": "score", "name": "dojo.html", "value": 5756.34801696043}, {"lowerIsBetter": false, "replicates": [444.3800897747642, 462.9930551041735, 464.7304563353255, 472.1100725133123, 548.5940404100966, 37704.05739856505, 37992.43011354828, 38082.0, 38135.80932095343, 38368.61631383685, 38857.222855542874, 39397.60602393975, 39466.80266598663, 39470.21059578807, 39560.802195989054, 9330.580123894424, 9552.379095358814, 9591.136797688207, 9602.183814375787, 9612.855807162898, 9270.582823772946, 9535.380200286994, 9553.0, 9560.665376711817, 9568.856467152964, 8167.183281671844, 9462.432254064744, 9494.715158545254, 9539.807524059492, 9629.133377995979, 9558.713238602853, 9564.043595640414, 9606.615735370577, 9613.807723845519, 9613.90386096137, 9543.0, 9546.045395460467, 9605.759856003586, 9685.225181985425, 9692.51537423126, 38391.23217535634, 38439.615603843886, 38451.615483845366, 38818.22363552713, 38995.41506877399, 2820.3795165063652, 3227.2415982244156, 3301.2572171261513, 3322.2026713588807, 3465.4108801503803, 26729.0, 27370.45259094807, 27475.17574472769, 28086.859565702245, 28634.713652863415, 2455.7667021632915, 2799.664040315155, 2841.105051908663, 2849.244950088228, 2870.641169853768, 428582.8570857157, 456888.0, 489239.0, 489442.0, 490115.0, 58006.0, 58973.82052358929, 67410.66294668496, 67727.0, 68721.65639171773, 54834.72582637141, 64675.35324646787, 64882.0, 65275.67362163254, 65453.0, 15966.121863297398, 16095.919520402324, 16181.19094045293, 16335.428260010842, 16347.59131021734, 12281.447334869952, 12383.318917459626, 12421.627351179479, 12515.687107822378, 12530.624081277576, 21101.577968440546, 21284.467888302916, 21387.0, 21397.0, 21412.0, 7429.62851857405, 8944.195022448012, 8977.596008179517, 8980.775480612907, 8984.460932343949, 943.9008904065112, 977.0, 984.7685793838442, 985.8422652375585, 1071.5606601293432, 29515.262118447212, 29608.851955740083, 29846.552301715492, 30011.0, 30073.0, 1058.8941105889503, 1066.7226521104415, 1114.7491814341709, 1142.8857114288505, 1171.5196769324536, 15056.548303550911, 15155.166465844264, 15166.772498412533, 15368.769468457982, 15401.22993850303, 537790.0, 540001.0, 540256.0, 543372.0, 547482.0, 57745.711271443375, 57760.71119644459, 58315.0, 58493.0, 58541.707291464125, 1418.1491105336715, 1439.8344190418236, 1447.370393878645, 1468.5007097586872, 1473.1823837769925, 29095.563566546094, 29201.123966281044, 29442.17659916382, 29852.0, 29854.70145298606, 50463.24305135352, 50809.983800324524, 50867.0, 50872.49127508677, 50895.0, 494899.0, 505235.47382262856, 505380.4730976322, 507056.0, 507367.0, 33610.49584256287, 43270.0, 44239.336409953234, 44889.77555112204, 44912.550874492146, 43576.56423435725, 43923.78038109789, 45532.31701524414, 46108.077838443714, 46205.306920395546, 36996.44505332476, 37591.43612845755, 37936.62063379441, 38053.0, 38525.8442246733, 28811.711882880903, 36977.81511092535, 37251.6274837259, 37324.62675373212, 37780.811095944344, 36906.5712114548, 37301.0, 37380.0, 37658.0, 37673.434898476, 30924.845375772977, 33058.00825975225, 33341.66658333482, 33393.99818005464, 33443.0, 24750.0, 24763.88562514655, 25156.874215628806, 25223.11719089823, 25297.62053569161], "unit": "score", "name": "ext.html", "value": 19835.008349034208}, {"lowerIsBetter": false, "replicates": [316.9556262123303, 365.5394203303838, 368.58718235576157, 369.8243334416152, 372.82290911816875, 15293.617659558517, 18643.1610577524, 19234.80765192348, 19571.315003974847, 20753.896230518843, 9586.376885502437, 11881.346525941091, 12090.939545302283, 12108.515659373614, 19487.123079461424, 4356.803943822528, 5244.816431424901, 5777.537796976232, 5813.912791308134, 5818.621789583684, 5692.800751973682, 5723.112917497794, 5732.197492351074, 5742.827715168552, 5859.355470898197, 3852.5569559500595, 5673.687947162925, 5773.249477567911, 5804.59367844251, 5820.883582328372, 5843.590948633598, 5851.502622277111, 5879.911801322962, 5889.293284805829, 5893.086571581412, 4546.568076032771, 5565.165225216209, 5574.9721251393485, 5629.0, 5646.322441307028, 12785.0, 15125.470608528649, 23206.7679323208, 23356.883215583814, 23525.88237058804, 1943.1255934829383, 2107.420459373669, 2128.074287684862, 2184.322859913432, 2234.3743751749535, 10053.447060411674, 10075.697729068139, 12627.43176557057, 14530.346134423977, 14877.776833347509, 1774.2459454731816, 1808.5117018404958, 1815.5914919143088, 1816.8546516278666, 1842.3551756884983, 93634.06365936322, 101673.0, 102685.0, 102794.0, 104785.47607261992, 10809.135269178447, 11088.55645774176, 11156.609518666808, 11204.66386008421, 11336.036436902956, 13157.407916643773, 13301.534446294334, 13367.799483007762, 13450.596482105553, 13454.52909148175, 8266.628001739937, 8339.666413343399, 8416.368772342099, 8427.157284271523, 8457.492550446992, 8490.702825401082, 8549.401541892132, 8553.700620478254, 8607.22534971843, 8627.396082274307, 4448.110377924428, 4451.955480445219, 4475.6643251755595, 4502.729836209838, 4508.278675411918, 1862.2085613614431, 1915.1286164794985, 1929.6237233739287, 1931.169597073272, 1954.1792447172222, 396.942443345719, 411.38087178795723, 419.1093925408446, 441.3313829548237, 457.83060267701165, 9889.606249003591, 11808.468618911998, 11960.76078478443, 11987.0, 12035.699107522207, 444.3334997503744, 466.37039996005797, 472.68094036525207, 472.75416783272505, 474.29567092867063, 6167.597322485842, 6167.691615419211, 6202.627842329474, 6252.874942501125, 6280.371962803683, 730698.0, 736334.0, 740450.0, 741013.0, 754584.0, 106522.46738766412, 116985.0, 117672.0, 118494.63010739909, 121476.0, 490.93863267091615, 495.67285591510154, 496.2184559319087, 497.1796535716025, 498.61357447977383, 9222.44665320083, 11140.888591113986, 11184.384858832842, 11229.71925701864, 11236.04493618019, 48229.381082755506, 48684.513154868, 48849.26726099182, 49280.014399711086, 49459.7635059112, 70732.0, 70964.64517677379, 71072.15711371487, 71342.0, 71974.0, 7084.681189346388, 7178.461615378972, 7323.0, 7324.681557319734, 7360.742374016883, 10302.896971030194, 11370.94314528422, 11418.82871756941, 11818.290902545874, 12223.388830558615, 7895.171007044178, 9561.665341713007, 9933.453660048477, 10362.326448780805, 10553.63062292816, 10053.597856085675, 10242.334248273839, 10392.688219353431, 10419.687409377731, 10614.310069845435, 10181.541830617492, 10403.167746580406, 10468.682872243557, 10812.891871081189, 10867.891321087005, 7492.7752167435065, 7624.885626715714, 7650.273224043707, 7652.349550288288, 7696.8460630788195, 9353.625854965725, 10559.841602375816, 10584.206184536344, 10621.681349559525, 10757.408342540923], "unit": "score", "name": "jquery.html", "value": 8151.614265928519}, {"lowerIsBetter": false, "replicates": [1363.4478036395258, 1414.370605080739, 1702.7956645202578, 1774.290283886446, 1784.464660601819, 7467.141278752945, 7807.687692492308, 8475.57622118894, 8675.652973881046, 8693.565321733911, 7662.425318101137, 8522.957385213065, 8528.976522817271, 8572.442791218566, 8581.613827377767, 2436.317831007321, 2453.950920981579, 2466.654668346424, 2476.616124500705, 2478.50429914017, 2392.9760702393014, 2486.105002199207, 2488.6515887775727, 2496.163785131983, 2502.637117617944, 2155.913763449468, 2405.386626410263, 2456.066694656028, 2473.764992325735, 2477.838940468873, 2444.841085329448, 2449.1672831237374, 2460.200434858678, 2460.3480077779404, 2483.2177863972793, 2441.829071964963, 2442.1818690738623, 2444.792192663608, 2446.376174075617, 2449.0326321103244, 8414.621342039623, 8510.957445212796, 8588.656453741844, 8595.570221488962, 8643.049264580892, 5290.1800220965815, 5417.674939503642, 5448.673079615236, 5454.8909021819345, 5458.808941687022, 3539.5752509699, 3609.747317687763, 3638.6725194732335, 3704.9073773155887, 3705.962940370589, 1051.2063392138962, 1067.487605949141, 1074.6883403812885, 1084.2735367303926, 1100.0924237504091, 11789.115816313812, 11828.290302581787, 11838.881611183864, 11885.643430697006, 11899.702507437296, 4770.928436073462, 4875.609951203895, 4928.48250933654, 4931.630127740434, 4947.158982972904, 9803.264755143393, 9895.554700038516, 9912.0, 9953.303268771117, 9996.0, 5299.284596579412, 5379.435159308295, 5406.270153529302, 5446.455354464521, 5449.918251226235, 4901.4805410322915, 4928.260760885896, 4943.826966056171, 4949.1586430306215, 4973.303737476684, 3367.5285460035616, 3926.09699769049, 3932.0563064864227, 3940.763554186758, 3945.11234972129, 1238.3003602964297, 1323.6293837725452, 1329.222404893129, 1347.8921686265076, 1358.0832937767166, 1083.6965649618119, 1085.3813326404031, 1115.1859142825783, 1219.9085068619888, 1303.2050449225965, 7773.68905243784, 7776.0, 7820.335271501986, 7875.251851074253, 7909.406794490436, 1037.725002874239, 1174.6358628825092, 1178.281248438452, 1183.3136780667364, 1189.3815216087587, 5965.3139888912465, 6071.180390647294, 6114.9694251529345, 6130.2030736004035, 6148.723307451175, 9984.500774961223, 10357.689269321932, 10604.522796474177, 10607.893921060844, 10630.521626526825, 10278.640247591298, 10296.124829389437, 10387.961203879551, 10394.740131496774, 10403.47982600867, 7962.522248665098, 8020.558869262247, 8036.839263214703, 8100.149484304181, 8146.022477302643, 7619.0, 7619.771406857803, 7663.0, 7673.616319183907, 7702.730404435818, 9099.49952752605, 9346.392484488486, 9349.205317547812, 9404.482753448627, 9475.384100033476, 8250.504969701837, 9521.238300936047, 9799.657012004545, 9828.950855245677, 9880.35777674449, 7203.747868824566, 7250.782476525713, 7255.673494692857, 7283.053203083565, 7332.9266707332245, 7891.84216315659, 7960.721374751856, 8062.9518162640825, 8068.87896681562, 8076.676932922617, 6769.932300677127, 7581.6209189541405, 7668.80827979305, 7681.7695469136015, 7748.0, 7365.852682946418, 7430.665620047002, 7509.061367329084, 7554.395648348009, 7568.243175682388, 7523.0, 7555.055618047744, 7626.542407455348, 7629.923700762922, 7632.69469221225, 6793.456523478011, 6817.761378351734, 6869.965650171717, 6896.379325860697, 6954.826129346807, 5853.385394533512, 6556.442702370352, 7028.753993610199, 7084.752033678797, 7090.964545177241], "unit": "score", "name": "mootools.html", "value": 4874.88635129566}, {"lowerIsBetter": false, "replicates": [324.5261917600304, 329.7329163377664, 333.85477317366934, 335.7632868827476, 340.9863605455782, 4944.480829512903, 5432.72836358182, 6814.080099186608, 6819.283975182597, 6822.7612033578835, 6647.235567909692, 6736.259011508742, 6746.257911629717, 6761.763338283161, 6776.559523630973, 5076.086304465195, 5083.440821509631, 5093.745312734367, 5093.847184584469, 5107.7701503432245, 4971.328870602477, 5081.568066714333, 5087.465816089313, 5107.923381149286, 5122.436531981479, 4685.617742765892, 4815.590674792629, 4983.676061056038, 5014.473480284572, 5026.170681837492, 4435.889102772424, 4677.812887484513, 5004.299398084271, 5023.397192336943, 5026.673266237683, 3535.8232088395475, 4328.04782947751, 4328.956710432887, 4330.415393921843, 4353.782310884443, 6385.47962112231, 6404.519661025395, 6518.57629254097, 6571.57284776488, 6576.210854697467, 5963.463288304073, 5973.671448070354, 5979.970100149515, 5982.102684597302, 5994.010988186944, 7255.927440725578, 7273.927260727378, 7279.344858962719, 7290.708371665127, 7303.269673032707, 4817.78319975602, 4841.467438581753, 4846.200376937801, 4848.951510484885, 4862.5380588844, 6689.33106689332, 7246.130464344313, 7429.777106686808, 7636.42726795487, 7671.424643151786, 4636.5131661175765, 4707.340972263886, 4732.1718699227495, 4735.739534325577, 4741.122892264942, 4002.3396139636634, 4803.0, 4830.106430310404, 4833.685810422311, 4850.490698476609, 4637.373954516097, 5642.153676948491, 5774.902768473977, 5851.912221316684, 5864.853378665567, 6326.46225070865, 6435.324290949477, 7234.74678386254, 7366.079240094989, 7373.262673732584, 1338.7389459055585, 1712.9914350428169, 1759.366628013914, 1761.1282415204555, 1764.4353806781962, 1009.4599389326675, 1116.4864162485185, 1137.7951968645723, 1154.7459558897028, 1155.0124643429915, 5174.793008279702, 6346.11154438379, 6731.596104233761, 6733.730650774012, 6749.122614060141, 7567.886481702779, 7572.2049184835905, 7578.772636820904, 7594.392448604099, 7598.848023039619, 6471.320511346335, 6692.6988285526295, 6712.563683360566, 6717.328267173243, 6730.226024007204, 4004.5194576650406, 4018.6383225509844, 4028.67770578353, 4029.738067025634, 4035.8183881725395, 6940.75066488037, 7440.4419668524, 7876.409269304825, 7904.841903161904, 7926.564038977912, 6198.752049918043, 6572.80281591553, 7811.960940195263, 7842.764717058383, 7881.684732610746, 6469.218236158403, 8054.154313797084, 8058.919410805817, 8072.273495385443, 8088.312493438006, 6030.216071910623, 7311.524750891175, 7661.6552255147535, 7727.536347819148, 7742.883856742266, 7374.483786134919, 7585.469017168745, 7586.658600363107, 7589.924100759143, 7590.39276857839, 8020.358371330396, 8039.638216280398, 8042.638081286474, 8042.798930026796, 8054.275115239657, 3992.2813893499447, 4327.978360108179, 4751.714897106046, 4773.546513081252, 4797.976010119927, 6331.366863313632, 7284.198738138906, 7419.258074192538, 7437.219091995263, 7570.583617900848, 7325.816854578678, 7346.228645992094, 7388.778336649909, 7408.333250007525, 7418.146913105062, 7359.852802944019, 7363.484556081023, 7363.668634911334, 7364.96317518409, 7374.004509391163, 6730.798076057726, 6951.0, 7166.068411106523, 7169.354758071799, 7176.892346614909, 5609.467100625434, 7063.6821343038655, 7326.3406293433845, 7368.59472729005, 7370.705171793068, 5847.970760146172, 7043.2604576518725, 7220.494565380373, 7224.2414546473965, 7226.096737907762], "unit": "score", "name": "prototype.html", "value": 5246.591902540664}, {"lowerIsBetter": false, "replicates": [671.0303611281694, 684.9349311815376, 707.9150501939765, 728.8214387475066, 735.2720806401662, 14521.564353069412, 14521.92739036306, 14878.47925322614, 14879.553613391601, 14885.0, 13563.254021028839, 13623.04638675293, 13624.318784060782, 13649.249291288976, 13692.17846929185, 705.8623568404163, 865.0657290126649, 866.8093019535708, 884.1777147253052, 889.550776857686, 866.6360128745911, 880.6609455359669, 892.8214357128568, 892.830362231174, 894.1505569708803, 929.2148134826061, 936.1434287626813, 937.4843835890233, 938.9342746007748, 942.8114377124602, 908.9636414543444, 921.6221349246811, 936.1106948399048, 937.4656445825882, 938.8357037518407, 668.348360348661, 669.8559809640902, 692.7471472912401, 693.7953303775398, 695.7738734911175, 10680.0, 14267.357968891425, 14396.424143034266, 14428.0, 14525.837932965338, 12742.36288185587, 12873.742525149444, 12893.033022523254, 13151.342432878319, 13330.533431329857, 9943.651972180938, 10133.290669653128, 10136.594536218543, 10194.796104077952, 10194.898051019543, 3494.0, 3557.484164796116, 3564.821758912044, 3564.8395822187804, 3569.7322700797545, 58237.126443103385, 60458.697706511186, 76639.85040224402, 78568.21431785666, 78713.60643196804, 9568.856467152998, 9578.233741300679, 9846.458444785605, 9924.0, 10189.337693050076, 21296.361109166748, 21455.67816482754, 21473.0, 21530.892345538174, 21663.0, 7335.816604584821, 7478.700851965969, 7483.139438964588, 7705.653245603961, 7852.214778522216, 4059.4113853491667, 4100.979495102505, 4143.129942712064, 4334.13317336534, 4350.71720338177, 3455.4644030175364, 3455.652295604716, 3475.1138459692615, 3495.7727747696317, 3501.5447991760907, 559.8271620954094, 561.332014902265, 570.6690119730546, 573.5125143627882, 582.7465052702088, 520.2560338715673, 520.9166533354645, 591.3672370563456, 594.1859652276408, 632.3234139470723, 8280.544570048705, 8450.830983380298, 8523.190296921906, 8656.697015604424, 8755.91244087551, 506.09914352452694, 515.2271592611083, 531.6278604976532, 547.4361407750024, 551.892380985712, 4049.331860243086, 4093.5906409358827, 4149.0, 4196.097838964637, 4199.181159673834, 87328.0, 88404.55797721099, 88537.0, 89070.0, 93661.5316923411, 76020.0, 76907.0, 77406.0, 77413.6129319361, 78109.82835257475, 65776.67111664411, 67201.65596688137, 68371.97442038274, 68458.65770671115, 68809.65595171992, 8832.0, 8838.758319727096, 8911.2425443838, 9014.459132452073, 9122.498262595622, 48876.26685599648, 48956.0, 49074.018519630125, 49382.25926611032, 49600.50399496103, 64471.71056578936, 65227.0, 65753.34246657472, 66392.67214655776, 68787.96818047833, 10100.797984040424, 10128.898711012796, 10145.695629130843, 10252.128569071712, 10481.685549433529, 11546.364949927834, 11933.164678472423, 12193.51225950952, 12335.876641233473, 12634.431450584929, 11617.244879083171, 11643.243189192675, 11653.242539234923, 11674.94162529182, 11906.285622862655, 10306.381617102697, 11492.253003554742, 11670.0, 11690.88309116898, 11918.642440726791, 11225.214235003472, 11254.790702304645, 11408.82886756716, 11451.370174640475, 11505.022073123879, 8973.955130224307, 9677.806443871224, 9711.66009189675, 9717.319787614799, 9804.1666458349, 9068.591913363782, 9369.437833729726, 9413.717588472357, 9511.57197926081, 9994.850077248702], "unit": "score", "name": "yui.html", "value": 6801.940264049332}], "name": "dromaeo_css", "value": 7382.81245635114}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 121.0, 155.0, 145.0, 126.0, 113.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 122.0}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 147.0, 186.0, 142.0, 166.0, 173.0, 157.0, 182.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 154.9}, {"lowerIsBetter": true, "replicates": [197.0, 191.0, 194.0, 207.0, 204.0, 262.0, 196.0, 272.0, 280.0, 201.0], "unit": "score", "name": "audio-dft", "value": 220.4}, {"lowerIsBetter": true, "replicates": [81.0, 72.0, 75.0, 125.0, 57.0, 55.0, 58.0, 60.0, 89.0, 59.0], "unit": "score", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 123.0, 80.0, 83.0, 81.0, 118.0, 81.0, 82.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 108.0, 121.0, 132.0, 113.0, 86.0, 93.0, 87.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.3}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 136.0, 107.0, 91.0, 148.0, 150.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 110.9}, {"lowerIsBetter": true, "replicates": [96.0, 151.0, 95.0, 142.0, 76.0, 100.0, 145.0, 144.0, 146.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 118.8}, {"lowerIsBetter": true, "replicates": [49.0, 64.0, 81.0, 85.0, 56.0, 58.0, 58.0, 65.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 62.8}, {"lowerIsBetter": true, "replicates": [63.0, 87.0, 69.0, 67.0, 74.0, 70.0, 68.0, 74.0, 56.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [110.0, 114.0, 79.0, 96.0, 111.0, 75.0, 106.0, 114.0, 113.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 102.7}, {"lowerIsBetter": true, "replicates": [124.0, 133.0, 124.0, 125.0, 132.0, 117.0, 132.0, 144.0, 112.0, 153.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.6}, {"lowerIsBetter": true, "replicates": [142.0, 138.0, 143.0, 146.0, 141.0, 146.0, 143.0, 144.0, 143.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 66.0, 70.0, 57.0, 67.0, 95.0, 95.0, 87.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.3}], "name": "kraken", "value": 1574.8999999999999}]} 20:32:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1574.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7382.81"}}} 20:32:22 INFO - Return code: 0 20:32:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:32:22 INFO - # TBPL SUCCESS # 20:32:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:32:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:32:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:32:22 INFO - 2016-02-10 20:32:22.629 screenresolution[1984:14836] starting screenresolution argv=screenresolution get 20:32:22 INFO - 2016-02-10 20:32:22.632 screenresolution[1984:14836] Display 0: 1600x1200x32@60 20:32:22 INFO - 2016-02-10 20:32:22.638 screenresolution[1985:14839] starting screenresolution argv=screenresolution list 20:32:22 INFO - Available Modes on Display 0 20:32:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:32:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:32:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:32:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:32:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:32:22 INFO - Intel Iris: 20:32:22 INFO - Chipset Model: Intel Iris 20:32:22 INFO - Type: GPU 20:32:22 INFO - Bus: Built-In 20:32:22 INFO - VRAM (Dynamic, Max): 1536 MB 20:32:22 INFO - Vendor: Intel (0x8086) 20:32:22 INFO - Device ID: 0x0a2e 20:32:22 INFO - Revision ID: 0x0009 20:32:22 INFO - Displays: 20:32:22 INFO - Display: 20:32:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:32:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:32:22 INFO - Display Serial Number: 1600x1200 60 20:32:22 INFO - Main Display: Yes 20:32:22 INFO - Mirror: Off 20:32:22 INFO - Online: Yes 20:32:22 INFO - Rotation: Supported 20:32:22 INFO - Return code: 0 20:32:22 INFO - Running post-action listener: _resource_record_post_action 20:32:22 INFO - Running post-run listener: _resource_record_post_run 20:32:23 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 2650112; Write bytes: 711651328; Read time: 42; Write time: 1989 20:32:23 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386476544; Write bytes: 381183488; Read time: 28785; Write time: 713 20:32:23 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 2650112; Write bytes: 305109504; Read time: 42; Write time: 1222 20:32:23 INFO - Running post-run listener: _upload_blobber_files 20:32:23 INFO - Blob upload gear active. 20:32:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:32:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:32:24 INFO - (blobuploader) - INFO - Open directory for files ... 20:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:25 INFO - (blobuploader) - INFO - Done attempting. 20:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:26 INFO - (blobuploader) - INFO - Done attempting. 20:32:26 INFO - (blobuploader) - INFO - Iteration through files over. 20:32:26 INFO - Return code: 0 20:32:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:32:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:32:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/873c3fb68a0811b8227de19e9d7dcca3ca52ea9cd104de02bc76915e1e76466d1aced9c489df4ca38ca7781cbb103e350fb94ff7bb69c67edda5dc732afb8780", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4011eebe7763dbd43c731f0d190920cfb190667deb9acf32299c1935d0be2192b45addeb9aaca78d20cf9f5a18cd98c8e51c10902c8fc020341ed5bb65460f20"} 20:32:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:26 INFO - Contents: 20:32:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/873c3fb68a0811b8227de19e9d7dcca3ca52ea9cd104de02bc76915e1e76466d1aced9c489df4ca38ca7781cbb103e350fb94ff7bb69c67edda5dc732afb8780", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4011eebe7763dbd43c731f0d190920cfb190667deb9acf32299c1935d0be2192b45addeb9aaca78d20cf9f5a18cd98c8e51c10902c8fc020341ed5bb65460f20"} 20:32:26 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:26 INFO - Copying logs to upload dir... 20:32:26 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.673285 ========= master_lag: 1.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-02-10 20:32:28.168789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 20:32:28.171811) ========= 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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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/Fx-Team/sha512/873c3fb68a0811b8227de19e9d7dcca3ca52ea9cd104de02bc76915e1e76466d1aced9c489df4ca38ca7781cbb103e350fb94ff7bb69c67edda5dc732afb8780", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4011eebe7763dbd43c731f0d190920cfb190667deb9acf32299c1935d0be2192b45addeb9aaca78d20cf9f5a18cd98c8e51c10902c8fc020341ed5bb65460f20"} build_url:https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/MatKC3EkT7C4O2h9KcEbeA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/873c3fb68a0811b8227de19e9d7dcca3ca52ea9cd104de02bc76915e1e76466d1aced9c489df4ca38ca7781cbb103e350fb94ff7bb69c67edda5dc732afb8780", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4011eebe7763dbd43c731f0d190920cfb190667deb9acf32299c1935d0be2192b45addeb9aaca78d20cf9f5a18cd98c8e51c10902c8fc020341ed5bb65460f20"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 20:32:28.198306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:32:28.198653) ========= 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.ALQ2mKDqsR/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.EArWGcWIQd/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005093 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:32:28.247981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 20:32:28.248319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 20:32:28.248733) ========= ========= Total master_lag: 2.14 =========