builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0011 starttime: 1454952597.62 results: success (0) buildid: 20160208074803 builduid: c996fb66ec694037a0aed0663c72bf9c revision: 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.619764) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.620189) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.620508) ========= 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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.005639 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.745912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.746229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.774125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.774437) ========= 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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.005803 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.822985) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.823848) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.824202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:57.824488) ========= 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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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-08 09:29:58-- 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% 178M=0s 2016-02-08 09:29:58 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.627452 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:58.467187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:58.467521) ========= 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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.025960 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:58.520575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:58.520927) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa --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 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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-08 09:29:59,101 truncating revision to first 12 chars 2016-02-08 09:29:59,101 Setting DEBUG logging. 2016-02-08 09:29:59,101 attempt 1/10 2016-02-08 09:29:59,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5728bfd4c648?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 09:29:59,805 unpacking tar archive at: fx-team-5728bfd4c648/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:59.482952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:59.483730) ========= echo 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5728bfd4c648ce684b2ebfdcfd9e399a98d202fa'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa program finished with exit code 0 elapsedTime=0.005679 script_repo_revision: '5728bfd4c648ce684b2ebfdcfd9e399a98d202fa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:59.544368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:59.544653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:29:59.560398) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-02-08 09:29:59.560740) ========= /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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:00 INFO - MultiFileLogger online at 20160208 09:30:00 in /builds/slave/test 09:30:00 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 09:30:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:00 INFO - {'append_to_log': False, 09:30:00 INFO - 'base_work_dir': '/builds/slave/test', 09:30:00 INFO - 'blob_upload_branch': 'Fx-Team', 09:30:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:00 INFO - 'branch': 'Fx-Team', 09:30:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:00 INFO - 'config_files': ('talos/mac_config.py',), 09:30:00 INFO - 'default_actions': ('clobber', 09:30:00 INFO - 'read-buildbot-config', 09:30:00 INFO - 'download-and-extract', 09:30:00 INFO - 'populate-webroot', 09:30:00 INFO - 'create-virtualenv', 09:30:00 INFO - 'install', 09:30:00 INFO - 'run-tests'), 09:30:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:00 INFO - 'download_minidump_stackwalk': True, 09:30:00 INFO - 'download_symbols': 'ondemand', 09:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:00 INFO - 'installer_path': 'installer.exe', 09:30:00 INFO - 'log_level': 'info', 09:30:00 INFO - 'log_name': 'talos', 09:30:00 INFO - 'log_to_console': True, 09:30:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:30:00 INFO - 'opt_config_files': (), 09:30:00 INFO - 'pip_index': False, 09:30:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:30:00 INFO - 'cmd': ('bash', 09:30:00 INFO - '-c', 09:30:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:30:00 INFO - 'enabled': True, 09:30:00 INFO - 'halt_on_failure': False, 09:30:00 INFO - 'name': 'check_screen_resolution'},), 09:30:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:30:00 INFO - 'cmd': ('bash', 09:30:00 INFO - '-c', 09:30:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:30:00 INFO - 'enabled': True, 09:30:00 INFO - 'halt_on_failure': False, 09:30:00 INFO - 'name': 'check_screen_resolution'},), 09:30:00 INFO - 'run_cmd_checks_enabled': True, 09:30:00 INFO - 'sps_profile': False, 09:30:00 INFO - 'sps_profile_interval': 0, 09:30:00 INFO - 'suite': 'dromaeojs-e10s', 09:30:00 INFO - 'system_bits': '32', 09:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:00 INFO - 'title': 't-yosemite-r7-0011', 09:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:00 INFO - 'use_talos_json': True, 09:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:00 INFO - 'work_dir': 'build'} 09:30:00 INFO - ##### 09:30:00 INFO - ##### Running clobber step. 09:30:00 INFO - ##### 09:30:00 INFO - Running pre-action listener: _resource_record_pre_action 09:30:00 INFO - Running main action method: clobber 09:30:00 INFO - rmtree: /builds/slave/test/build 09:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:01 INFO - Running post-action listener: _resource_record_post_action 09:30:01 INFO - ##### 09:30:01 INFO - ##### Running read-buildbot-config step. 09:30:01 INFO - ##### 09:30:01 INFO - Running pre-action listener: _resource_record_pre_action 09:30:01 INFO - Running main action method: read_buildbot_config 09:30:01 INFO - Using buildbot properties: 09:30:01 INFO - { 09:30:01 INFO - "project": "", 09:30:01 INFO - "product": "firefox", 09:30:01 INFO - "script_repo_revision": "production", 09:30:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:30:01 INFO - "repository": "", 09:30:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:30:01 INFO - "buildid": "20160208074803", 09:30:01 INFO - "pgo_build": "False", 09:30:01 INFO - "basedir": "/builds/slave/test", 09:30:01 INFO - "buildnumber": 400, 09:30:01 INFO - "slavename": "t-yosemite-r7-0011", 09:30:01 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:30:01 INFO - "platform": "yosemite_r7", 09:30:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:30:01 INFO - "branch": "fx-team", 09:30:01 INFO - "repo_path": "integration/fx-team", 09:30:01 INFO - "revision": "5728bfd4c648ce684b2ebfdcfd9e399a98d202fa", 09:30:01 INFO - "stage_platform": "macosx64", 09:30:01 INFO - "builduid": "c996fb66ec694037a0aed0663c72bf9c", 09:30:01 INFO - "slavebuilddir": "test" 09:30:01 INFO - } 09:30:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:30:01 INFO - Running post-action listener: _resource_record_post_action 09:30:01 INFO - ##### 09:30:01 INFO - ##### Running download-and-extract step. 09:30:01 INFO - ##### 09:30:01 INFO - Running pre-action listener: _resource_record_pre_action 09:30:01 INFO - Running main action method: download_and_extract 09:30:01 INFO - mkdir: /builds/slave/test/build/tests 09:30: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')]} 09:30:01 INFO - https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/test_packages.json 09:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/test_packages.json 09:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:30:14 INFO - Downloaded 1277 bytes. 09:30:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:30:14 INFO - Using the following test package requirements: 09:30:14 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:30:14 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:30:14 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:30:14 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'jsshell-mac.zip'], 09:30:14 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:30:14 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:30:14 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:30:14 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:30:14 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:30:14 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:30:14 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:30:14 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:30:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:30:14 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')]} 09:30:14 INFO - https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:20 INFO - Downloaded 17753506 bytes. 09:30:20 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'] 09:30:20 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 09:30:23 INFO - Return code: 0 09:30:23 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 09:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:23 INFO - https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:30:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:30:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:30:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:27 INFO - Downloaded 17753506 bytes. 09:30:27 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'] 09:30:27 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 09:30:30 INFO - Return code: 0 09:30:30 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')]} 09:30:30 INFO - https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:31 INFO - Downloaded 10706547 bytes. 09:30:31 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'] 09:30:31 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 09:30:31 INFO - Return code: 0 09:30:31 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')]} 09:30:31 INFO - https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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 09:30:36 INFO - Downloaded 111841108 bytes. 09:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:30:36 INFO - mkdir: /builds/slave/test/properties 09:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:36 INFO - Contents: 09:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:30:37 INFO - Running post-action listener: _resource_record_post_action 09:30:37 INFO - Running post-action listener: set_extra_try_arguments 09:30:37 INFO - ##### 09:30:37 INFO - ##### Running populate-webroot step. 09:30:37 INFO - ##### 09:30:37 INFO - Running pre-action listener: _resource_record_pre_action 09:30:37 INFO - Running main action method: populate_webroot 09:30:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:37 INFO - '--tppagecycles', 09:30:37 INFO - '7'], 09:30:37 INFO - 'tests': ['tsvgm']}}, 09:30:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:30:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:30:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'tests': ['damp', 'tps']}, 09:30:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['damp', 'tps']}, 09:30:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:30:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:37 INFO - 'other': {'tests': ['a11yr', 09:30:37 INFO - 'ts_paint', 09:30:37 INFO - 'tpaint', 09:30:37 INFO - 'sessionrestore', 09:30:37 INFO - 'sessionrestore_no_auto_restore']}, 09:30:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['a11yr', 09:30:37 INFO - 'ts_paint', 09:30:37 INFO - 'tpaint', 09:30:37 INFO - 'sessionrestore', 09:30:37 INFO - 'sessionrestore_no_auto_restore']}, 09:30:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['a11yr', 09:30:37 INFO - 'ts_paint', 09:30:37 INFO - 'tpaint', 09:30:37 INFO - 'sessionrestore', 09:30:37 INFO - 'sessionrestore_no_auto_restore']}, 09:30:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['a11yr', 09:30:37 INFO - 'ts_paint', 09:30:37 INFO - 'tpaint', 09:30:37 INFO - 'sessionrestore', 09:30:37 INFO - 'sessionrestore_no_auto_restore']}, 09:30:37 INFO - 'other_l64': {'tests': ['a11yr', 09:30:37 INFO - 'ts_paint', 09:30:37 INFO - 'tpaint', 09:30:37 INFO - 'sessionrestore', 09:30:37 INFO - 'sessionrestore_no_auto_restore']}, 09:30:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:30:37 INFO - 'ts_paint', 09:30:37 INFO - 'tpaint', 09:30:37 INFO - 'sessionrestore', 09:30:37 INFO - 'sessionrestore_no_auto_restore']}, 09:30:37 INFO - 'svgr': {'tests': ['tsvgx', 09:30:37 INFO - 'tsvgr_opacity', 09:30:37 INFO - 'tart', 09:30:37 INFO - 'tscrollx', 09:30:37 INFO - 'cart']}, 09:30:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['tsvgx', 09:30:37 INFO - 'tsvgr_opacity', 09:30:37 INFO - 'tart', 09:30:37 INFO - 'tscrollx', 09:30:37 INFO - 'cart']}, 09:30:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'tests': ['tp5o']}, 09:30:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'talos_options': ['--e10s'], 09:30:37 INFO - 'tests': ['tp5o']}, 09:30:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'talos_options': ['--xperf_path', 09:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:37 INFO - 'tests': ['tp5n']}, 09:30:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:37 INFO - 'talos_options': ['--e10s', 09:30:37 INFO - '--xperf_path', 09:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:37 INFO - 'tests': ['tp5n']}}, 09:30:37 INFO - 'talos.zip': {'path': '', 09:30:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:37 INFO - Running post-action listener: _resource_record_post_action 09:30:37 INFO - ##### 09:30:37 INFO - ##### Running create-virtualenv step. 09:30:37 INFO - ##### 09:30:37 INFO - Running pre-action listener: _resource_record_pre_action 09:30:37 INFO - Running main action method: create_virtualenv 09:30:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:30:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:37 INFO - Using real prefix '/tools/python27' 09:30:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:41 INFO - Installing pip.................done. 09:30:41 INFO - Return code: 0 09:30:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:41 INFO - 'HOME': '/Users/cltbld', 09:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:41 INFO - 'LOGNAME': 'cltbld', 09:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:41 INFO - 'MOZ_NO_REMOTE': '1', 09:30:41 INFO - 'NO_EM_RESTART': '1', 09:30:41 INFO - 'PAGER': '/bin/cat', 09:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:41 INFO - 'PWD': '/builds/slave/test', 09:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:41 INFO - 'SHELL': '/bin/bash', 09:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:30:41 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:41 INFO - 'USER': 'cltbld', 09:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:41 INFO - 'XPC_FLAGS': '0x0', 09:30:41 INFO - 'XPC_SERVICE_NAME': '0', 09:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:30:41 INFO - Cleaning up... 09:30:41 INFO - Return code: 0 09:30:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:41 INFO - 'HOME': '/Users/cltbld', 09:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:41 INFO - 'LOGNAME': 'cltbld', 09:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:41 INFO - 'MOZ_NO_REMOTE': '1', 09:30:41 INFO - 'NO_EM_RESTART': '1', 09:30:41 INFO - 'PAGER': '/bin/cat', 09:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:41 INFO - 'PWD': '/builds/slave/test', 09:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:41 INFO - 'SHELL': '/bin/bash', 09:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:30:41 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:41 INFO - 'USER': 'cltbld', 09:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:41 INFO - 'XPC_FLAGS': '0x0', 09:30:41 INFO - 'XPC_SERVICE_NAME': '0', 09:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:41 INFO - Downloading/unpacking psutil>=0.7.1 09:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:45 INFO - Installing collected packages: psutil 09:30:45 INFO - Running setup.py install for psutil 09:30:45 INFO - building 'psutil._psutil_osx' extension 09:30:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:30:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:30:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:30:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:30:46 INFO - building 'psutil._psutil_posix' extension 09:30:46 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 09:30:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:30:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:30:46 INFO - ^ 09:30:46 INFO - 1 warning generated. 09:30:46 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 09:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:46 INFO - Successfully installed psutil 09:30:46 INFO - Cleaning up... 09:30:46 INFO - Return code: 0 09:30:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:30:46 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')]} 09:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:46 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')]} 09:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:46 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 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:46 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 09:30:46 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 09:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:46 INFO - 'HOME': '/Users/cltbld', 09:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:46 INFO - 'LOGNAME': 'cltbld', 09:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:46 INFO - 'MOZ_NO_REMOTE': '1', 09:30:46 INFO - 'NO_EM_RESTART': '1', 09:30:46 INFO - 'PAGER': '/bin/cat', 09:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:46 INFO - 'PWD': '/builds/slave/test', 09:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:46 INFO - 'SHELL': '/bin/bash', 09:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:30:46 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:46 INFO - 'USER': 'cltbld', 09:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:46 INFO - 'XPC_FLAGS': '0x0', 09:30:46 INFO - 'XPC_SERVICE_NAME': '0', 09:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:30:46 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 09:30:46 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 09:30:46 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 09:30:46 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 09:30:46 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 09:30:46 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 09:30:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:30:48 INFO - Installing collected packages: mozsystemmonitor 09:30:48 INFO - Running setup.py install for mozsystemmonitor 09:30:49 INFO - Successfully installed mozsystemmonitor 09:30:49 INFO - Cleaning up... 09:30:49 INFO - Return code: 0 09:30:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:49 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 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:49 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 09:30:49 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 09:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:49 INFO - 'HOME': '/Users/cltbld', 09:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:49 INFO - 'LOGNAME': 'cltbld', 09:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:49 INFO - 'MOZ_NO_REMOTE': '1', 09:30:49 INFO - 'NO_EM_RESTART': '1', 09:30:49 INFO - 'PAGER': '/bin/cat', 09:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:49 INFO - 'PWD': '/builds/slave/test', 09:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:49 INFO - 'SHELL': '/bin/bash', 09:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:30:49 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:49 INFO - 'USER': 'cltbld', 09:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:49 INFO - 'XPC_FLAGS': '0x0', 09:30:49 INFO - 'XPC_SERVICE_NAME': '0', 09:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:51 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30: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 09:30:52 INFO - Downloading docopt-0.6.1.tar.gz 09:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:52 INFO - Running setup.py install for blobuploader 09:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:53 INFO - Running setup.py install for requests 09:30:53 INFO - Running setup.py install for docopt 09:30:53 INFO - Successfully installed blobuploader requests docopt 09:30:53 INFO - Cleaning up... 09:30:53 INFO - Return code: 0 09:30:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:53 INFO - 'HOME': '/Users/cltbld', 09:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:53 INFO - 'LOGNAME': 'cltbld', 09:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:53 INFO - 'MOZ_NO_REMOTE': '1', 09:30:53 INFO - 'NO_EM_RESTART': '1', 09:30:53 INFO - 'PAGER': '/bin/cat', 09:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:53 INFO - 'PWD': '/builds/slave/test', 09:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:53 INFO - 'SHELL': '/bin/bash', 09:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:30:53 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:53 INFO - 'USER': 'cltbld', 09:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:53 INFO - 'XPC_FLAGS': '0x0', 09:30:53 INFO - 'XPC_SERVICE_NAME': '0', 09:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-hfsZiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-iWbAVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-XQAhZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-BKuieP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-OayvS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-6pEqdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-iKgXkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-KZKJyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:54 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-YYTEdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-XH15t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-WXKQPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-f4RbyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Cz4YcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-b7sFrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-oe5s4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-TzvIyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:55 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-vRCtvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:55 INFO - Running setup.py install for manifestparser 09:30:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:55 INFO - Running setup.py install for mozcrash 09:30:56 INFO - Running setup.py install for mozdebug 09:30:56 INFO - Running setup.py install for mozdevice 09:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Running setup.py install for mozfile 09:30:56 INFO - Running setup.py install for mozhttpd 09:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Running setup.py install for mozinfo 09:30:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Running setup.py install for mozInstall 09:30:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:56 INFO - Running setup.py install for mozleak 09:30:57 INFO - Running setup.py install for mozlog 09:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:57 INFO - Running setup.py install for moznetwork 09:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:57 INFO - Running setup.py install for mozprocess 09:30:57 INFO - Running setup.py install for mozprofile 09:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:57 INFO - Running setup.py install for mozrunner 09:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:57 INFO - Running setup.py install for mozscreenshot 09:30:58 INFO - Running setup.py install for moztest 09:30:58 INFO - Running setup.py install for mozversion 09:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:58 INFO - Cleaning up... 09:30:58 INFO - Return code: 0 09:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:30:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:30:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:58 INFO - 'HOME': '/Users/cltbld', 09:30:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:58 INFO - 'LOGNAME': 'cltbld', 09:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:58 INFO - 'MOZ_NO_REMOTE': '1', 09:30:58 INFO - 'NO_EM_RESTART': '1', 09:30:58 INFO - 'PAGER': '/bin/cat', 09:30:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:58 INFO - 'PWD': '/builds/slave/test', 09:30:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:58 INFO - 'SHELL': '/bin/bash', 09:30:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:30:58 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:30:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:58 INFO - 'USER': 'cltbld', 09:30:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:58 INFO - 'XPC_FLAGS': '0x0', 09:30:58 INFO - 'XPC_SERVICE_NAME': '0', 09:30:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:58 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-nwYoXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:58 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-NXgEz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:58 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)) 09:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:58 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-V1PZMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-2RHSje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:59 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)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-WVNseF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:59 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)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-quzQ7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:59 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)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Ab97gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-142q4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-keMuo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Airn2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-hFTmYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-aDLmn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:59 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-LguYBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:00 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)) 09:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:00 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-ZXeb8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:00 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)) 09:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:00 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-c5ayl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:00 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)) 09:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:00 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-yrZh8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:00 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)) 09:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:00 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-rgu7z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:02 INFO - Downloading blessings-1.6.tar.gz 09:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:02 INFO - Installing collected packages: blessings 09:31:02 INFO - Running setup.py install for blessings 09:31:02 INFO - Successfully installed blessings 09:31:02 INFO - Cleaning up... 09:31:03 INFO - Return code: 0 09:31:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:03 INFO - Reading from file tmpfile_stdout 09:31:03 INFO - Current package versions: 09:31:03 INFO - blessings == 1.6 09:31:03 INFO - blobuploader == 1.2.4 09:31:03 INFO - docopt == 0.6.1 09:31:03 INFO - manifestparser == 1.1 09:31:03 INFO - mozInstall == 1.12 09:31:03 INFO - mozcrash == 0.16 09:31:03 INFO - mozdebug == 0.1 09:31:03 INFO - mozdevice == 0.48 09:31:03 INFO - mozfile == 1.2 09:31:03 INFO - mozhttpd == 0.7 09:31:03 INFO - mozinfo == 0.9 09:31:03 INFO - mozleak == 0.1 09:31:03 INFO - mozlog == 3.1 09:31:03 INFO - moznetwork == 0.27 09:31:03 INFO - mozprocess == 0.22 09:31:03 INFO - mozprofile == 0.28 09:31:03 INFO - mozrunner == 6.11 09:31:03 INFO - mozscreenshot == 0.1 09:31:03 INFO - mozsystemmonitor == 0.0 09:31:03 INFO - moztest == 0.7 09:31:03 INFO - mozversion == 1.4 09:31:03 INFO - psutil == 3.1.1 09:31:03 INFO - requests == 1.2.3 09:31:03 INFO - wsgiref == 0.1.2 09:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:03 INFO - 'HOME': '/Users/cltbld', 09:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:03 INFO - 'LOGNAME': 'cltbld', 09:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:03 INFO - 'MOZ_NO_REMOTE': '1', 09:31:03 INFO - 'NO_EM_RESTART': '1', 09:31:03 INFO - 'PAGER': '/bin/cat', 09:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:03 INFO - 'PWD': '/builds/slave/test', 09:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:03 INFO - 'SHELL': '/bin/bash', 09:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:31:03 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:03 INFO - 'USER': 'cltbld', 09:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:03 INFO - 'XPC_FLAGS': '0x0', 09:31:03 INFO - 'XPC_SERVICE_NAME': '0', 09:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:31:03 INFO - Cleaning up... 09:31:03 INFO - Return code: 0 09:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:03 INFO - 'HOME': '/Users/cltbld', 09:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:03 INFO - 'LOGNAME': 'cltbld', 09:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:03 INFO - 'MOZ_NO_REMOTE': '1', 09:31:03 INFO - 'NO_EM_RESTART': '1', 09:31:03 INFO - 'PAGER': '/bin/cat', 09:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:03 INFO - 'PWD': '/builds/slave/test', 09:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:03 INFO - 'SHELL': '/bin/bash', 09:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:31:03 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:03 INFO - 'USER': 'cltbld', 09:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:03 INFO - 'XPC_FLAGS': '0x0', 09:31:03 INFO - 'XPC_SERVICE_NAME': '0', 09:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:04 INFO - Downloading/unpacking jsonschema 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:06 INFO - Downloading/unpacking functools32 (from jsonschema) 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:31:07 INFO - warning: no files found matching '*.txt' 09:31:07 INFO - no previously-included directories found matching 'build' 09:31:07 INFO - no previously-included directories found matching 'dist' 09:31:07 INFO - no previously-included directories found matching '.git*' 09:31:07 INFO - Installing collected packages: jsonschema, functools32 09:31:07 INFO - Running setup.py install for functools32 09:31:07 INFO - warning: no files found matching '*.txt' 09:31:07 INFO - no previously-included directories found matching 'build' 09:31:07 INFO - no previously-included directories found matching 'dist' 09:31:07 INFO - no previously-included directories found matching '.git*' 09:31:07 INFO - Successfully installed jsonschema functools32 09:31:07 INFO - Cleaning up... 09:31:07 INFO - Return code: 0 09:31:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:07 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 0x109b50a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb502caf0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, '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.wan4V9gqkK/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.LYwCq8ylky/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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 09:31:07 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 09:31:07 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 09:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:07 INFO - 'HOME': '/Users/cltbld', 09:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:07 INFO - 'LOGNAME': 'cltbld', 09:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:07 INFO - 'MOZ_NO_REMOTE': '1', 09:31:07 INFO - 'NO_EM_RESTART': '1', 09:31:07 INFO - 'PAGER': '/bin/cat', 09:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:07 INFO - 'PWD': '/builds/slave/test', 09:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:07 INFO - 'SHELL': '/bin/bash', 09:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:31:07 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:07 INFO - 'USER': 'cltbld', 09:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:07 INFO - 'XPC_FLAGS': '0x0', 09:31:07 INFO - 'XPC_SERVICE_NAME': '0', 09:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:07 INFO - Downloading/unpacking flake8 09:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:31:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:31:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:31:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:31:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:31:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:31:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:31:11 INFO - no previously-included directories found matching 'docs/_build' 09:31:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:31:11 INFO - Running setup.py install for pep8 09:31:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:31:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:31:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:31:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:31:11 INFO - no previously-included directories found matching 'docs/_build' 09:31:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:31:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:31:11 INFO - Cleaning up... 09:31:11 INFO - Return code: 0 09:31:11 INFO - Running post-action listener: _resource_record_post_action 09:31:11 INFO - Running post-action listener: _start_resource_monitoring 09:31:11 INFO - Starting resource monitoring. 09:31:11 INFO - ##### 09:31:11 INFO - ##### Running install step. 09:31:11 INFO - ##### 09:31:11 INFO - Running pre-action listener: _resource_record_pre_action 09:31:11 INFO - Running main action method: install 09:31:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:12 INFO - Reading from file tmpfile_stdout 09:31:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:31:12 INFO - Reading from file tmpfile_stdout 09:31:12 INFO - Output received: 09:31:12 INFO - Usage: mozinstall [options] installer 09:31:12 INFO - Options: 09:31:12 INFO - -h, --help show this help message and exit 09:31:12 INFO - -d DEST, --destination=DEST 09:31:12 INFO - Directory to install application into. [default: 09:31:12 INFO - "/builds/slave/test"] 09:31:12 INFO - --app=APP Application being installed. [default: firefox] 09:31:12 INFO - mkdir: /builds/slave/test/build/application 09:31:12 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'] 09:31:12 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 09:31:46 INFO - Reading from file tmpfile_stdout 09:31:46 INFO - Output received: 09:31:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:31:46 INFO - Running post-action listener: _resource_record_post_action 09:31:46 INFO - ##### 09:31:46 INFO - ##### Running run-tests step. 09:31:46 INFO - ##### 09:31:46 INFO - Running pre-action listener: _resource_record_pre_action 09:31:46 INFO - Running main action method: run_tests 09:31:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:31:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:31:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:31:46 INFO - 2016-02-08 09:31:46.358 screenresolution[1661:8064] starting screenresolution argv=screenresolution get 09:31:46 INFO - 2016-02-08 09:31:46.361 screenresolution[1661:8064] Display 0: 1600x1200x32@50 09:31:46 INFO - 2016-02-08 09:31:46.367 screenresolution[1662:8067] starting screenresolution argv=screenresolution list 09:31:46 INFO - Available Modes on Display 0 09:31:46 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 09:31:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:31:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:31:46 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 09:31:46 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 09:31:46 INFO - Graphics/Displays: 09:31:46 INFO - Intel Iris: 09:31:46 INFO - Chipset Model: Intel Iris 09:31:46 INFO - Type: GPU 09:31:46 INFO - Bus: Built-In 09:31:46 INFO - VRAM (Dynamic, Max): 1536 MB 09:31:46 INFO - Vendor: Intel (0x8086) 09:31:46 INFO - Device ID: 0x0a2e 09:31:46 INFO - Revision ID: 0x0009 09:31:46 INFO - Displays: 09:31:46 INFO - Display: 09:31:46 INFO - Resolution: 1600 x 1200 @ 50 Hz 09:31:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:31:46 INFO - Display Serial Number: 1600x1200 50 09:31:46 INFO - Main Display: Yes 09:31:46 INFO - Mirror: Off 09:31:46 INFO - Online: Yes 09:31:46 INFO - Rotation: Supported 09:31:46 INFO - Return code: 0 09:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:46 INFO - Python 2.7.3 09:31:46 INFO - Return code: 0 09:31:46 INFO - grabbing minidump binary from tooltool 09:31:46 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')]} 09:31:46 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 0x1099f4d30>, '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 0x109818db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:46 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 09:31:46 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 09:31:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:46 INFO - Return code: 0 09:31:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:31:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:31:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:31:47 INFO - Return code: 0 09:31:47 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/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--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 09:31:47 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/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0011 --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 09:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wan4V9gqkK/Render', 09:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:47 INFO - 'HOME': '/Users/cltbld', 09:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:47 INFO - 'LOGNAME': 'cltbld', 09:31:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:47 INFO - 'MOZ_NO_REMOTE': '1', 09:31:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:47 INFO - 'NO_EM_RESTART': '1', 09:31:47 INFO - 'PAGER': '/bin/cat', 09:31:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:47 INFO - 'PWD': '/builds/slave/test', 09:31:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:47 INFO - 'SHELL': '/bin/bash', 09:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LYwCq8ylky/Listeners', 09:31:47 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 09:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:47 INFO - 'USER': 'cltbld', 09:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:47 INFO - 'XPC_FLAGS': '0x0', 09:31:47 INFO - 'XPC_SERVICE_NAME': '0', 09:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:47 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/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--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 09:31:48 INFO - mozversion application_buildid: 20160208074803 09:31:48 INFO - mozversion application_changeset: 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa 09:31:48 INFO - mozversion application_display_name: Nightly 09:31:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:48 INFO - mozversion application_name: Firefox 09:31:48 INFO - mozversion application_remotingname: firefox 09:31:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:31:48 INFO - mozversion application_vendor: Mozilla 09:31:48 INFO - mozversion application_version: 47.0a1 09:31:48 INFO - mozversion platform_buildid: 20160208074803 09:31:48 INFO - mozversion platform_changeset: 5728bfd4c648ce684b2ebfdcfd9e399a98d202fa 09:31:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:31:48 INFO - mozversion platform_version: 47.0a1 09:31:48 INFO - using testdate: 1454952708 09:31:48 INFO - actual date: 1454952708 09:31:48 INFO - starting webserver on 'localhost:49275' 09:31:48 INFO - SUITE-START | Running 2 tests 09:31:48 INFO - TEST-START | dromaeo_css 09:31:48 INFO - operating with platform_type : mac_ 09:31:48 INFO - Initialising browser for dromaeo_css test... 09:31:48 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpB2G_3b/profile http://localhost:49275/getInfo.html) 09:31:51 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 09:31:51 INFO - PROCESS | 1680 | colorDepth:24 09:31:51 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 09:31:51 INFO - PROCESS | 1680 | __metrics 09:31:52 INFO - TEST-INFO | 1680: exit 0 09:31:52 INFO - Browser initialized. 09:31:52 INFO - Running cycle 1/1 for dromaeo_css test... 09:31:52 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpB2G_3b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:04 INFO - PROCESS | 1685 | RSS: Main: 258514944 09:32:04 INFO - PROCESS | 1685 | 09:32:53 INFO - PROCESS | 1685 | 1454952773981 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] 09:35:04 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 09:35:05 INFO - PROCESS | 1685 | RSS: Main: 277868544 09:35:05 INFO - PROCESS | 1685 | 09:38:07 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:38:08 INFO - PROCESS | 1685 | RSS: Main: 287678464 09:38:08 INFO - PROCESS | 1685 | 09:41:09 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:41:10 INFO - PROCESS | 1685 | RSS: Main: 289710080 09:41:10 INFO - PROCESS | 1685 | 09:44:12 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:44:12 INFO - PROCESS | 1685 | RSS: Main: 291782656 09:44:12 INFO - PROCESS | 1685 | 09:47:15 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 09:47:15 INFO - PROCESS | 1685 | RSS: Main: 293019648 09:47:15 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 09:50:18 INFO - PROCESS | 1685 | RSS: Main: 295690240 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | __start_tp_report 09:50:18 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 09:50:18 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 09:50:18 INFO - PROCESS | 1685 | |i|pagename|runs| 09:50:18 INFO - PROCESS | 1685 | |0;dojo.html;3089.335792804547;3535.3106144301837;3551;3588.9461658075115;3591.443326284426;5670.546356291492;5715.257016587843;5718.9428105718935;5719.485246327829;5719.571032172583;5578.24693666355;5715.3141623005295;5730.541556675466;5776.277965254343;5856.882862342751;5142.845714628548;5191.766370513317;5228.0850851101095;5237.319148510707;5280.709560974145;664.8789132939611;5117.257997590347;5166.948330516684;5218.556422704056;5220.947790522103;5179;5197.792088316444;5222.712750798704;5228.451012643674;5233.110371236899;4320.4383430153875;5223.059849227137;5230.764615592308;5245.449227831061;5283.022640811424;4688.296755486705;4869.659123861331;5120;5156.252343410185;5198.298229738974;4426.601605855489;5603.971980140073;5609.411011843738;5728.513076388512;5735.053716136832;6106.673025714385;6144.402455361594;6258.9359808832605;6289.7169627366875;6323.241211054657;5252.317198764136;6177.752889884399;6195.16365290689;6199.752009919598;6218.906716399258;5174.922376164361;5922.911156332659;5959.970200149015;5971;5984.820455386345;6175.44421002112;6240.063990401385;6264.812055638338;6273.1844860167885;6274.843128921722;5544.861378465571;5916.023856063702;6149.538784591174;6209.285932117774;6214.223222097238;5113.897722045538;6146.524834039798;6283.96858015707;6285.5914365567005;6339;6165.62623389998;6243.750249989949;6251.499880009679;6253.218347706536;6263.217097862767;6253.937460625336;6279.905801412982;6286.685665716787;6289.339619339995;6306.180196574416;4794.736289504111;4909.140900342497;4918.360613120343;4932.358793356912;4986.875328116754;4411.757353345597;4429.490608580055;4432.911341773147;4466.7766611669285;4493.842715505007;5680.886382272414;5720.599558030981;5753.942460575341;5765.971170144123;5775.306963164448;5652.406497317723;5890.3815099414805;6173.012318029094;6182.443580077815;6269.655168965751;5691.658500489983;5748.770049197985;5750.424957504216;5767.826965191051;5797.826065218051;4560.361549383023;5292.682439053669;5363.436839131913;5404.567634589223;5419.512243898068;6301.275353334425;6318.210223722035;6332.4934005279465;6341.3341599132345;6347.460465860454;5106.0121411383625;6212.378762123752;6226.377362263737;6269.153664255267;6274.1843560336865;6187.195664563578;6253.593516421418;6308.495320374451;6359.8092057238355;6361.45927596141;6210.161628180138;6219.533534984804;6230.283517395557;6264.310925798068;6265.15420418256;5201.453847346125;6148.647297594522;6251.093591429309;6263.997760358321;6280.309165991646;6131.386861313833;6163;6172.722227499684;6218.968905155445;6226.377362263737;6078.057901025348;6102.389761023862;6108.450239478469;6156.1381406604005;6160.568760186923;5744.965906136936;5773.797917072882;5870.853228669317;5873.177755114202;6030.125631783455;6074.787382441594;6132.325444201224;6157.291911430243;6170.5372097092;6199.132121502903;5173.767180476812;5917.526597872074;6016.4585187331595;6070.9089363658695;6079.848003799941 09:50:18 INFO - PROCESS | 1685 | |1;ext.html;468.0685435982396;479.8560431870439;492.7610109097087;567.687771725551;608.7504123309444;37133.62866371335;37405.06487337818;37523.24953500935;37649;37685.43471847924;38502.807485962534;38832.41751373732;38922;38924.22151556967;38956.831295061194;9194.862077068832;9378.718638440823;9410.952945235298;9425.952870235673;9466.857997130048;8103.797405064862;9422.52887355633;9622.951885240564;9666.033396660348;9673.758156046084;8471.195236452528;9639;9645.469499177543;9676.467794271312;9696.612135514571;9567.42595444272;9592.95203523978;9637.373570717951;9648.614055437809;9657;9362.859557106649;9372.95313523435;9448.149666530046;9485.905140948571;9491.19324857388;37893.242135157416;38193.809030954944;38223.61776382229;38317.85046448611;38377.42433863494;2834.4756220099143;2877.5539791332376;3126.6873312668777;3261.9347613047844;3434.5191673165778;22599;25956.35109122268;26200.9519619215;26339.73660263392;26523.73476265232;2318.420394901275;2797.580362945554;2826.844523551204;2860.3993161436124;2877.84171870547;284621.1537884636;307597;317416;319431;426221.8688906567;55903.44096558982;62184.68907655523;64862.675686622206;65106;65531;61239.69380153071;61479.07781383283;61566.69216653888;61570.384296156466;62129;15626.76559851603;15643.139627320606;15777.132257725705;15963.920180399024;16157.192140392934;11898.643040708792;12216.694582635328;12286.938565307117;12419.813702794465;12512.186707863959;17016.234269457906;20194.192232310543;20518.076686549142;20559.074841632162;20602.072906719233;7075.433965282868;7497.925020749832;7881.330086942559;7914.762557123296;7923.841523169504;922.9907700923039;972.2562239886493;998.8152191844387;1103.768208676187;1172.0740614914293;30094.398112038074;30208.697913021027;30222.395552089274;30359.544606830914;30443.695563044086;1006.9043440873105;1063.7500187456096;1084.9891501085046;1159.246489781632;1188.0495603517152;14362;14370;14415.351309191112;14734.852651473562;14804.62988425298;544564;547041;552368;554531;554798;56136.43863561394;56162;56403.71798141065;56617.86764264692;57148;1410.8730214280558;1413.484078311409;1420.801087847702;1430.6494908747216;1432.176498513359;27120.72879271182;29274.268143296587;29276.70723292825;29731.702682972893;29828;50483;50968.98062038812;51007;51076.74461627668;51151;352206;358910;412623;417319;419925;28605.570916435852;30439.239019024702;31268.530972034983;32363.676363236067;33412.1646958828;41458.58541414547;41984.58015419929;43167.56832431635;43444.13111737684;43891.78054109709;31771.523427149074;35174.76888308897;35219.82390088033;36144.63855361518;36420.635793641726;35292.823535882155;35417.29165416729;35797.64202357943;35928;35987;35821.88048374366;36041.819790900874;36201.275974480886;36230.913072607866;36270.27459450849;29859.552106718853;31021.68978310188;31033.844830775703;31046.0686179415;31094.911678091157;23657.40856478602;25025.874870625532;25088.874555627106;25095;25431.6185257225 09:50:18 INFO - PROCESS | 1685 | |2;jquery.html;361.32612677356724;366.4905780964459;366.6187165348038;371.18710025045146;372.74280746285046;15298.541043768677;18399.46951453599;19426.1258243379;19472.902635486822;19983.60032799345;18880.150393232303;18928.1482333295;19024.524386890334;19225.903870480626;19248.807511924875;4207.200631879949;5566.443355664442;5867.677277749722;5872.706364681749;6267.185265915425;6257.499400047986;6436.613803171825;6492.318306577812;6512.153420055386;6539.4114529692315;6336.841578960517;6413.7113829877535;6426.871462570746;6434.839129021789;6441.227052753676;6233.625982441068;6394.584352017104;6510.08858759774;6519.119918810948;6526.184226971604;5436.184572314145;5583.4137415571595;5658.094704847204;5658.405867383906;5660.915086273709;23725.525489490286;24100.79496025192;24148.275551733477;24153.03387864501;24449;2013.5268211970176;2141.839362047837;2182.9126834926583;2185.825133989277;2393.521295740841;11671;14045.508407205698;14129.646758831112;14622.488212912604;14709.55871323862;1490.8658220760183;1762.488878225313;1762.5769815244378;1787.9540468825753;1822.7630408046869;87435;94503.63740906533;95037;96580;103717;9733.707988760349;9970.700878973643;10900.400477973788;11125.777484450266;11305.152113591514;13087.738245235041;13107.475700972045;13154.276514791587;13157.013224008238;13167.144135631153;8383.413161078666;8417.579121043924;8538.274246689101;8551.657933682707;8594.312455003585;7673.887286343449;8598.742037738877;8657.350698697623;8664;8706.52114133716;3157.715805577509;4278.871633850989;4426.490953540319;4439.533848945879;4501.527339629357;1821.9544511387057;1893.3184053740642;1895.8578106642058;1900.914458849355;1921.5964647424198;888.9244414224863;928.5450129436528;947.393668052447;1004.4124187350336;1005.648023191877;19214.711779323323;19637.31269405564;19996.90001550012;20026.499337516387;20035.799642003683;944.8960614332418;947.1286416496839;956.297121615612;993.7714325705128;1013.9340942838692;10567.682969510926;10905.83641245382;10941.945290273658;10957.616483423042;10983.066439352584;281539;282097;282155;508437.45781270857;754868;71162.57674846577;73688;110543;115129;117794;1093.6500319897716;1137.6871360375796;1139.9088072954144;1146.8795776443353;1176.353005846781;18289.634207315514;18314.81685183131;18676.43970680882;18737.90631046836;18896.338628147947;49254;50298;50685.23972140347;52433;52463;58364;64485.03272450823;68551.65724171347;71688.64155679189;74364.25635743573;6280.623162610258;7422.703091876265;7600.087989441303;7685.692572297045;7705.113911900204;11393.544258229578;11797.35114568707;11820.172587918763;12010.63968080959;12140.575079872162;10279.743006424898;10327.586896524055;10418.218633602663;10444.947775261378;10547.525361358605;9864.950675246579;10256.743581410525;10332.225083118947;10381.25587245428;10647.520861561403;10043.748906277402;10256.07695307426;10758.946205268923;10839.187060970302;11134.053605443629;6362.554621176659;7686.538807671557;7708.4218683600075;7714.922850771645;7774.105977812624;9061;10495.527701253615;10672.733181670521;10675.786484270426;10815.891841081488 09:50:18 INFO - PROCESS | 1685 | |3;mootools.html;1553.4019402530025;1557.3381312941997;1638.565780068283;1797.3260027489691;1911.5698967732262;7953.642086106124;8618.741437756862;8683.652653893845;8882.067382924788;8938.731838044861;8558;8613.483191008543;8678.47929124253;8720.956395218014;8723.91276087239;2127.9573009225523;2472.826902116857;2483;2486.316263027664;2492.464120214154;2420.1166574200465;2457.717362503317;2467.5805113130723;2469.2098528470897;2470.703515578133;2049.1086377425795;2203.713517242756;2465.2604218734396;2491.5141547398266;2500.2874180858457;2433.184883064158;2435.5007223519224;2476;2480.776730094282;2481.057198264666;2149.2370208575885;2403.855768653869;2475.8885850136785;2482.8137889658346;2495.201535508638;8680.782980425476;8698.260647844942;8729.912700873037;8731.039585645574;8748.737537873874;5401.108817045183;5528.336599608073;5546.833594992157;5574.693391863446;5578.967890940189;3191.888283910052;3671.7796932184156;3681.7238707097076;3799.3351163546545;3808.257389808988;1062.4687656171914;1065.1053115383115;1102.685734565645;1104.4532956186738;1109.3233127792041;10741.033307002408;11120.888791112066;11965;12003.279803211835;12140.210886292363;4861.368022157097;4939.580135688435;4962.131626965339;5000.874978125503;5017.096922553902;10252.794944101077;10287.537060832281;10363.533640986023;10386.272960892666;10402.791944161074;5419.34967803866;5423.891522169534;5510.476504732044;5517.503424691797;5554.861128471821;4022.718409711292;4876.853694389174;4943.209086546135;4986.152354099811;5048.116579598629;3951.8024098794945;3987.720859539804;3994.9201015979515;4003.799810009546;4020.015096301425;1024.2062401638789;1297.3124244150615;1316.8419789625116;1324.6489680234745;1325.1452812935602;1089.8692156941217;1099.406320586874;1131.9207655464204;1254.5170109507724;1353.2489468345163;7998.680052797939;8031.638576264082;8099.595020249082;8311.958440207882;8483.490990540588;1164.9242799218023;1182.5388098641536;1191.398343836357;1210.5702475621204;1212.1817773003363;6293.590916590407;6341.492680585542;6385.584936979081;6433.324500927335;6448.161738973903;10530.736731581772;10593.258471906893;10836.945815270874;10959.178061645409;10975.780484390267;10253.436061016715;10640.680779576625;10867.45662716861;10922.945385273022;10997.395143267197;8290.378221633402;8402.243798058327;8424.368172387096;8475.788105297293;8505.10696376884;7680.577568233801;7788.792737125755;8239.505629662239;8302;8379.790505237417;9594.520273986132;9912.15746661542;9949.552270148006;9977.850332245167;10058.597656093674;9614;9729.9027009729;9817.754556135867;9863.654772082942;10374.688759337232;7503.7748867534065;7583.886241706489;7677.309042186007;7754.418418618739;7764.262395072459;8264.090949995376;8289.129641387568;8326.29226515753;8338.916610833814;8345.833083338177;7696.396195017892;7899.723509677134;7965.4822436541435;7966.721164759206;8000.199980002186;7137.607431591105;7282.271772822675;7649.579273140031;7756;7881.408894333063;7887.723929662434;7922.643481043482;7976.840463190588;7991.160928102698;7999.120096789232;7140.07179066718;7175.21072682015;7228.855422891407;7232.927670723436;7248.528845625017;7275.599842008529;7296;7305.780826575211;7325.7802265932105;7351.448641352027 09:50:18 INFO - PROCESS | 1685 | |4;prototype.html;328.99835500822496;333.3915604022658;336.69024497462334;338.24739953603233;345.2887052671497;6832.077669514614;6964.16430028396;6973.232944376121;7041.436685065195;7073.221945585988;6899.689513971871;6942.4446044316455;6945.826354341144;6952.721891124349;6972.825679358006;4388.539203383647;5076.8730781730565;5078.746062696869;5110.233464980264;5111.974440127803;4831.178699621073;4968.180250258703;5111.08000559899;5136.101182293084;5154.845354639367;4906.994066216417;4912.140375434303;4918.729469879156;4928.211486162215;4943.382077240345;4922.163232250526;4928.802847886081;4942;4946.505349465043;4949.034938187055;4014.5182578090817;4112.9717570607345;4157.688173386978;4164.604362585549;4168.895777605554;6595.802125936181;6644.60132392058;6682.866342673168;6706.631135287557;6727.697253623599;5864.5894787364905;5930.644161350333;5934.495567876736;5945.851353716149;5953.821385358447;7163.89254161188;7435.553866768011;7436.888446673304;7437.367823734989;7457;4714.669973101884;4724.196886529298;4729.219678753002;4732.668713190078;4738.668293219476;6356.713947872357;7791.922080779233;7869.409794265453;7896.881546776745;7911.802204944865;3939;4361.345798130243;4363.759993200341;4618.168729628699;4809.735464549413;4855.660103792771;4879.512048795092;4894.433781189985;4895.192293271642;4895.975520122448;4778.354922085544;4791.233402655558;5865.912011319833;5919.822405327847;5934.8813023739285;7313.451491138186;7477.102747670315;7485.925140748632;7489.887651685229;7508.962455187689;1660.9335626575044;1700.2943778331853;1701.7277235642239;1705.1303835044216;1708.7522309265335;1066.802641511323;1069.764651776608;1079.940603266812;1081.324172392255;1087.3475914451424;6860.211075726255;6904.620245886424;6916.6541672916155;6927.238003819576;6936.861262774716;7781.766547003599;7795.571243581658;7796.766097017098;7796.881247500932;7804.102528209215;6719.865602688016;6868.9313106869295;6883.586984780829;6887.449004079662;6894.207166175854;4005.3991901214467;4068.816903239361;4104.4664193654635;4136.131412403369;4179.2895207814745;6566;8167.63245653947;8193.057798353146;8195.508269503849;8229.753107406787;7781.766547003599;8089.191080891864;8096.149904259968;8109.594520273963;8126.39052071097;8168;8169.836603267901;8176.7955801105445;8193.46742461738;8209;7853.921460785547;7881.448298619041;7884.132745398117;7907.644156012878;7920.811878218314;6258.906116408349;7437.367823735043;7624.428167887541;7653;7672.80817979555;6411.93588064132;7088.503804733619;8124.512529248264;8173.79565510867;8181;4992.101421744121;5043.36957880265;5052.621053420935;5063.772130254074;5063.924041139459;6228.439440450381;6415.903761443488;7746.806329841574;7756.612169391621;7803.570803605629;7449.206547544671;7462.850742985219;7466.850662986819;7472.459363816329;7499.88750168737;6039.305479869696;7193.856122877409;7456.142543607554;7462.253774622494;7505.249475052451;7006.649667516705;7262.818429539304;7338.77983660491;7369.078865141857;7376.299251571092;6434.195725534309;6566.474682025522;7403.852402877563;7516.962415187889;7525.58609276495;7136.250693677297;7260.056192694916;7277.526960747535;7289.1981881994;7298.124225092811 09:50:18 INFO - PROCESS | 1685 | |5;yui.html;647.9935200647993;663.2207156591005;693.0747452151378;700.6916956539122;723.884178531435;12070.818937715942;14068.22624755638;15038.248087595617;15103.62240943977;16697.749533756974;12567.868891799737;15335.76996345053;15399.461018864342;15438.073715577073;15447.922760386182;843.7553109598224;854.2269246332048;858.4076986879033;863.5164307987548;863.7063398444527;841.7096101844854;850.8170743290192;852.497026754218;856.2165618459103;856.3791251342758;892.1524551675934;901.4726385064745;901.5176880369004;908.9136532029447;909.6816114359954;767.3707559800965;887.0774394629577;891.335954713736;896.9506677132755;898.9730308090768;645.8449972006731;650.606383138204;657.9671016449158;666.110742159218;671.2884342596863;10332.638357657446;13213.801792973112;13999.95000374976;14821.110733356034;14849.851501484954;10061.949690251502;12313;12636.873631263754;12808.871911280861;12828.358582070952;10233.744156396075;10234.79530409395;10266.794664106676;10342;10786.514606842711;2950.350922796981;3034.666186719459;3376.1053320869987;3474.9305013899834;3508.438649816043;71157.6442117786;71701.64149179221;71785.64107179483;74289;74434.99999999946;9346.859797103049;9416;9481.051894810602;9729.41623502578;9775.804483910282;20090.799092009183;20268.79731202669;20275.898620506803;20290.492737681678;20292.79707202909;6348.143000694847;7361.742339018108;7468.178500364956;7487;7601.703451783751;4053.452783874139;4231.513375961742;4242.809073591696;4263.444156957729;4307.461567304087;3518.9824050879583;3529.647035296501;3535.964640353615;3537.5931767846514;3545.62770909056;647.3397134922353;649.8472858878159;651.7067319706151;653.9346065393518;658.7068754404244;536.9516743493105;544.9209864569615;577.4052725692543;584.6550535184261;609.6464050850497;8580.570971451403;8678.6528538859;8733.25767309773;8740.344474164463;8785.516796576121;479.3720226503292;513.7893463679874;578.3320265093823;582.5543459253674;637.1048676609371;4165.437665915063;4248.9787551062045;4257.955561773285;4282.443282373271;4437.467503899488;91701.16597668009;92071.61892571617;93093.60359594612;93300.66748331346;95792.52103739437;74404.88392674114;74824.25175748282;75348.62325688337;76743;77316;70895.99999999897;71397.2860271401;71744.64127679433;71828.28171718217;72179;7959.442839001214;8194;8362.707305244287;8654.82690346202;8703.54304404625;48567;48813.51186488089;49167.26249106195;50327.74836125796;51280.743596281776;51174.74412628062;67478;68633.97049044368;68723.96914046194;69551.95672065024;10999.175061870232;11351.772964540498;11373.488193031168;11382;11737.589184378507;10684.145268378355;10743.946280268861;10823.40471274056;12514.249145051326;12696.936515317364;10789.784204316027;10807.13542916549;11891.821622675494;11917;11998.220115692453;11041.723956901142;11899.345535995257;11979.460924258256;11993.460294286604;12069.456874440846;11374.31754094757;11383.487743051417;11412.48643811047;11609.316649086004;11614.825777613174;7514;9155.633774649206;9559.808803824024;9727.173190278623;9872.851907221253;8102.878456823035;9405.576749046173;9614.990426005168;9850.162736167505;10083.546240419051 09:50:18 INFO - PROCESS | 1685 | __end_tp_report 09:50:18 INFO - PROCESS | 1685 | __start_cc_report 09:50:18 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,373 09:50:18 INFO - PROCESS | 1685 | __end_cc_report 09:50:18 INFO - PROCESS | 1685 | __startTimestamp1454953818857__endTimestamp 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | ------- Summary: start ------- 09:50:18 INFO - PROCESS | 1685 | Number of tests: 6 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | [#0] dojo.html Cycles:165 Average:5669.74 Median:5916.02 stddev:767.65 (13.0%) stddev-sans-first:742.83 09:50:18 INFO - PROCESS | 1685 | Values: 3089.3 3535.3 3551.0 3588.9 3591.4 5670.5 5715.3 5718.9 5719.5 5719.6 5578.2 5715.3 5730.5 5776.3 5856.9 5142.8 5191.8 5228.1 5237.3 5280.7 664.9 5117.3 5166.9 5218.6 5220.9 5179.0 5197.8 5222.7 5228.5 5233.1 4320.4 5223.1 5230.8 5245.4 5283.0 4688.3 4869.7 5120.0 5156.3 5198.3 4426.6 5604.0 5609.4 5728.5 5735.1 6106.7 6144.4 6258.9 6289.7 6323.2 5252.3 6177.8 6195.2 6199.8 6218.9 5174.9 5922.9 5960.0 5971.0 5984.8 6175.4 6240.1 6264.8 6273.2 6274.8 5544.9 5916.0 6149.5 6209.3 6214.2 5113.9 6146.5 6284.0 6285.6 6339.0 6165.6 6243.8 6251.5 6253.2 6263.2 6253.9 6279.9 6286.7 6289.3 6306.2 4794.7 4909.1 4918.4 4932.4 4986.9 4411.8 4429.5 4432.9 4466.8 4493.8 5680.9 5720.6 5753.9 5766.0 5775.3 5652.4 5890.4 6173.0 6182.4 6269.7 5691.7 5748.8 5750.4 5767.8 5797.8 4560.4 5292.7 5363.4 5404.6 5419.5 6301.3 6318.2 6332.5 6341.3 6347.5 5106.0 6212.4 6226.4 6269.2 6274.2 6187.2 6253.6 6308.5 6359.8 6361.5 6210.2 6219.5 6230.3 6264.3 6265.2 5201.5 6148.6 6251.1 6264.0 6280.3 6131.4 6163.0 6172.7 6219.0 6226.4 6078.1 6102.4 6108.5 6156.1 6160.6 5745.0 5773.8 5870.9 5873.2 6030.1 6074.8 6132.3 6157.3 6170.5 6199.1 5173.8 5917.5 6016.5 6070.9 6079.8 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | [#1] ext.html Cycles:180 Average:57460.43 Median:36250.59 stddev:115930.18 (319.8%) stddev-sans-first:116176.42 09:50:18 INFO - PROCESS | 1685 | Values: 468.1 479.9 492.8 567.7 608.8 37133.6 37405.1 37523.2 37649.0 37685.4 38502.8 38832.4 38922.0 38924.2 38956.8 9194.9 9378.7 9411.0 9426.0 9466.9 8103.8 9422.5 9623.0 9666.0 9673.8 8471.2 9639.0 9645.5 9676.5 9696.6 9567.4 9593.0 9637.4 9648.6 9657.0 9362.9 9373.0 9448.1 9485.9 9491.2 37893.2 38193.8 38223.6 38317.9 38377.4 2834.5 2877.6 3126.7 3261.9 3434.5 22599.0 25956.4 26201.0 26339.7 26523.7 2318.4 2797.6 2826.8 2860.4 2877.8 284621.2 307597.0 317416.0 319431.0 426221.9 55903.4 62184.7 64862.7 65106.0 65531.0 61239.7 61479.1 61566.7 61570.4 62129.0 15626.8 15643.1 15777.1 15963.9 16157.2 11898.6 12216.7 12286.9 12419.8 12512.2 17016.2 20194.2 20518.1 20559.1 20602.1 7075.4 7497.9 7881.3 7914.8 7923.8 923.0 972.3 998.8 1103.8 1172.1 30094.4 30208.7 30222.4 30359.5 30443.7 1006.9 1063.8 1085.0 1159.2 1188.0 14362.0 14370.0 14415.4 14734.9 14804.6 544564.0 547041.0 552368.0 554531.0 554798.0 56136.4 56162.0 56403.7 56617.9 57148.0 1410.9 1413.5 1420.8 1430.6 1432.2 27120.7 29274.3 29276.7 29731.7 29828.0 50483.0 50969.0 51007.0 51076.7 51151.0 352206.0 358910.0 412623.0 417319.0 419925.0 28605.6 30439.2 31268.5 32363.7 33412.2 41458.6 41984.6 43167.6 43444.1 43891.8 31771.5 35174.8 35219.8 36144.6 36420.6 35292.8 35417.3 35797.6 35928.0 35987.0 35821.9 36041.8 36201.3 36230.9 36270.3 29859.6 31021.7 31033.8 31046.1 31094.9 23657.4 25025.9 25088.9 25095.0 25431.6 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | [#2] jquery.html Cycles:180 Average:28084.16 Median:24150.65 stddev:77483.88 (320.8%) stddev-sans-first:77673.28 09:50:18 INFO - PROCESS | 1685 | Values: 361.3 366.5 366.6 371.2 372.7 15298.5 18399.5 19426.1 19472.9 19983.6 18880.2 18928.1 19024.5 19225.9 19248.8 4207.2 5566.4 5867.7 5872.7 6267.2 6257.5 6436.6 6492.3 6512.2 6539.4 6336.8 6413.7 6426.9 6434.8 6441.2 6233.6 6394.6 6510.1 6519.1 6526.2 5436.2 5583.4 5658.1 5658.4 5660.9 23725.5 24100.8 24148.3 24153.0 24449.0 2013.5 2141.8 2182.9 2185.8 2393.5 11671.0 14045.5 14129.6 14622.5 14709.6 1490.9 1762.5 1762.6 1788.0 1822.8 87435.0 94503.6 95037.0 96580.0 103717.0 9733.7 9970.7 10900.4 11125.8 11305.2 13087.7 13107.5 13154.3 13157.0 13167.1 8383.4 8417.6 8538.3 8551.7 8594.3 7673.9 8598.7 8657.4 8664.0 8706.5 3157.7 4278.9 4426.5 4439.5 4501.5 1822.0 1893.3 1895.9 1900.9 1921.6 888.9 928.5 947.4 1004.4 1005.6 19214.7 19637.3 19996.9 20026.5 20035.8 944.9 947.1 956.3 993.8 1013.9 10567.7 10905.8 10941.9 10957.6 10983.1 281539.0 282097.0 282155.0 508437.5 754868.0 71162.6 73688.0 110543.0 115129.0 117794.0 1093.7 1137.7 1139.9 1146.9 1176.4 18289.6 18314.8 18676.4 18737.9 18896.3 49254.0 50298.0 50685.2 52433.0 52463.0 58364.0 64485.0 68551.7 71688.6 74364.3 6280.6 7422.7 7600.1 7685.7 7705.1 11393.5 11797.4 11820.2 12010.6 12140.6 10279.7 10327.6 10418.2 10444.9 10547.5 9865.0 10256.7 10332.2 10381.3 10647.5 10043.7 10256.1 10758.9 10839.2 11134.1 6362.6 7686.5 7708.4 7714.9 7774.1 9061.0 10495.5 10672.7 10675.8 10815.9 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | [#3] mootools.html Cycles:180 Average:6139.61 Median:5032.61 stddev:3223.91 (64.1%) stddev-sans-first:3214.52 09:50:18 INFO - PROCESS | 1685 | Values: 1553.4 1557.3 1638.6 1797.3 1911.6 7953.6 8618.7 8683.7 8882.1 8938.7 8558.0 8613.5 8678.5 8721.0 8723.9 2128.0 2472.8 2483.0 2486.3 2492.5 2420.1 2457.7 2467.6 2469.2 2470.7 2049.1 2203.7 2465.3 2491.5 2500.3 2433.2 2435.5 2476.0 2480.8 2481.1 2149.2 2403.9 2475.9 2482.8 2495.2 8680.8 8698.3 8729.9 8731.0 8748.7 5401.1 5528.3 5546.8 5574.7 5579.0 3191.9 3671.8 3681.7 3799.3 3808.3 1062.5 1065.1 1102.7 1104.5 1109.3 10741.0 11120.9 11965.0 12003.3 12140.2 4861.4 4939.6 4962.1 5000.9 5017.1 10252.8 10287.5 10363.5 10386.3 10402.8 5419.3 5423.9 5510.5 5517.5 5554.9 4022.7 4876.9 4943.2 4986.2 5048.1 3951.8 3987.7 3994.9 4003.8 4020.0 1024.2 1297.3 1316.8 1324.6 1325.1 1089.9 1099.4 1131.9 1254.5 1353.2 7998.7 8031.6 8099.6 8312.0 8483.5 1164.9 1182.5 1191.4 1210.6 1212.2 6293.6 6341.5 6385.6 6433.3 6448.2 10530.7 10593.3 10836.9 10959.2 10975.8 10253.4 10640.7 10867.5 10922.9 10997.4 8290.4 8402.2 8424.4 8475.8 8505.1 7680.6 7788.8 8239.5 8302.0 8379.8 9594.5 9912.2 9949.6 9977.9 10058.6 9614.0 9729.9 9817.8 9863.7 10374.7 7503.8 7583.9 7677.3 7754.4 7764.3 8264.1 8289.1 8326.3 8338.9 8345.8 7696.4 7899.7 7965.5 7966.7 8000.2 7137.6 7282.3 7649.6 7756.0 7881.4 7887.7 7922.6 7976.8 7991.2 7999.1 7140.1 7175.2 7228.9 7232.9 7248.5 7275.6 7296.0 7305.8 7325.8 7351.4 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | [#4] prototype.html Cycles:180 Average:6014.12 Median:6846.14 stddev:1971.72 (28.8%) stddev-sans-first:1930.53 09:50:18 INFO - PROCESS | 1685 | Values: 329.0 333.4 336.7 338.2 345.3 6832.1 6964.2 6973.2 7041.4 7073.2 6899.7 6942.4 6945.8 6952.7 6972.8 4388.5 5076.9 5078.7 5110.2 5112.0 4831.2 4968.2 5111.1 5136.1 5154.8 4907.0 4912.1 4918.7 4928.2 4943.4 4922.2 4928.8 4942.0 4946.5 4949.0 4014.5 4113.0 4157.7 4164.6 4168.9 6595.8 6644.6 6682.9 6706.6 6727.7 5864.6 5930.6 5934.5 5945.9 5953.8 7163.9 7435.6 7436.9 7437.4 7457.0 4714.7 4724.2 4729.2 4732.7 4738.7 6356.7 7791.9 7869.4 7896.9 7911.8 3939.0 4361.3 4363.8 4618.2 4809.7 4855.7 4879.5 4894.4 4895.2 4896.0 4778.4 4791.2 5865.9 5919.8 5934.9 7313.5 7477.1 7485.9 7489.9 7509.0 1660.9 1700.3 1701.7 1705.1 1708.8 1066.8 1069.8 1079.9 1081.3 1087.3 6860.2 6904.6 6916.7 6927.2 6936.9 7781.8 7795.6 7796.8 7796.9 7804.1 6719.9 6868.9 6883.6 6887.4 6894.2 4005.4 4068.8 4104.5 4136.1 4179.3 6566.0 8167.6 8193.1 8195.5 8229.8 7781.8 8089.2 8096.1 8109.6 8126.4 8168.0 8169.8 8176.8 8193.5 8209.0 7853.9 7881.4 7884.1 7907.6 7920.8 6258.9 7437.4 7624.4 7653.0 7672.8 6411.9 7088.5 8124.5 8173.8 8181.0 4992.1 5043.4 5052.6 5063.8 5063.9 6228.4 6415.9 7746.8 7756.6 7803.6 7449.2 7462.9 7466.9 7472.5 7499.9 6039.3 7193.9 7456.1 7462.3 7505.2 7006.6 7262.8 7338.8 7369.1 7376.3 6434.2 6566.5 7403.9 7517.0 7525.6 7136.3 7260.1 7277.5 7289.2 7298.1 09:50:18 INFO - PROCESS | 1685 | 09:50:18 INFO - PROCESS | 1685 | [#5] yui.html Cycles:180 Average:17931.98 Median:3478.89 stddev:25064.54 (720.5%) stddev-sans-first:25101.25 09:50:18 INFO - PROCESS | 1685 | Values: 648.0 663.2 693.1 700.7 723.9 12070.8 14068.2 15038.2 15103.6 16697.7 12567.9 15335.8 15399.5 15438.1 15447.9 843.8 854.2 858.4 863.5 863.7 841.7 850.8 852.5 856.2 856.4 892.2 901.5 901.5 908.9 909.7 767.4 887.1 891.3 897.0 899.0 645.8 650.6 658.0 666.1 671.3 10332.6 13213.8 14000.0 14821.1 14849.9 10061.9 12313.0 12636.9 12808.9 12828.4 10233.7 10234.8 10266.8 10342.0 10786.5 2950.4 3034.7 3376.1 3474.9 3508.4 71157.6 71701.6 71785.6 74289.0 74435.0 9346.9 9416.0 9481.1 9729.4 9775.8 20090.8 20268.8 20275.9 20290.5 20292.8 6348.1 7361.7 7468.2 7487.0 7601.7 4053.5 4231.5 4242.8 4263.4 4307.5 3519.0 3529.6 3536.0 3537.6 3545.6 647.3 649.8 651.7 653.9 658.7 537.0 544.9 577.4 584.7 609.6 8580.6 8678.7 8733.3 8740.3 8785.5 479.4 513.8 578.3 582.6 637.1 4165.4 4249.0 4258.0 4282.4 4437.5 91701.2 92071.6 93093.6 93300.7 95792.5 74404.9 74824.3 75348.6 76743.0 77316.0 70896.0 71397.3 71744.6 71828.3 72179.0 7959.4 8194.0 8362.7 8654.8 8703.5 48567.0 48813.5 49167.3 50327.7 51280.7 51174.7 67478.0 68634.0 68724.0 69552.0 10999.2 11351.8 11373.5 11382.0 11737.6 10684.1 10743.9 10823.4 12514.2 12696.9 10789.8 10807.1 11891.8 11917.0 11998.2 11041.7 11899.3 11979.5 11993.5 12069.5 11374.3 11383.5 11412.5 11609.3 11614.8 7514.0 9155.6 9559.8 9727.2 9872.9 8102.9 9405.6 9615.0 9850.2 10083.5 09:50:18 INFO - PROCESS | 1685 | -------- Summary: end -------- 09:50:18 INFO - PROCESS | 1685 | 09:50:19 INFO - TEST-INFO | 1685: exit 0 09:50:19 INFO - TEST-OK | dromaeo_css | took 1110744ms 09:50:19 INFO - TEST-START | kraken 09:50:19 INFO - operating with platform_type : mac_ 09:50:19 INFO - Initialising browser for kraken test... 09:50:19 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmp3vO0LG/profile http://localhost:49275/getInfo.html) 09:50:21 INFO - PROCESS | 1692 | __metrics Screen width/height:1600/1200 09:50:21 INFO - PROCESS | 1692 | colorDepth:24 09:50:21 INFO - PROCESS | 1692 | Browser inner width/height: 1024/689 09:50:21 INFO - PROCESS | 1692 | __metrics 09:50:22 INFO - PROCESS | 1692 | 09:50:22 INFO - PROCESS | 1692 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 09:50:22 INFO - PROCESS | 1692 | 09:50:22 INFO - TEST-INFO | 1692: exit 0 09:50:22 INFO - Browser initialized. 09:50:22 INFO - Running cycle 1/1 for kraken test... 09:50:22 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmp3vO0LG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:34 INFO - PROCESS | 1695 | RSS: Main: 259022848 09:50:34 INFO - PROCESS | 1695 | 09:50:37 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 09:50:37 INFO - PROCESS | 1695 | RSS: Main: 271003648 09:50:37 INFO - PROCESS | 1695 | 09:50:40 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 09:50:41 INFO - PROCESS | 1695 | RSS: Main: 278167552 09:50:41 INFO - PROCESS | 1695 | 09:50:44 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 09:50:45 INFO - PROCESS | 1695 | RSS: Main: 283070464 09:50:45 INFO - PROCESS | 1695 | 09:50:47 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 09:50:47 INFO - PROCESS | 1695 | RSS: Main: 285028352 09:50:47 INFO - PROCESS | 1695 | 09:50:49 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:50 INFO - PROCESS | 1695 | RSS: Main: 285962240 09:50:50 INFO - PROCESS | 1695 | 09:50:53 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:53 INFO - PROCESS | 1695 | RSS: Main: 285388800 09:50:53 INFO - PROCESS | 1695 | 09:50:57 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:57 INFO - PROCESS | 1695 | RSS: Main: 285335552 09:50:57 INFO - PROCESS | 1695 | 09:51:00 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 09:51:01 INFO - PROCESS | 1695 | RSS: Main: 285663232 09:51:01 INFO - PROCESS | 1695 | 09:51:03 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:03 INFO - PROCESS | 1695 | RSS: Main: 286339072 09:51:03 INFO - PROCESS | 1695 | 09:51:05 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:06 INFO - PROCESS | 1695 | RSS: Main: 284286976 09:51:06 INFO - PROCESS | 1695 | 09:51:08 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:08 INFO - PROCESS | 1695 | RSS: Main: 286629888 09:51:08 INFO - PROCESS | 1695 | 09:51:11 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:12 INFO - PROCESS | 1695 | RSS: Main: 286507008 09:51:12 INFO - PROCESS | 1695 | 09:51:14 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:15 INFO - PROCESS | 1695 | RSS: Main: 284758016 09:51:15 INFO - PROCESS | 1695 | 09:51:16 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 09:51:17 INFO - PROCESS | 1695 | RSS: Main: 286314496 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | __start_tp_report 09:51:17 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 09:51:17 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 09:51:17 INFO - PROCESS | 1695 | |i|pagename|runs| 09:51:17 INFO - PROCESS | 1695 | |0;ai-astar;113;113;108;113;115;115;108;117;116;115 09:51:17 INFO - PROCESS | 1695 | |1;audio-beat-detection;151;146;146;150;153;135;173;153;145;149 09:51:17 INFO - PROCESS | 1695 | |2;audio-dft;191;198;199;208;244;272;284;221;204;243 09:51:17 INFO - PROCESS | 1695 | |3;audio-fft;73;72;73;124;60;49;78;91;62;75 09:51:17 INFO - PROCESS | 1695 | |4;audio-oscillator;76;84;126;79;79;84;114;81;81;124 09:51:17 INFO - PROCESS | 1695 | |5;imaging-gaussian-blur;87;96;86;87;132;134;87;95;132;135 09:51:17 INFO - PROCESS | 1695 | |6;imaging-darkroom;99;152;126;96;123;104;153;99;154;154 09:51:17 INFO - PROCESS | 1695 | |7;imaging-desaturate;144;151;108;144;148;128;93;91;92;91 09:51:17 INFO - PROCESS | 1695 | |8;json-parse-financial;57;55;56;56;57;58;59;64;57;56 09:51:17 INFO - PROCESS | 1695 | |9;json-stringify-tinderbox;66;71;55;81;108;107;68;68;66;67 09:51:17 INFO - PROCESS | 1695 | |10;stanford-crypto-aes;85;85;86;84;85;84;85;87;88;101 09:51:17 INFO - PROCESS | 1695 | |11;stanford-crypto-ccm;126;138;146;133;136;144;114;123;117;136 09:51:17 INFO - PROCESS | 1695 | |12;stanford-crypto-pbkdf2;127;144;142;141;140;167;193;182;146;130 09:51:17 INFO - PROCESS | 1695 | |13;stanford-crypto-sha256-iterative;67;68;66;69;67;68;65;69;71;66 09:51:17 INFO - PROCESS | 1695 | __end_tp_report 09:51:17 INFO - PROCESS | 1695 | __start_cc_report 09:51:17 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,942 09:51:17 INFO - PROCESS | 1695 | __end_cc_report 09:51:17 INFO - PROCESS | 1695 | __startTimestamp1454953877181__endTimestamp 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | ------- Summary: start ------- 09:51:17 INFO - PROCESS | 1695 | Number of tests: 14 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:3.09 (2.7%) stddev-sans-first:3.28 09:51:17 INFO - PROCESS | 1695 | Values: 113.0 113.0 108.0 113.0 115.0 115.0 108.0 117.0 116.0 115.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:150.50 stddev:9.61 (6.4%) stddev-sans-first:10.19 09:51:17 INFO - PROCESS | 1695 | Values: 151.0 146.0 146.0 150.0 153.0 135.0 173.0 153.0 145.0 149.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#2] audio-dft Cycles:10 Average:226.40 Median:232.00 stddev:32.77 (14.1%) stddev-sans-first:32.15 09:51:17 INFO - PROCESS | 1695 | Values: 191.0 198.0 199.0 208.0 244.0 272.0 284.0 221.0 204.0 243.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#3] audio-fft Cycles:10 Average:75.70 Median:73.00 stddev:20.41 (28.0%) stddev-sans-first:21.62 09:51:17 INFO - PROCESS | 1695 | Values: 73.0 72.0 73.0 124.0 60.0 49.0 78.0 91.0 62.0 75.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:80.00 stddev:20.06 (25.1%) stddev-sans-first:20.33 09:51:17 INFO - PROCESS | 1695 | Values: 76.0 84.0 126.0 79.0 79.0 84.0 114.0 81.0 81.0 124.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#5] imaging-gaussian-blur Cycles:10 Average:107.10 Median:87.00 stddev:22.78 (26.2%) stddev-sans-first:22.97 09:51:17 INFO - PROCESS | 1695 | Values: 87.0 96.0 86.0 87.0 132.0 134.0 87.0 95.0 132.0 135.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#6] imaging-darkroom Cycles:10 Average:126.00 Median:154.00 stddev:25.44 (16.5%) stddev-sans-first:25.03 09:51:17 INFO - PROCESS | 1695 | Values: 99.0 152.0 126.0 96.0 123.0 104.0 153.0 99.0 154.0 154.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#7] imaging-desaturate Cycles:10 Average:119.00 Median:121.00 stddev:26.44 (21.8%) stddev-sans-first:26.45 09:51:17 INFO - PROCESS | 1695 | Values: 144.0 151.0 108.0 144.0 148.0 128.0 93.0 91.0 92.0 91.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.55 (4.5%) stddev-sans-first:2.70 09:51:17 INFO - PROCESS | 1695 | Values: 57.0 55.0 56.0 56.0 57.0 58.0 59.0 64.0 57.0 56.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:67.50 stddev:17.90 (26.5%) stddev-sans-first:18.64 09:51:17 INFO - PROCESS | 1695 | Values: 66.0 71.0 55.0 81.0 108.0 107.0 68.0 68.0 66.0 67.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:85.00 stddev:5.08 (6.0%) stddev-sans-first:5.33 09:51:17 INFO - PROCESS | 1695 | Values: 85.0 85.0 86.0 84.0 85.0 84.0 85.0 87.0 88.0 101.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:136.00 stddev:10.90 (8.0%) stddev-sans-first:11.40 09:51:17 INFO - PROCESS | 1695 | Values: 126.0 138.0 146.0 133.0 136.0 144.0 114.0 123.0 117.0 136.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:145.00 stddev:22.04 (15.2%) stddev-sans-first:21.57 09:51:17 INFO - PROCESS | 1695 | Values: 127.0 144.0 142.0 141.0 140.0 167.0 193.0 182.0 146.0 130.0 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - PROCESS | 1695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.87 09:51:17 INFO - PROCESS | 1695 | Values: 67.0 68.0 66.0 69.0 67.0 68.0 65.0 69.0 71.0 66.0 09:51:17 INFO - PROCESS | 1695 | -------- Summary: end -------- 09:51:17 INFO - PROCESS | 1695 | 09:51:17 INFO - TEST-INFO | 1695: exit 0 09:51:17 INFO - TEST-OK | kraken | took 58551ms 09:51:17 INFO - SUITE-END | took 1169s 09:51:18 INFO - Completed test suite (00:19:29) 09:51:18 INFO - Working with test: dromaeo_css 09:51:18 INFO - Generating results file: dromaeo_css 09:51:18 INFO - Working with test: kraken 09:51:18 INFO - Generating results file: kraken 09:51:18 INFO - javascript benchmark 09:51:18 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 09:51:18 INFO - process_Request line: dromaeo_css 7500.21 graph.html#tests=[[72,64,61]] 09:51:18 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:18 INFO - process_Request line: kraken 1580.70 graph.html#tests=[[232,64,61]] 09:51:18 INFO - RETURN: dromaeo_css: 7500.21 09:51:18 INFO - RETURN: kraken: 1580.70 09:51:18 INFO - javascript benchmark 09:51:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3089.335792804547, 3535.3106144301837, 3551.0, 3588.9461658075115, 3591.443326284426, 5670.546356291492, 5715.257016587843, 5718.9428105718935, 5719.485246327829, 5719.571032172583, 5578.24693666355, 5715.3141623005295, 5730.541556675466, 5776.277965254343, 5856.882862342751, 5142.845714628548, 5191.766370513317, 5228.0850851101095, 5237.319148510707, 5280.709560974145, 664.8789132939611, 5117.257997590347, 5166.948330516684, 5218.556422704056, 5220.947790522103, 5179.0, 5197.792088316444, 5222.712750798704, 5228.451012643674, 5233.110371236899, 4320.4383430153875, 5223.059849227137, 5230.764615592308, 5245.449227831061, 5283.022640811424, 4688.296755486705, 4869.659123861331, 5120.0, 5156.252343410185, 5198.298229738974, 4426.601605855489, 5603.971980140073, 5609.411011843738, 5728.513076388512, 5735.053716136832, 6106.673025714385, 6144.402455361594, 6258.9359808832605, 6289.7169627366875, 6323.241211054657, 5252.317198764136, 6177.752889884399, 6195.16365290689, 6199.752009919598, 6218.906716399258, 5174.922376164361, 5922.911156332659, 5959.970200149015, 5971.0, 5984.820455386345, 6175.44421002112, 6240.063990401385, 6264.812055638338, 6273.1844860167885, 6274.843128921722, 5544.861378465571, 5916.023856063702, 6149.538784591174, 6209.285932117774, 6214.223222097238, 5113.897722045538, 6146.524834039798, 6283.96858015707, 6285.5914365567005, 6339.0, 6165.62623389998, 6243.750249989949, 6251.499880009679, 6253.218347706536, 6263.217097862767, 6253.937460625336, 6279.905801412982, 6286.685665716787, 6289.339619339995, 6306.180196574416, 4794.736289504111, 4909.140900342497, 4918.360613120343, 4932.358793356912, 4986.875328116754, 4411.757353345597, 4429.490608580055, 4432.911341773147, 4466.7766611669285, 4493.842715505007, 5680.886382272414, 5720.599558030981, 5753.942460575341, 5765.971170144123, 5775.306963164448, 5652.406497317723, 5890.3815099414805, 6173.012318029094, 6182.443580077815, 6269.655168965751, 5691.658500489983, 5748.770049197985, 5750.424957504216, 5767.826965191051, 5797.826065218051, 4560.361549383023, 5292.682439053669, 5363.436839131913, 5404.567634589223, 5419.512243898068, 6301.275353334425, 6318.210223722035, 6332.4934005279465, 6341.3341599132345, 6347.460465860454, 5106.0121411383625, 6212.378762123752, 6226.377362263737, 6269.153664255267, 6274.1843560336865, 6187.195664563578, 6253.593516421418, 6308.495320374451, 6359.8092057238355, 6361.45927596141, 6210.161628180138, 6219.533534984804, 6230.283517395557, 6264.310925798068, 6265.15420418256, 5201.453847346125, 6148.647297594522, 6251.093591429309, 6263.997760358321, 6280.309165991646, 6131.386861313833, 6163.0, 6172.722227499684, 6218.968905155445, 6226.377362263737, 6078.057901025348, 6102.389761023862, 6108.450239478469, 6156.1381406604005, 6160.568760186923, 5744.965906136936, 5773.797917072882, 5870.853228669317, 5873.177755114202, 6030.125631783455, 6074.787382441594, 6132.325444201224, 6157.291911430243, 6170.5372097092, 6199.132121502903, 5173.767180476812, 5917.526597872074, 6016.4585187331595, 6070.9089363658695, 6079.848003799941], "unit": "score", "name": "dojo.html", "value": 5625.217286194848}, {"lowerIsBetter": false, "replicates": [468.0685435982396, 479.8560431870439, 492.7610109097087, 567.687771725551, 608.7504123309444, 37133.62866371335, 37405.06487337818, 37523.24953500935, 37649.0, 37685.43471847924, 38502.807485962534, 38832.41751373732, 38922.0, 38924.22151556967, 38956.831295061194, 9194.862077068832, 9378.718638440823, 9410.952945235298, 9425.952870235673, 9466.857997130048, 8103.797405064862, 9422.52887355633, 9622.951885240564, 9666.033396660348, 9673.758156046084, 8471.195236452528, 9639.0, 9645.469499177543, 9676.467794271312, 9696.612135514571, 9567.42595444272, 9592.95203523978, 9637.373570717951, 9648.614055437809, 9657.0, 9362.859557106649, 9372.95313523435, 9448.149666530046, 9485.905140948571, 9491.19324857388, 37893.242135157416, 38193.809030954944, 38223.61776382229, 38317.85046448611, 38377.42433863494, 2834.4756220099143, 2877.5539791332376, 3126.6873312668777, 3261.9347613047844, 3434.5191673165778, 22599.0, 25956.35109122268, 26200.9519619215, 26339.73660263392, 26523.73476265232, 2318.420394901275, 2797.580362945554, 2826.844523551204, 2860.3993161436124, 2877.84171870547, 284621.1537884636, 307597.0, 317416.0, 319431.0, 426221.8688906567, 55903.44096558982, 62184.68907655523, 64862.675686622206, 65106.0, 65531.0, 61239.69380153071, 61479.07781383283, 61566.69216653888, 61570.384296156466, 62129.0, 15626.76559851603, 15643.139627320606, 15777.132257725705, 15963.920180399024, 16157.192140392934, 11898.643040708792, 12216.694582635328, 12286.938565307117, 12419.813702794465, 12512.186707863959, 17016.234269457906, 20194.192232310543, 20518.076686549142, 20559.074841632162, 20602.072906719233, 7075.433965282868, 7497.925020749832, 7881.330086942559, 7914.762557123296, 7923.841523169504, 922.9907700923039, 972.2562239886493, 998.8152191844387, 1103.768208676187, 1172.0740614914293, 30094.398112038074, 30208.697913021027, 30222.395552089274, 30359.544606830914, 30443.695563044086, 1006.9043440873105, 1063.7500187456096, 1084.9891501085046, 1159.246489781632, 1188.0495603517152, 14362.0, 14370.0, 14415.351309191112, 14734.852651473562, 14804.62988425298, 544564.0, 547041.0, 552368.0, 554531.0, 554798.0, 56136.43863561394, 56162.0, 56403.71798141065, 56617.86764264692, 57148.0, 1410.8730214280558, 1413.484078311409, 1420.801087847702, 1430.6494908747216, 1432.176498513359, 27120.72879271182, 29274.268143296587, 29276.70723292825, 29731.702682972893, 29828.0, 50483.0, 50968.98062038812, 51007.0, 51076.74461627668, 51151.0, 352206.0, 358910.0, 412623.0, 417319.0, 419925.0, 28605.570916435852, 30439.239019024702, 31268.530972034983, 32363.676363236067, 33412.1646958828, 41458.58541414547, 41984.58015419929, 43167.56832431635, 43444.13111737684, 43891.78054109709, 31771.523427149074, 35174.76888308897, 35219.82390088033, 36144.63855361518, 36420.635793641726, 35292.823535882155, 35417.29165416729, 35797.64202357943, 35928.0, 35987.0, 35821.88048374366, 36041.819790900874, 36201.275974480886, 36230.913072607866, 36270.27459450849, 29859.552106718853, 31021.68978310188, 31033.844830775703, 31046.0686179415, 31094.911678091157, 23657.40856478602, 25025.874870625532, 25088.874555627106, 25095.0, 25431.6185257225], "unit": "score", "name": "ext.html", "value": 18984.904806544488}, {"lowerIsBetter": false, "replicates": [361.32612677356724, 366.4905780964459, 366.6187165348038, 371.18710025045146, 372.74280746285046, 15298.541043768677, 18399.46951453599, 19426.1258243379, 19472.902635486822, 19983.60032799345, 18880.150393232303, 18928.1482333295, 19024.524386890334, 19225.903870480626, 19248.807511924875, 4207.200631879949, 5566.443355664442, 5867.677277749722, 5872.706364681749, 6267.185265915425, 6257.499400047986, 6436.613803171825, 6492.318306577812, 6512.153420055386, 6539.4114529692315, 6336.841578960517, 6413.7113829877535, 6426.871462570746, 6434.839129021789, 6441.227052753676, 6233.625982441068, 6394.584352017104, 6510.08858759774, 6519.119918810948, 6526.184226971604, 5436.184572314145, 5583.4137415571595, 5658.094704847204, 5658.405867383906, 5660.915086273709, 23725.525489490286, 24100.79496025192, 24148.275551733477, 24153.03387864501, 24449.0, 2013.5268211970176, 2141.839362047837, 2182.9126834926583, 2185.825133989277, 2393.521295740841, 11671.0, 14045.508407205698, 14129.646758831112, 14622.488212912604, 14709.55871323862, 1490.8658220760183, 1762.488878225313, 1762.5769815244378, 1787.9540468825753, 1822.7630408046869, 87435.0, 94503.63740906533, 95037.0, 96580.0, 103717.0, 9733.707988760349, 9970.700878973643, 10900.400477973788, 11125.777484450266, 11305.152113591514, 13087.738245235041, 13107.475700972045, 13154.276514791587, 13157.013224008238, 13167.144135631153, 8383.413161078666, 8417.579121043924, 8538.274246689101, 8551.657933682707, 8594.312455003585, 7673.887286343449, 8598.742037738877, 8657.350698697623, 8664.0, 8706.52114133716, 3157.715805577509, 4278.871633850989, 4426.490953540319, 4439.533848945879, 4501.527339629357, 1821.9544511387057, 1893.3184053740642, 1895.8578106642058, 1900.914458849355, 1921.5964647424198, 888.9244414224863, 928.5450129436528, 947.393668052447, 1004.4124187350336, 1005.648023191877, 19214.711779323323, 19637.31269405564, 19996.90001550012, 20026.499337516387, 20035.799642003683, 944.8960614332418, 947.1286416496839, 956.297121615612, 993.7714325705128, 1013.9340942838692, 10567.682969510926, 10905.83641245382, 10941.945290273658, 10957.616483423042, 10983.066439352584, 281539.0, 282097.0, 282155.0, 508437.45781270857, 754868.0, 71162.57674846577, 73688.0, 110543.0, 115129.0, 117794.0, 1093.6500319897716, 1137.6871360375796, 1139.9088072954144, 1146.8795776443353, 1176.353005846781, 18289.634207315514, 18314.81685183131, 18676.43970680882, 18737.90631046836, 18896.338628147947, 49254.0, 50298.0, 50685.23972140347, 52433.0, 52463.0, 58364.0, 64485.03272450823, 68551.65724171347, 71688.64155679189, 74364.25635743573, 6280.623162610258, 7422.703091876265, 7600.087989441303, 7685.692572297045, 7705.113911900204, 11393.544258229578, 11797.35114568707, 11820.172587918763, 12010.63968080959, 12140.575079872162, 10279.743006424898, 10327.586896524055, 10418.218633602663, 10444.947775261378, 10547.525361358605, 9864.950675246579, 10256.743581410525, 10332.225083118947, 10381.25587245428, 10647.520861561403, 10043.748906277402, 10256.07695307426, 10758.946205268923, 10839.187060970302, 11134.053605443629, 6362.554621176659, 7686.538807671557, 7708.4218683600075, 7714.922850771645, 7774.105977812624, 9061.0, 10495.527701253615, 10672.733181670521, 10675.786484270426, 10815.891841081488], "unit": "score", "name": "jquery.html", "value": 9182.537402290054}, {"lowerIsBetter": false, "replicates": [1553.4019402530025, 1557.3381312941997, 1638.565780068283, 1797.3260027489691, 1911.5698967732262, 7953.642086106124, 8618.741437756862, 8683.652653893845, 8882.067382924788, 8938.731838044861, 8558.0, 8613.483191008543, 8678.47929124253, 8720.956395218014, 8723.91276087239, 2127.9573009225523, 2472.826902116857, 2483.0, 2486.316263027664, 2492.464120214154, 2420.1166574200465, 2457.717362503317, 2467.5805113130723, 2469.2098528470897, 2470.703515578133, 2049.1086377425795, 2203.713517242756, 2465.2604218734396, 2491.5141547398266, 2500.2874180858457, 2433.184883064158, 2435.5007223519224, 2476.0, 2480.776730094282, 2481.057198264666, 2149.2370208575885, 2403.855768653869, 2475.8885850136785, 2482.8137889658346, 2495.201535508638, 8680.782980425476, 8698.260647844942, 8729.912700873037, 8731.039585645574, 8748.737537873874, 5401.108817045183, 5528.336599608073, 5546.833594992157, 5574.693391863446, 5578.967890940189, 3191.888283910052, 3671.7796932184156, 3681.7238707097076, 3799.3351163546545, 3808.257389808988, 1062.4687656171914, 1065.1053115383115, 1102.685734565645, 1104.4532956186738, 1109.3233127792041, 10741.033307002408, 11120.888791112066, 11965.0, 12003.279803211835, 12140.210886292363, 4861.368022157097, 4939.580135688435, 4962.131626965339, 5000.874978125503, 5017.096922553902, 10252.794944101077, 10287.537060832281, 10363.533640986023, 10386.272960892666, 10402.791944161074, 5419.34967803866, 5423.891522169534, 5510.476504732044, 5517.503424691797, 5554.861128471821, 4022.718409711292, 4876.853694389174, 4943.209086546135, 4986.152354099811, 5048.116579598629, 3951.8024098794945, 3987.720859539804, 3994.9201015979515, 4003.799810009546, 4020.015096301425, 1024.2062401638789, 1297.3124244150615, 1316.8419789625116, 1324.6489680234745, 1325.1452812935602, 1089.8692156941217, 1099.406320586874, 1131.9207655464204, 1254.5170109507724, 1353.2489468345163, 7998.680052797939, 8031.638576264082, 8099.595020249082, 8311.958440207882, 8483.490990540588, 1164.9242799218023, 1182.5388098641536, 1191.398343836357, 1210.5702475621204, 1212.1817773003363, 6293.590916590407, 6341.492680585542, 6385.584936979081, 6433.324500927335, 6448.161738973903, 10530.736731581772, 10593.258471906893, 10836.945815270874, 10959.178061645409, 10975.780484390267, 10253.436061016715, 10640.680779576625, 10867.45662716861, 10922.945385273022, 10997.395143267197, 8290.378221633402, 8402.243798058327, 8424.368172387096, 8475.788105297293, 8505.10696376884, 7680.577568233801, 7788.792737125755, 8239.505629662239, 8302.0, 8379.790505237417, 9594.520273986132, 9912.15746661542, 9949.552270148006, 9977.850332245167, 10058.597656093674, 9614.0, 9729.9027009729, 9817.754556135867, 9863.654772082942, 10374.688759337232, 7503.7748867534065, 7583.886241706489, 7677.309042186007, 7754.418418618739, 7764.262395072459, 8264.090949995376, 8289.129641387568, 8326.29226515753, 8338.916610833814, 8345.833083338177, 7696.396195017892, 7899.723509677134, 7965.4822436541435, 7966.721164759206, 8000.199980002186, 7137.607431591105, 7282.271772822675, 7649.579273140031, 7756.0, 7881.408894333063, 7887.723929662434, 7922.643481043482, 7976.840463190588, 7991.160928102698, 7999.120096789232, 7140.07179066718, 7175.21072682015, 7228.855422891407, 7232.927670723436, 7248.528845625017, 7275.599842008529, 7296.0, 7305.780826575211, 7325.7802265932105, 7351.448641352027], "unit": "score", "name": "mootools.html", "value": 4994.222980539132}, {"lowerIsBetter": false, "replicates": [328.99835500822496, 333.3915604022658, 336.69024497462334, 338.24739953603233, 345.2887052671497, 6832.077669514614, 6964.16430028396, 6973.232944376121, 7041.436685065195, 7073.221945585988, 6899.689513971871, 6942.4446044316455, 6945.826354341144, 6952.721891124349, 6972.825679358006, 4388.539203383647, 5076.8730781730565, 5078.746062696869, 5110.233464980264, 5111.974440127803, 4831.178699621073, 4968.180250258703, 5111.08000559899, 5136.101182293084, 5154.845354639367, 4906.994066216417, 4912.140375434303, 4918.729469879156, 4928.211486162215, 4943.382077240345, 4922.163232250526, 4928.802847886081, 4942.0, 4946.505349465043, 4949.034938187055, 4014.5182578090817, 4112.9717570607345, 4157.688173386978, 4164.604362585549, 4168.895777605554, 6595.802125936181, 6644.60132392058, 6682.866342673168, 6706.631135287557, 6727.697253623599, 5864.5894787364905, 5930.644161350333, 5934.495567876736, 5945.851353716149, 5953.821385358447, 7163.89254161188, 7435.553866768011, 7436.888446673304, 7437.367823734989, 7457.0, 4714.669973101884, 4724.196886529298, 4729.219678753002, 4732.668713190078, 4738.668293219476, 6356.713947872357, 7791.922080779233, 7869.409794265453, 7896.881546776745, 7911.802204944865, 3939.0, 4361.345798130243, 4363.759993200341, 4618.168729628699, 4809.735464549413, 4855.660103792771, 4879.512048795092, 4894.433781189985, 4895.192293271642, 4895.975520122448, 4778.354922085544, 4791.233402655558, 5865.912011319833, 5919.822405327847, 5934.8813023739285, 7313.451491138186, 7477.102747670315, 7485.925140748632, 7489.887651685229, 7508.962455187689, 1660.9335626575044, 1700.2943778331853, 1701.7277235642239, 1705.1303835044216, 1708.7522309265335, 1066.802641511323, 1069.764651776608, 1079.940603266812, 1081.324172392255, 1087.3475914451424, 6860.211075726255, 6904.620245886424, 6916.6541672916155, 6927.238003819576, 6936.861262774716, 7781.766547003599, 7795.571243581658, 7796.766097017098, 7796.881247500932, 7804.102528209215, 6719.865602688016, 6868.9313106869295, 6883.586984780829, 6887.449004079662, 6894.207166175854, 4005.3991901214467, 4068.816903239361, 4104.4664193654635, 4136.131412403369, 4179.2895207814745, 6566.0, 8167.63245653947, 8193.057798353146, 8195.508269503849, 8229.753107406787, 7781.766547003599, 8089.191080891864, 8096.149904259968, 8109.594520273963, 8126.39052071097, 8168.0, 8169.836603267901, 8176.7955801105445, 8193.46742461738, 8209.0, 7853.921460785547, 7881.448298619041, 7884.132745398117, 7907.644156012878, 7920.811878218314, 6258.906116408349, 7437.367823735043, 7624.428167887541, 7653.0, 7672.80817979555, 6411.93588064132, 7088.503804733619, 8124.512529248264, 8173.79565510867, 8181.0, 4992.101421744121, 5043.36957880265, 5052.621053420935, 5063.772130254074, 5063.924041139459, 6228.439440450381, 6415.903761443488, 7746.806329841574, 7756.612169391621, 7803.570803605629, 7449.206547544671, 7462.850742985219, 7466.850662986819, 7472.459363816329, 7499.88750168737, 6039.305479869696, 7193.856122877409, 7456.142543607554, 7462.253774622494, 7505.249475052451, 7006.649667516705, 7262.818429539304, 7338.77983660491, 7369.078865141857, 7376.299251571092, 6434.195725534309, 6566.474682025522, 7403.852402877563, 7516.962415187889, 7525.58609276495, 7136.250693677297, 7260.056192694916, 7277.526960747535, 7289.1981881994, 7298.124225092811], "unit": "score", "name": "prototype.html", "value": 5353.4948162365345}, {"lowerIsBetter": false, "replicates": [647.9935200647993, 663.2207156591005, 693.0747452151378, 700.6916956539122, 723.884178531435, 12070.818937715942, 14068.22624755638, 15038.248087595617, 15103.62240943977, 16697.749533756974, 12567.868891799737, 15335.76996345053, 15399.461018864342, 15438.073715577073, 15447.922760386182, 843.7553109598224, 854.2269246332048, 858.4076986879033, 863.5164307987548, 863.7063398444527, 841.7096101844854, 850.8170743290192, 852.497026754218, 856.2165618459103, 856.3791251342758, 892.1524551675934, 901.4726385064745, 901.5176880369004, 908.9136532029447, 909.6816114359954, 767.3707559800965, 887.0774394629577, 891.335954713736, 896.9506677132755, 898.9730308090768, 645.8449972006731, 650.606383138204, 657.9671016449158, 666.110742159218, 671.2884342596863, 10332.638357657446, 13213.801792973112, 13999.95000374976, 14821.110733356034, 14849.851501484954, 10061.949690251502, 12313.0, 12636.873631263754, 12808.871911280861, 12828.358582070952, 10233.744156396075, 10234.79530409395, 10266.794664106676, 10342.0, 10786.514606842711, 2950.350922796981, 3034.666186719459, 3376.1053320869987, 3474.9305013899834, 3508.438649816043, 71157.6442117786, 71701.64149179221, 71785.64107179483, 74289.0, 74434.99999999946, 9346.859797103049, 9416.0, 9481.051894810602, 9729.41623502578, 9775.804483910282, 20090.799092009183, 20268.79731202669, 20275.898620506803, 20290.492737681678, 20292.79707202909, 6348.143000694847, 7361.742339018108, 7468.178500364956, 7487.0, 7601.703451783751, 4053.452783874139, 4231.513375961742, 4242.809073591696, 4263.444156957729, 4307.461567304087, 3518.9824050879583, 3529.647035296501, 3535.964640353615, 3537.5931767846514, 3545.62770909056, 647.3397134922353, 649.8472858878159, 651.7067319706151, 653.9346065393518, 658.7068754404244, 536.9516743493105, 544.9209864569615, 577.4052725692543, 584.6550535184261, 609.6464050850497, 8580.570971451403, 8678.6528538859, 8733.25767309773, 8740.344474164463, 8785.516796576121, 479.3720226503292, 513.7893463679874, 578.3320265093823, 582.5543459253674, 637.1048676609371, 4165.437665915063, 4248.9787551062045, 4257.955561773285, 4282.443282373271, 4437.467503899488, 91701.16597668009, 92071.61892571617, 93093.60359594612, 93300.66748331346, 95792.52103739437, 74404.88392674114, 74824.25175748282, 75348.62325688337, 76743.0, 77316.0, 70895.99999999897, 71397.2860271401, 71744.64127679433, 71828.28171718217, 72179.0, 7959.442839001214, 8194.0, 8362.707305244287, 8654.82690346202, 8703.54304404625, 48567.0, 48813.51186488089, 49167.26249106195, 50327.74836125796, 51280.743596281776, 51174.74412628062, 67478.0, 68633.97049044368, 68723.96914046194, 69551.95672065024, 10999.175061870232, 11351.772964540498, 11373.488193031168, 11382.0, 11737.589184378507, 10684.145268378355, 10743.946280268861, 10823.40471274056, 12514.249145051326, 12696.936515317364, 10789.784204316027, 10807.13542916549, 11891.821622675494, 11917.0, 11998.220115692453, 11041.723956901142, 11899.345535995257, 11979.460924258256, 11993.460294286604, 12069.456874440846, 11374.31754094757, 11383.487743051417, 11412.48643811047, 11609.316649086004, 11614.825777613174, 7514.0, 9155.633774649206, 9559.808803824024, 9727.173190278623, 9872.851907221253, 8102.878456823035, 9405.576749046173, 9614.990426005168, 9850.162736167505, 10083.546240419051], "unit": "score", "name": "yui.html", "value": 6788.792866943717}], "name": "dromaeo_css", "value": 7500.209317332097}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 108.0, 113.0, 115.0, 115.0, 108.0, 117.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [151.0, 146.0, 146.0, 150.0, 153.0, 135.0, 173.0, 153.0, 145.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [191.0, 198.0, 199.0, 208.0, 244.0, 272.0, 284.0, 221.0, 204.0, 243.0], "unit": "score", "name": "audio-dft", "value": 226.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 124.0, 60.0, 49.0, 78.0, 91.0, 62.0, 75.0], "unit": "score", "name": "audio-fft", "value": 75.7}, {"lowerIsBetter": true, "replicates": [76.0, 84.0, 126.0, 79.0, 79.0, 84.0, 114.0, 81.0, 81.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 92.8}, {"lowerIsBetter": true, "replicates": [87.0, 96.0, 86.0, 87.0, 132.0, 134.0, 87.0, 95.0, 132.0, 135.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 107.1}, {"lowerIsBetter": true, "replicates": [99.0, 152.0, 126.0, 96.0, 123.0, 104.0, 153.0, 99.0, 154.0, 154.0], "unit": "score", "name": "imaging-darkroom", "value": 126.0}, {"lowerIsBetter": true, "replicates": [144.0, 151.0, 108.0, 144.0, 148.0, 128.0, 93.0, 91.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 119.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 56.0, 57.0, 58.0, 59.0, 64.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 55.0, 81.0, 108.0, 107.0, 68.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 75.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 84.0, 85.0, 84.0, 85.0, 87.0, 88.0, 101.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [126.0, 138.0, 146.0, 133.0, 136.0, 144.0, 114.0, 123.0, 117.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.3}, {"lowerIsBetter": true, "replicates": [127.0, 144.0, 142.0, 141.0, 140.0, 167.0, 193.0, 182.0, 146.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 69.0, 67.0, 68.0, 65.0, 69.0, 71.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1580.7}]} 09:51:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1580.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7500.21"}}} 09:51:18 INFO - Return code: 0 09:51:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:51:19 INFO - # TBPL SUCCESS # 09:51:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:51:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:51:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:51:19 INFO - 2016-02-08 09:51:19.032 screenresolution[1700:10749] starting screenresolution argv=screenresolution get 09:51:19 INFO - 2016-02-08 09:51:19.034 screenresolution[1700:10749] Display 0: 1600x1200x32@50 09:51:19 INFO - 2016-02-08 09:51:19.040 screenresolution[1701:10752] starting screenresolution argv=screenresolution list 09:51:19 INFO - Available Modes on Display 0 09:51:19 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 09:51:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:51:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:51:19 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 09:51:19 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 09:51:19 INFO - Graphics/Displays: 09:51:19 INFO - Intel Iris: 09:51:19 INFO - Chipset Model: Intel Iris 09:51:19 INFO - Type: GPU 09:51:19 INFO - Bus: Built-In 09:51:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:51:19 INFO - Vendor: Intel (0x8086) 09:51:19 INFO - Device ID: 0x0a2e 09:51:19 INFO - Revision ID: 0x0009 09:51:19 INFO - Displays: 09:51:19 INFO - Display: 09:51:19 INFO - Resolution: 1600 x 1200 @ 50 Hz 09:51:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:51:19 INFO - Display Serial Number: 1600x1200 50 09:51:19 INFO - Main Display: Yes 09:51:19 INFO - Mirror: Off 09:51:19 INFO - Online: Yes 09:51:19 INFO - Rotation: Supported 09:51:19 INFO - Return code: 0 09:51:19 INFO - Running post-action listener: _resource_record_post_action 09:51:19 INFO - Running post-run listener: _resource_record_post_run 09:51:20 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34000384; Write bytes: 713556480; Read time: 354; Write time: 1992 09:51:20 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397517312; Write bytes: 391984640; Read time: 29718; Write time: 717 09:51:20 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32206336; Write bytes: 303791104; Read time: 335; Write time: 1233 09:51:20 INFO - Running post-run listener: _upload_blobber_files 09:51:20 INFO - Blob upload gear active. 09:51:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:51:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:51:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:21 INFO - (blobuploader) - INFO - Done attempting. 09:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:22 INFO - (blobuploader) - INFO - Done attempting. 09:51:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:51:22 INFO - Return code: 0 09:51:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:51:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:51:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccabe0ba85a09f16a20b37a962691507b4f9b22781e2de9291d1f3d40f151f28ec46d736d08d0a7d6cda730e3ffd8f31477cb950b579f255348fa8397138396d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f038fc9b970a6f082ecf6d79b1770e33c40a8983555bed2ecacbab555fcc68ce98e99af833ada20d6fdf059b6c8f95d24106a1ae01a79fded6cf626577adc5b"} 09:51:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:51:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:51:22 INFO - Contents: 09:51:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ccabe0ba85a09f16a20b37a962691507b4f9b22781e2de9291d1f3d40f151f28ec46d736d08d0a7d6cda730e3ffd8f31477cb950b579f255348fa8397138396d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f038fc9b970a6f082ecf6d79b1770e33c40a8983555bed2ecacbab555fcc68ce98e99af833ada20d6fdf059b6c8f95d24106a1ae01a79fded6cf626577adc5b"} 09:51:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:51:22 INFO - Copying logs to upload dir... 09:51:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:51:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.931841 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-02-08 09:51:22.540901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 09:51:22.544897) ========= 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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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/ccabe0ba85a09f16a20b37a962691507b4f9b22781e2de9291d1f3d40f151f28ec46d736d08d0a7d6cda730e3ffd8f31477cb950b579f255348fa8397138396d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f038fc9b970a6f082ecf6d79b1770e33c40a8983555bed2ecacbab555fcc68ce98e99af833ada20d6fdf059b6c8f95d24106a1ae01a79fded6cf626577adc5b"} build_url:https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/b_GK5HHaTBKtd8mMgBF3sw/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/ccabe0ba85a09f16a20b37a962691507b4f9b22781e2de9291d1f3d40f151f28ec46d736d08d0a7d6cda730e3ffd8f31477cb950b579f255348fa8397138396d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f038fc9b970a6f082ecf6d79b1770e33c40a8983555bed2ecacbab555fcc68ce98e99af833ada20d6fdf059b6c8f95d24106a1ae01a79fded6cf626577adc5b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 09:51:22.576218) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:51:22.576603) ========= 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.wan4V9gqkK/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.LYwCq8ylky/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/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.005083 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:51:22.626323) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 09:51:22.629708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 09:51:22.630103) ========= ========= Total master_lag: 0.39 =========