builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0165 starttime: 1458290854.68 results: success (0) buildid: 20160318000913 builduid: 8a917d5d8c0c4d109ec09add4e47f6f2 revision: 0e729ba9f2bf518876ce87959ae4a95827f68935 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.677410) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.677828) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.678135) ========= 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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005647 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.708138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.708440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.729426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.729715) ========= 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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005551 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.781733) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.782064) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.782423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.782699) ========= 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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-18 01:47:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.9M=0s 2016-03-18 01:47:34 (24.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.929114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.929426) ========= 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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.025786 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.978136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:34.978952) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0e729ba9f2bf518876ce87959ae4a95827f68935 --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 0e729ba9f2bf518876ce87959ae4a95827f68935 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-18 01:47:35,056 truncating revision to first 12 chars 2016-03-18 01:47:35,057 Setting DEBUG logging. 2016-03-18 01:47:35,057 attempt 1/10 2016-03-18 01:47:35,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0e729ba9f2bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 01:47:35,646 unpacking tar archive at: fx-team-0e729ba9f2bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:35.831728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:35.832095) ========= echo 0e729ba9f2bf518876ce87959ae4a95827f68935 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0e729ba9f2bf518876ce87959ae4a95827f68935'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 0e729ba9f2bf518876ce87959ae4a95827f68935 program finished with exit code 0 elapsedTime=0.005209 script_repo_revision: '0e729ba9f2bf518876ce87959ae4a95827f68935' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:35.881205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:35.881497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 01:47:35.894895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-03-18 01:47:35.895177) ========= /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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:47:36 INFO - MultiFileLogger online at 20160318 01:47:36 in /builds/slave/test 01:47:36 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 01:47:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:47:36 INFO - {'append_to_log': False, 01:47:36 INFO - 'base_work_dir': '/builds/slave/test', 01:47:36 INFO - 'blob_upload_branch': 'Fx-Team', 01:47:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:47:36 INFO - 'branch': 'Fx-Team', 01:47:36 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:36 INFO - 'config_files': ('talos/mac_config.py',), 01:47:36 INFO - 'default_actions': ('clobber', 01:47:36 INFO - 'read-buildbot-config', 01:47:36 INFO - 'download-and-extract', 01:47:36 INFO - 'populate-webroot', 01:47:36 INFO - 'create-virtualenv', 01:47:36 INFO - 'install', 01:47:36 INFO - 'run-tests'), 01:47:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:36 INFO - 'download_minidump_stackwalk': True, 01:47:36 INFO - 'download_symbols': 'ondemand', 01:47:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:47:36 INFO - 'tooltool.py': '/tools/tooltool.py', 01:47:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:47:36 INFO - '/tools/misc-python/virtualenv.py')}, 01:47:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:36 INFO - 'installer_path': 'installer.exe', 01:47:36 INFO - 'log_level': 'info', 01:47:36 INFO - 'log_name': 'talos', 01:47:36 INFO - 'log_to_console': True, 01:47:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:47:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:47:36 INFO - 'opt_config_files': (), 01:47:36 INFO - 'pip_index': False, 01:47:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:47:36 INFO - 'cmd': ('bash', 01:47:36 INFO - '-c', 01:47:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:47:36 INFO - 'enabled': True, 01:47:36 INFO - 'halt_on_failure': False, 01:47:36 INFO - 'name': 'check_screen_resolution'},), 01:47:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:47:36 INFO - 'cmd': ('bash', 01:47:36 INFO - '-c', 01:47:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:47:36 INFO - 'enabled': True, 01:47:36 INFO - 'halt_on_failure': False, 01:47:36 INFO - 'name': 'check_screen_resolution'},), 01:47:36 INFO - 'run_cmd_checks_enabled': True, 01:47:36 INFO - 'sps_profile': False, 01:47:36 INFO - 'sps_profile_interval': 0, 01:47:36 INFO - 'suite': 'dromaeojs-e10s', 01:47:36 INFO - 'system_bits': '32', 01:47:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:36 INFO - 'title': 't-yosemite-r7-0165', 01:47:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:36 INFO - 'use_talos_json': True, 01:47:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:47:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:36 INFO - 'work_dir': 'build'} 01:47:36 INFO - ##### 01:47:36 INFO - ##### Running clobber step. 01:47:36 INFO - ##### 01:47:36 INFO - Running pre-action listener: _resource_record_pre_action 01:47:36 INFO - Running main action method: clobber 01:47:36 INFO - rmtree: /builds/slave/test/build 01:47:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:47:37 INFO - Running post-action listener: _resource_record_post_action 01:47:37 INFO - ##### 01:47:37 INFO - ##### Running read-buildbot-config step. 01:47:37 INFO - ##### 01:47:37 INFO - Running pre-action listener: _resource_record_pre_action 01:47:37 INFO - Running main action method: read_buildbot_config 01:47:37 INFO - Using buildbot properties: 01:47:37 INFO - { 01:47:37 INFO - "project": "", 01:47:37 INFO - "product": "firefox", 01:47:37 INFO - "script_repo_revision": "production", 01:47:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:47:37 INFO - "repository": "", 01:47:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:47:37 INFO - "buildid": "20160318000913", 01:47:37 INFO - "pgo_build": "False", 01:47:37 INFO - "basedir": "/builds/slave/test", 01:47:37 INFO - "buildnumber": 546, 01:47:37 INFO - "slavename": "t-yosemite-r7-0165", 01:47:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:47:37 INFO - "platform": "yosemite_r7", 01:47:37 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:47:37 INFO - "branch": "fx-team", 01:47:37 INFO - "repo_path": "integration/fx-team", 01:47:37 INFO - "revision": "0e729ba9f2bf518876ce87959ae4a95827f68935", 01:47:37 INFO - "stage_platform": "macosx64", 01:47:37 INFO - "builduid": "8a917d5d8c0c4d109ec09add4e47f6f2", 01:47:37 INFO - "slavebuilddir": "test" 01:47:37 INFO - } 01:47:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:47:37 INFO - Running post-action listener: _resource_record_post_action 01:47:37 INFO - ##### 01:47:37 INFO - ##### Running download-and-extract step. 01:47:37 INFO - ##### 01:47:37 INFO - Running pre-action listener: _resource_record_pre_action 01:47:37 INFO - Running main action method: download_and_extract 01:47:37 INFO - mkdir: /builds/slave/test/build/tests 01:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:37 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 01:47:39 INFO - Downloaded 1199 bytes. 01:47:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:47:39 INFO - Using the following test package requirements: 01:47:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:47:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:47:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:47:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'jsshell-mac.zip'], 01:47:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:47:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:47:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:47:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:47:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:47:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:47:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:47:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:39 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:47:40 INFO - Downloaded 17870538 bytes. 01:47:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:47:43 INFO - Return code: 0 01:47:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:43 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:47:44 INFO - Downloaded 17870538 bytes. 01:47:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:47:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:47:47 INFO - Return code: 0 01:47:47 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')]} 01:47:47 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:47:48 INFO - Downloaded 10846565 bytes. 01:47:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:47:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:47:49 INFO - Return code: 0 01:47: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')]} 01:47:49 INFO - https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 01:47:55 INFO - Downloaded 111172516 bytes. 01:47:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:47:55 INFO - mkdir: /builds/slave/test/properties 01:47:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:47:55 INFO - Writing to file /builds/slave/test/properties/build_url 01:47:55 INFO - Contents: 01:47:55 INFO - build_url:https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:47:56 INFO - Running post-action listener: _resource_record_post_action 01:47:56 INFO - Running post-action listener: set_extra_try_arguments 01:47:56 INFO - ##### 01:47:56 INFO - ##### Running populate-webroot step. 01:47:56 INFO - ##### 01:47:56 INFO - Running pre-action listener: _resource_record_pre_action 01:47:56 INFO - Running main action method: populate_webroot 01:47:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:47:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:47:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:47:56 INFO - '--tppagecycles', 01:47:56 INFO - '7'], 01:47:56 INFO - 'tests': ['tsvgm']}}, 01:47:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:47:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:47:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:47:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:47:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'tests': ['damp', 'tps']}, 01:47:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['damp', 'tps']}, 01:47:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:47:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:47:56 INFO - 'other': {'tests': ['a11yr', 01:47:56 INFO - 'ts_paint', 01:47:56 INFO - 'tpaint', 01:47:56 INFO - 'sessionrestore', 01:47:56 INFO - 'sessionrestore_no_auto_restore', 01:47:56 INFO - 'tabpaint']}, 01:47:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['a11yr', 01:47:56 INFO - 'ts_paint', 01:47:56 INFO - 'tpaint', 01:47:56 INFO - 'sessionrestore', 01:47:56 INFO - 'sessionrestore_no_auto_restore', 01:47:56 INFO - 'tabpaint']}, 01:47:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['a11yr', 01:47:56 INFO - 'ts_paint', 01:47:56 INFO - 'tpaint', 01:47:56 INFO - 'sessionrestore', 01:47:56 INFO - 'sessionrestore_no_auto_restore', 01:47:56 INFO - 'tabpaint']}, 01:47:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['a11yr', 01:47:56 INFO - 'ts_paint', 01:47:56 INFO - 'tpaint', 01:47:56 INFO - 'sessionrestore', 01:47:56 INFO - 'sessionrestore_no_auto_restore', 01:47:56 INFO - 'tabpaint']}, 01:47:56 INFO - 'other_l64': {'tests': ['a11yr', 01:47:56 INFO - 'ts_paint', 01:47:56 INFO - 'tpaint', 01:47:56 INFO - 'sessionrestore', 01:47:56 INFO - 'sessionrestore_no_auto_restore', 01:47:56 INFO - 'tabpaint']}, 01:47:56 INFO - 'other_nol64': {'tests': ['a11yr', 01:47:56 INFO - 'ts_paint', 01:47:56 INFO - 'tpaint', 01:47:56 INFO - 'sessionrestore', 01:47:56 INFO - 'sessionrestore_no_auto_restore', 01:47:56 INFO - 'tabpaint']}, 01:47:56 INFO - 'svgr': {'tests': ['tsvgx', 01:47:56 INFO - 'tsvgr_opacity', 01:47:56 INFO - 'tart', 01:47:56 INFO - 'tscrollx', 01:47:56 INFO - 'cart']}, 01:47:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['tsvgx', 01:47:56 INFO - 'tsvgr_opacity', 01:47:56 INFO - 'tart', 01:47:56 INFO - 'tscrollx', 01:47:56 INFO - 'cart']}, 01:47:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'tests': ['tp5o']}, 01:47:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'talos_options': ['--e10s'], 01:47:56 INFO - 'tests': ['tp5o']}, 01:47:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'talos_options': ['--xperf_path', 01:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:56 INFO - 'tests': ['tp5n']}, 01:47:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:56 INFO - 'talos_options': ['--e10s', 01:47:56 INFO - '--xperf_path', 01:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:56 INFO - 'tests': ['tp5n']}}, 01:47:56 INFO - 'talos.zip': {'path': '', 01:47:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:47:56 INFO - Running post-action listener: _resource_record_post_action 01:47:56 INFO - ##### 01:47:56 INFO - ##### Running create-virtualenv step. 01:47:56 INFO - ##### 01:47:56 INFO - Running pre-action listener: _resource_record_pre_action 01:47:56 INFO - Running main action method: create_virtualenv 01:47:56 INFO - Creating virtualenv /builds/slave/test/build/venv 01:47:56 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 01:47:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:47:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:47:56 INFO - Using real prefix '/tools/python27' 01:47:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:47:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:00 INFO - Installing pip.................done. 01:48:00 INFO - Return code: 0 01:48:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:48:00 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')]} 01:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 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')]} 01:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:00 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 01:48:00 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 01:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:00 INFO - 'HOME': '/Users/cltbld', 01:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:00 INFO - 'LOGNAME': 'cltbld', 01:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:00 INFO - 'MOZ_NO_REMOTE': '1', 01:48:00 INFO - 'NO_EM_RESTART': '1', 01:48:00 INFO - 'PAGER': '/bin/cat', 01:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:00 INFO - 'PWD': '/builds/slave/test', 01:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:00 INFO - 'SHELL': '/bin/bash', 01:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:00 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:00 INFO - 'USER': 'cltbld', 01:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:00 INFO - 'XPC_FLAGS': '0x0', 01:48:00 INFO - 'XPC_SERVICE_NAME': '0', 01:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:00 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 01:48:00 INFO - Cleaning up... 01:48:00 INFO - Return code: 0 01:48:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:48:00 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')]} 01:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 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')]} 01:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:00 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:00 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 01:48:00 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 01:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:00 INFO - 'HOME': '/Users/cltbld', 01:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:00 INFO - 'LOGNAME': 'cltbld', 01:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:00 INFO - 'MOZ_NO_REMOTE': '1', 01:48:00 INFO - 'NO_EM_RESTART': '1', 01:48:00 INFO - 'PAGER': '/bin/cat', 01:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:00 INFO - 'PWD': '/builds/slave/test', 01:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:00 INFO - 'SHELL': '/bin/bash', 01:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:00 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:00 INFO - 'USER': 'cltbld', 01:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:00 INFO - 'XPC_FLAGS': '0x0', 01:48:00 INFO - 'XPC_SERVICE_NAME': '0', 01:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:00 INFO - Downloading/unpacking psutil>=0.7.1 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:48:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:03 INFO - Installing collected packages: psutil 01:48:03 INFO - Running setup.py install for psutil 01:48:03 INFO - building 'psutil._psutil_osx' extension 01:48:03 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 01:48:04 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 01:48:04 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 01:48:04 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 01:48:04 INFO - building 'psutil._psutil_posix' extension 01:48:04 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 01:48:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:48:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:48:04 INFO - ^ 01:48:04 INFO - 1 warning generated. 01:48:04 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 01:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:04 INFO - Successfully installed psutil 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:48:04 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')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:04 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 01:48:04 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 01:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:04 INFO - 'HOME': '/Users/cltbld', 01:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PAGER': '/bin/cat', 01:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test', 01:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:04 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - 'XPC_FLAGS': '0x0', 01:48:04 INFO - 'XPC_SERVICE_NAME': '0', 01:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:48:07 INFO - Installing collected packages: mozsystemmonitor 01:48:07 INFO - Running setup.py install for mozsystemmonitor 01:48:07 INFO - Successfully installed mozsystemmonitor 01:48:07 INFO - Cleaning up... 01:48:07 INFO - Return code: 0 01:48:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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', '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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:48: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 blobuploader==1.2.4 01:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:07 INFO - 'HOME': '/Users/cltbld', 01:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:07 INFO - 'LOGNAME': 'cltbld', 01:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:07 INFO - 'MOZ_NO_REMOTE': '1', 01:48:07 INFO - 'NO_EM_RESTART': '1', 01:48:07 INFO - 'PAGER': '/bin/cat', 01:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:07 INFO - 'PWD': '/builds/slave/test', 01:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:07 INFO - 'SHELL': '/bin/bash', 01:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:07 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:07 INFO - 'USER': 'cltbld', 01:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:07 INFO - 'XPC_FLAGS': '0x0', 01:48:07 INFO - 'XPC_SERVICE_NAME': '0', 01:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:07 INFO - Downloading/unpacking blobuploader==1.2.4 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:10 INFO - Downloading blobuploader-1.2.4.tar.gz 01:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:48:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:48:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:11 INFO - Downloading docopt-0.6.1.tar.gz 01:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:48:11 INFO - Installing collected packages: blobuploader, requests, docopt 01:48:11 INFO - Running setup.py install for blobuploader 01:48:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:48:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:48:11 INFO - Running setup.py install for requests 01:48:12 INFO - Running setup.py install for docopt 01:48:12 INFO - Successfully installed blobuploader requests docopt 01:48:12 INFO - Cleaning up... 01:48:12 INFO - Return code: 0 01:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:12 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')]} 01:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:12 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')]} 01:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:12 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:12 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 01:48:12 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 01:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:12 INFO - 'HOME': '/Users/cltbld', 01:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:12 INFO - 'LOGNAME': 'cltbld', 01:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:12 INFO - 'MOZ_NO_REMOTE': '1', 01:48:12 INFO - 'NO_EM_RESTART': '1', 01:48:12 INFO - 'PAGER': '/bin/cat', 01:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:12 INFO - 'PWD': '/builds/slave/test', 01:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:12 INFO - 'SHELL': '/bin/bash', 01:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:12 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:12 INFO - 'USER': 'cltbld', 01:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:12 INFO - 'XPC_FLAGS': '0x0', 01:48:12 INFO - 'XPC_SERVICE_NAME': '0', 01:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:12 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-XOUsEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:12 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JX7ND_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:12 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JC5IXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-x5kw00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-_Kd59V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-I1esKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-jOyz_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-hfF7v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-I7lUlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-NR9s8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-HrdXKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-jUi3_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:13 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-qzpHgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:14 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-FovgfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:14 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-CrZvVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:14 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Ep_DYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:14 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-NFnIvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:48:14 INFO - Running setup.py install for manifestparser 01:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:48:14 INFO - Running setup.py install for mozcrash 01:48:14 INFO - Running setup.py install for mozdebug 01:48:14 INFO - Running setup.py install for mozdevice 01:48:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozfile 01:48:15 INFO - Running setup.py install for mozhttpd 01:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozinfo 01:48:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozInstall 01:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for mozleak 01:48:15 INFO - Running setup.py install for mozlog 01:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:48:15 INFO - Running setup.py install for moznetwork 01:48:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozprocess 01:48:16 INFO - Running setup.py install for mozprofile 01:48:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozrunner 01:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Running setup.py install for mozscreenshot 01:48:16 INFO - Running setup.py install for moztest 01:48:16 INFO - Running setup.py install for mozversion 01:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:16 INFO - Cleaning up... 01:48:17 INFO - Return code: 0 01:48:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:17 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')]} 01:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 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')]} 01:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:17 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 01:48:17 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 01:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:17 INFO - 'HOME': '/Users/cltbld', 01:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:17 INFO - 'LOGNAME': 'cltbld', 01:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:17 INFO - 'MOZ_NO_REMOTE': '1', 01:48:17 INFO - 'NO_EM_RESTART': '1', 01:48:17 INFO - 'PAGER': '/bin/cat', 01:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:17 INFO - 'PWD': '/builds/slave/test', 01:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:17 INFO - 'SHELL': '/bin/bash', 01:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:17 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:17 INFO - 'USER': 'cltbld', 01:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:17 INFO - 'XPC_FLAGS': '0x0', 01:48:17 INFO - 'XPC_SERVICE_NAME': '0', 01:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-x51qWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:17 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)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-nFvSaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-IDglB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:17 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)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-X0S_yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:17 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)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-IR17Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:17 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)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-vvrjPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:17 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)) 01:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:17 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-VdaCKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-bRirMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Rpv6cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Zt9t15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-H0h5Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-YQ_pg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-mDPZE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-EbUpVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-OQorSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:18 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)) 01:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:18 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-FaOSig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:19 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)) 01:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:19 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Qt562Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:19 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)) 01:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:19 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)) 01:48:19 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)) 01:48:19 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)) 01:48:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:19 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 01:48:19 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 01:48:19 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 01:48:19 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 01:48:19 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 01:48:19 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 01:48:21 INFO - Downloading blessings-1.6.tar.gz 01:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:21 INFO - Installing collected packages: blessings 01:48:21 INFO - Running setup.py install for blessings 01:48:21 INFO - Successfully installed blessings 01:48:21 INFO - Cleaning up... 01:48:21 INFO - Return code: 0 01:48:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:22 INFO - Reading from file tmpfile_stdout 01:48:22 INFO - Current package versions: 01:48:22 INFO - blessings == 1.6 01:48:22 INFO - blobuploader == 1.2.4 01:48:22 INFO - docopt == 0.6.1 01:48:22 INFO - manifestparser == 1.1 01:48:22 INFO - mozInstall == 1.12 01:48:22 INFO - mozcrash == 0.17 01:48:22 INFO - mozdebug == 0.1 01:48:22 INFO - mozdevice == 0.48 01:48:22 INFO - mozfile == 1.2 01:48:22 INFO - mozhttpd == 0.7 01:48:22 INFO - mozinfo == 0.9 01:48:22 INFO - mozleak == 0.1 01:48:22 INFO - mozlog == 3.1 01:48:22 INFO - moznetwork == 0.27 01:48:22 INFO - mozprocess == 0.22 01:48:22 INFO - mozprofile == 0.28 01:48:22 INFO - mozrunner == 6.11 01:48:22 INFO - mozscreenshot == 0.1 01:48:22 INFO - mozsystemmonitor == 0.0 01:48:22 INFO - moztest == 0.7 01:48:22 INFO - mozversion == 1.4 01:48:22 INFO - psutil == 3.1.1 01:48:22 INFO - requests == 1.2.3 01:48:22 INFO - wsgiref == 0.1.2 01:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:22 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')]} 01:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:22 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')]} 01:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:22 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:22 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 01:48:22 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 01:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:22 INFO - 'HOME': '/Users/cltbld', 01:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:22 INFO - 'LOGNAME': 'cltbld', 01:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:22 INFO - 'MOZ_NO_REMOTE': '1', 01:48:22 INFO - 'NO_EM_RESTART': '1', 01:48:22 INFO - 'PAGER': '/bin/cat', 01:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:22 INFO - 'PWD': '/builds/slave/test', 01:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:22 INFO - 'SHELL': '/bin/bash', 01:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:22 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:22 INFO - 'USER': 'cltbld', 01:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:22 INFO - 'XPC_FLAGS': '0x0', 01:48:22 INFO - 'XPC_SERVICE_NAME': '0', 01:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 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)) 01:48:22 INFO - Cleaning up... 01:48:22 INFO - Return code: 0 01:48:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48:22 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')]} 01:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:22 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')]} 01:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:22 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:22 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 01:48:22 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 01:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:22 INFO - 'HOME': '/Users/cltbld', 01:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:22 INFO - 'LOGNAME': 'cltbld', 01:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:22 INFO - 'MOZ_NO_REMOTE': '1', 01:48:22 INFO - 'NO_EM_RESTART': '1', 01:48:22 INFO - 'PAGER': '/bin/cat', 01:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:22 INFO - 'PWD': '/builds/slave/test', 01:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:22 INFO - 'SHELL': '/bin/bash', 01:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:22 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:22 INFO - 'USER': 'cltbld', 01:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:22 INFO - 'XPC_FLAGS': '0x0', 01:48:22 INFO - 'XPC_SERVICE_NAME': '0', 01:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:22 INFO - Downloading/unpacking jsonschema 01:48:22 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 01:48:22 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 01:48:22 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 01:48:22 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 01:48:22 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 01:48:22 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 01:48:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:25 INFO - Downloading/unpacking functools32 (from jsonschema) 01:48:25 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 01:48:25 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 01:48:25 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 01:48:25 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 01:48:25 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 01:48:25 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 01:48:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:25 INFO - warning: no files found matching '*.txt' 01:48:25 INFO - no previously-included directories found matching 'build' 01:48:25 INFO - no previously-included directories found matching 'dist' 01:48:25 INFO - no previously-included directories found matching '.git*' 01:48:25 INFO - Installing collected packages: jsonschema, functools32 01:48:25 INFO - Running setup.py install for functools32 01:48:25 INFO - warning: no files found matching '*.txt' 01:48:25 INFO - no previously-included directories found matching 'build' 01:48:25 INFO - no previously-included directories found matching 'dist' 01:48:25 INFO - no previously-included directories found matching '.git*' 01:48:25 INFO - Successfully installed jsonschema functools32 01:48:25 INFO - Cleaning up... 01:48:25 INFO - Return code: 0 01:48:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:25 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 0x110338a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110348420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa50b4aad30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, '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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 01:48:25 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 01:48:25 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 01:48:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:48:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:25 INFO - 'HOME': '/Users/cltbld', 01:48:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:25 INFO - 'LOGNAME': 'cltbld', 01:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:25 INFO - 'MOZ_NO_REMOTE': '1', 01:48:25 INFO - 'NO_EM_RESTART': '1', 01:48:25 INFO - 'PAGER': '/bin/cat', 01:48:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:25 INFO - 'PWD': '/builds/slave/test', 01:48:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:25 INFO - 'SHELL': '/bin/bash', 01:48:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:48:25 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:48:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:25 INFO - 'USER': 'cltbld', 01:48:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:25 INFO - 'XPC_FLAGS': '0x0', 01:48:25 INFO - 'XPC_SERVICE_NAME': '0', 01:48:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:26 INFO - Downloading/unpacking flake8 01:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:48:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:48:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 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 01:48:28 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 01:48:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:48:29 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 01:48:29 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 01:48:29 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 01:48:29 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 01:48:29 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 01:48:29 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 01:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:29 INFO - no previously-included directories found matching 'docs/_build' 01:48:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:48:29 INFO - Running setup.py install for pep8 01:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:29 INFO - no previously-included directories found matching 'docs/_build' 01:48:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:48:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:48:29 INFO - Cleaning up... 01:48:30 INFO - Return code: 0 01:48:30 INFO - Running post-action listener: _resource_record_post_action 01:48:30 INFO - Running post-action listener: _start_resource_monitoring 01:48:30 INFO - Starting resource monitoring. 01:48:30 INFO - ##### 01:48:30 INFO - ##### Running install step. 01:48:30 INFO - ##### 01:48:30 INFO - Running pre-action listener: _resource_record_pre_action 01:48:30 INFO - Running main action method: install 01:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:30 INFO - Reading from file tmpfile_stdout 01:48:30 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:48:30 INFO - Reading from file tmpfile_stdout 01:48:30 INFO - Output received: 01:48:30 INFO - Usage: mozinstall [options] installer 01:48:30 INFO - Options: 01:48:30 INFO - -h, --help show this help message and exit 01:48:30 INFO - -d DEST, --destination=DEST 01:48:30 INFO - Directory to install application into. [default: 01:48:30 INFO - "/builds/slave/test"] 01:48:30 INFO - --app=APP Application being installed. [default: firefox] 01:48:30 INFO - mkdir: /builds/slave/test/build/application 01:48:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:49:04 INFO - Reading from file tmpfile_stdout 01:49:04 INFO - Output received: 01:49:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:49:04 INFO - Running post-action listener: _resource_record_post_action 01:49:04 INFO - ##### 01:49:04 INFO - ##### Running run-tests step. 01:49:04 INFO - ##### 01:49:04 INFO - Running pre-action listener: _resource_record_pre_action 01:49:04 INFO - Running main action method: run_tests 01:49:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:04 INFO - 2016-03-18 01:49:04.352 screenresolution[1637:7578] starting screenresolution argv=screenresolution get 01:49:04 INFO - 2016-03-18 01:49:04.355 screenresolution[1637:7578] Display 0: 1600x1200x32@60 01:49:04 INFO - 2016-03-18 01:49:04.361 screenresolution[1638:7580] starting screenresolution argv=screenresolution list 01:49:04 INFO - Available Modes on Display 0 01:49:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:04 INFO - Intel Iris: 01:49:04 INFO - Chipset Model: Intel Iris 01:49:04 INFO - Type: GPU 01:49:04 INFO - Bus: Built-In 01:49:04 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:04 INFO - Vendor: Intel (0x8086) 01:49:04 INFO - Device ID: 0x0a2e 01:49:04 INFO - Revision ID: 0x0009 01:49:04 INFO - Displays: 01:49:04 INFO - Display: 01:49:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:04 INFO - Display Serial Number: 1600x1200 60 01:49:04 INFO - Main Display: Yes 01:49:04 INFO - Mirror: Off 01:49:04 INFO - Online: Yes 01:49:04 INFO - Rotation: Supported 01:49:04 INFO - Return code: 0 01:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:49:04 INFO - Python 2.7.3 01:49:04 INFO - Return code: 0 01:49:04 INFO - grabbing minidump binary from tooltool 01:49:04 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')]} 01:49:04 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 0x1101d7e00>, '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 0x110040db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1101d2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:49:04 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 01:49:04 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 01:49:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:04 INFO - Return code: 0 01:49:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:49:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:49:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:49:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:49:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:49:05 INFO - Return code: 0 01:49:05 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/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--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 01:49:05 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/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --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 01:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aj4oGWRVU6/Render', 01:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:05 INFO - 'HOME': '/Users/cltbld', 01:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:05 INFO - 'LOGNAME': 'cltbld', 01:49:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:49:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:05 INFO - 'MOZ_NO_REMOTE': '1', 01:49:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:49:05 INFO - 'NO_EM_RESTART': '1', 01:49:05 INFO - 'PAGER': '/bin/cat', 01:49:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:05 INFO - 'PWD': '/builds/slave/test', 01:49:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:05 INFO - 'SHELL': '/bin/bash', 01:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VWhBxDO9zi/Listeners', 01:49:05 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 01:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:05 INFO - 'USER': 'cltbld', 01:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:05 INFO - 'XPC_FLAGS': '0x0', 01:49:05 INFO - 'XPC_SERVICE_NAME': '0', 01:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:05 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/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--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 01:49:06 INFO - mozversion application_buildid: 20160318000913 01:49:06 INFO - mozversion application_changeset: 0e729ba9f2bf518876ce87959ae4a95827f68935 01:49:06 INFO - mozversion application_display_name: Nightly 01:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:49:06 INFO - mozversion application_name: Firefox 01:49:06 INFO - mozversion application_remotingname: firefox 01:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:49:06 INFO - mozversion application_vendor: Mozilla 01:49:06 INFO - mozversion application_version: 48.0a1 01:49:06 INFO - mozversion platform_buildid: 20160318000913 01:49:06 INFO - mozversion platform_changeset: 0e729ba9f2bf518876ce87959ae4a95827f68935 01:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:49:06 INFO - mozversion platform_version: 48.0a1 01:49:06 INFO - using testdate: 1458290946 01:49:06 INFO - actual date: 1458290946 01:49:06 INFO - starting webserver on 'localhost:49272' 01:49:06 INFO - SUITE-START | Running 2 tests 01:49:06 INFO - TEST-START | dromaeo_css 01:49:06 INFO - operating with platform_type : mac_ 01:49:06 INFO - Initialising browser for dromaeo_css test... 01:49:06 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmprMogJm/profile http://localhost:49272/getInfo.html) 01:49:08 INFO - PROCESS | 1656 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 01:49:09 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 01:49:09 INFO - PROCESS | 1656 | colorDepth:24 01:49:09 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 01:49:09 INFO - PROCESS | 1656 | __metrics 01:49:09 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 01:49:09 INFO - TEST-INFO | 1656: exit 0 01:49:09 INFO - Browser initialized. 01:49:09 INFO - Running cycle 1/1 for dromaeo_css test... 01:49:09 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmprMogJm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:49:21 INFO - PROCESS | 1660 | RSS: Main: 255647744 01:49:21 INFO - PROCESS | 1660 | 01:50:11 INFO - PROCESS | 1660 | 1458291011461 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] 01:52:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 01:52:23 INFO - PROCESS | 1660 | RSS: Main: 268062720 01:52:23 INFO - PROCESS | 1660 | 01:55:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 01:55:26 INFO - PROCESS | 1660 | RSS: Main: 281305088 01:55:26 INFO - PROCESS | 1660 | 01:58:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 01:58:28 INFO - PROCESS | 1660 | RSS: Main: 282529792 01:58:28 INFO - PROCESS | 1660 | 02:01:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:01:31 INFO - PROCESS | 1660 | RSS: Main: 283770880 02:01:31 INFO - PROCESS | 1660 | 02:04:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:04:34 INFO - PROCESS | 1660 | RSS: Main: 286150656 02:04:34 INFO - PROCESS | 1660 | 02:07:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:07:37 INFO - PROCESS | 1660 | RSS: Main: 289558528 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | __start_tp_report 02:07:37 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 02:07:37 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 02:07:37 INFO - PROCESS | 1660 | |i|pagename|runs| 02:07:37 INFO - PROCESS | 1660 | |0;dojo.html;3020.5167173252275;3531.2937412517495;3562.83967221475;3564.108972756811;3578.2843431313713;4493.415855938723;5404.486573775494;5811.767529298823;5827.038538641124;5862.0034594119;5705.914411283824;5836.562257830658;5926.229590153274;5932.644041357522;5961.61249518781;5168.457311982244;5194.37667479902;5248.632595718302;5278.181881808326;5317.069512835238;5348.759305831228;5350.27771250882;5368.0605893968595;5402.729863506809;5406.59450541209;5176.5858731301405;5176.663516871391;5298.947010529903;5302.522772950453;5334.813281535147;5255.39562950258;5262.947370526284;5296.364436267634;5299.417064122943;5302.92045619316;4182.477190351206;4535.024969631512;5217.399999000126;5263.973525162595;5278.2082687596785;4586.862394128181;5580.609357344987;5582.441755824426;5628.43715628438;5737.7131143443075;6217.968910155466;6270.216222972129;6275.090111933744;6306.747730090791;6316.336784637593;6280;6287.371262873722;6295;6311.2426508819235;6312.558120931537;5803.883922321572;5912.172295878538;5924.348321684612;5926.407359264039;5990.580659353847;6342.04869269604;6363.936360636427;6371.5221358397375;6442.871142577123;6450.387213214737;6206.10011548332;6250.624962502265;6256.186695729617;6261.937380626136;6265.091561723524;6168.1056246844855;6259.968700156561;6305.243370795534;6344.746210151635;6345.111684364193;6139.768135342631;6281.497480201664;6289.591176573508;6291.591046581958;6302.873942521124;6257.217847769029;6270.216222972129;6278.717457714414;6302.558820882494;6317.368263173737;4158.438610787565;4870.853874383774;4925.285833554115;4983.828800231942;5006.148954677714;4442.178197033559;4504.234280172379;4505.234110201273;4510.233260345683;4540.931886021713;5940.405959404025;6029.60807547508;6030.216071910623;6051.394860513913;6053.213082299361;5376.623636345418;6166.290876549165;6225.066240064027;6276.6547839869245;6302.991521356561;5980.312264089598;5984.251968503937;6015.037593984942;6015.488683461867;6039.245094363205;5409.756560954766;5452.073147564924;5471.425500322488;5481.506664400223;5486.067368547277;5998.770252098222;6327.873442531123;6468.450181734511;6511.934880651228;6584.670766461562;5191.195364718475;5743.740061116318;6058.5153187745755;6080.787172448943;6292.11910332563;6332.176817013758;6487.1566696331065;6539.444147247537;6548.508861835287;6557.377049180321;5085.644004919768;6165.506759459143;6190.288116866618;6235.46998505114;6289.811305660837;5260.342457192851;6272.8431789203805;6277.372262773686;6302.9684851577285;6315.210598675166;4731.858044258678;5554.611177217717;6226.377362263737;6257.8748425030335;6276.529260305587;6144.801763656223;6214.663847272858;6219;6276.152719383008;6283.183186185766;5988.550858685703;6063.454289113824;6066.636001839904;6121.632702037892;6126.877462450637;6112.572119951561;6123.70969670409;6127.6936153193055;6180.598261113013;6255.78104766331;6100.75596976116;6101.247350682792;6112.4901134650945;6124.758803966819;6144.539159562962 02:07:37 INFO - PROCESS | 1660 | |1;ext.html;577.6505214345322;578.6961845031358;599.6671847124844;640.9070684750711;643.4884267007728;30398.24004399891;34437.13907152323;37734.433983490235;38445.423318650246;38534.807325963404;32512.349753004924;34598.481022784676;39920;40045;40424.59575404245;8801.25189358902;8930.508822014786;9392.62429502819;9631.566579503904;9636.71089867305;9368.437893726365;9634.614615415376;9679.419234845896;9686.9515652422;9687.031296870327;9608.135267825894;9699.418034917928;9699.854502182472;9737;9779.706608801747;9564.713058608253;9602.711918642486;9660.227181825507;9678.080582344666;9701.90298097017;8775.297976161892;9562.56968436422;9672.468014259213;9695.90304096957;9716.417014979124;39386.21227575461;39403;39629.80185099085;39692.007699807735;39758.20483590312;3152.763542734281;3153.4166179256913;3187.235063584746;3264.575605171336;3445.1903802606366;28297.717022829715;28693.713062869523;28762.280942976384;29044.12867613975;29292.414151716846;2512.899484020637;2743.7942154338502;2767.7370649788236;2774.18161642316;2884.7403733664073;434388;472056;474022.6298868518;478446;479283;68332.65833670899;68686.65656671785;68825.3117468819;68920;68968.6551567239;70412.64793675998;75189.6240518794;75223.24776752162;75777;76248.4750305002;17014.234359453854;17245.56886077833;17256;17405.47783566495;17423.390181343846;12950.287734174712;13009.0243231758;13074.019448541207;13107.410166542528;13160.473581056842;21605.135794568356;21797.237096701538;21868.23461178851;21931.780682192973;21936.45158871041;9591.664291749756;9721.222302215805;9729.464879431558;9732.464714440632;9774.16919561831;941.8493041113389;982.415462799633;999.4608303212971;1033.503918119292;1078.8489611454402;29430.969916052836;29721.851390742908;29795.40409191804;29828.955986540368;29979.25051873677;865.2688478235881;879.0945326313907;939.5912777941618;1075.516017791981;1132.750794825137;12271.141020128684;14455;14860.18268995194;14922.850771492145;15173.848261517243;517700;528659.7134028687;529487;530817;531147;59196;59605.403945960854;59731.70134149301;59926;59976;1289.8645642207432;1315.1122991980567;1321.5044358365612;1351.8310211223597;1403.8385585657577;29227.7077229225;29388.7061129386;29515.114546563636;29874.551881722226;30046;43733.90665233395;52645;52854.20718689146;54115.18827217674;57292.71353643205;480670;485350;491427;492530;493559;33033.00900972974;34049.65950340465;34099.48850767191;34283.485747713305;34444.13889652779;44742.328865066396;45373;45827;46159.53840461552;46699.52202877841;36746.448803267434;37931.2413751729;37984;38846.6115338843;39084.609153908095;33194.5020824683;35942.460863087595;37444.62555374411;37487.81256093702;38156;34521.82739086288;36381.90854274376;36813.81593092017;38010.239795203386;38307.04232394212;31307.53038704467;32137.35725285528;32225.194370140933;32264;32647.673523264464;20062.197512099352;20975.160993560086;21793.455163621038;24571.262862114167;24710.752892470846 02:07:37 INFO - PROCESS | 1660 | |2;jquery.html;306.4376868446401;338.3030956230166;356.2803137661925;356.94344739570863;367.74993004756755;18613.348532801356;18706.345277915276;19133.42599722009;19293.807061929376;19341.903290483562;19175.712364314546;20413;20468.590628187427;20620.793792062075;20659.070341834617;5655.943440565604;5950.345461999198;5995.790147344844;5998.850028749294;6002.039673652216;4169.4162817205615;5308.5487733542695;5847.44449277318;6429.32492088331;6453.064305675674;5481.945180548183;6361.4274715275615;6382.138411314483;6394.392532709385;6398.872022559546;6137.693115344237;6462.32145624712;6467.094606755058;6481.060246264313;6483.319251478598;5482.533984611313;5582;5589.329280486327;5596.664200147963;5602.467765562265;24347.14784982535;24576.877115614487;24732.505349893083;24765.5046899061;24835.62746558803;2159.676048592708;2175;2274.4541310085624;2300.9654855177187;2857.557078652812;12158.756824863542;13276.402561884643;14461.91535634821;14603.269836508132;14792.926035369863;1728.9221985010704;1755.95610109747;1790.498660375097;1825.2151574822822;1944.474991752219;74825;99608;100636;101032.93802371882;102907.45638815424;10926.125909927187;11155.72110697239;11205.551777928791;11240.943795280971;11270.211085223955;13544.255065971467;13571.52499662507;13583.932080339535;13613.591592252249;13624.318784060757;8378.204070613281;8533.359998000175;8559.529225892637;8601.139886011473;8608.741737747878;8589.914100859036;8608.182222688834;8666.6100025499;8689.6524139035;8691.695790647424;4401.40581021558;4465.508794032654;4471.1728330259;4471.680854148034;4531.864044078683;1589.5628702106783;1772.7961284452194;1821.5537193387704;1873.4754268804757;1882.124811962444;741.7885902517756;878.3982971664431;912.543728135932;970.6942313171328;1038.2991480750463;17524.386646467567;19189.904050479938;19238.422847314603;20138.59722805565;20162.773956166944;927.6614035876856;965.0831709875646;965.6330594374093;966.3042609321277;1049.2917280835406;10342.431166285927;10384.740381490372;10417.270791044706;10464.895351046544;10587.100096491731;485257;558765;610445;623336;630820.8458957768;80692;94624;94987;105619.55043596648;108258;1019.4087429290994;1025.2259544044198;1034.2088302448783;1040.3653771199563;1041.739565108723;14623.561293161221;17062.744058838878;17675.204615792576;17744;17777.911110444365;35927.92216233517;47966.76016619895;49903.75048124736;50412.739681508254;50693;71543.64228178826;71636;72455;72717;72954.63522682352;7195.812690906151;7653.808654783675;7704.30661240491;7731.92268077312;8042.879356809535;10087.445190514298;11788.4695188715;12233.898949094624;12268.263904165779;12353.38233088324;10484.895151048391;10560;10710.946445267724;10818.404987725437;10820.89179108199;10397.896021039693;10508.369497830156;10546.367217966947;10854.945725271324;10858.728531786768;10326.793464130826;10922.781544369227;10984.340939543654;11044.447777611247;11266.66200014001;7685.23147685227;7764;7779.7666070017995;7815.25755053269;7967.681292748225;10400.843987340044;10666.679999600025;10912.181586381212;10920.453977300944;10935 02:07:37 INFO - PROCESS | 1660 | |3;mootools.html;1455.3160014793048;1557.629286228119;1855.3599008342126;1974.624821283955;1987.8210961013506;7938.523688578689;8578.571071446433;8680.131986801316;8829.205371516562;8832.293416526678;8616.483011019327;8631.093735157812;8697.391182617219;8713.433626814269;8742.431741936785;2437.5740191987666;2470.567650661136;2470.9135180268604;2474.208253358926;2485.0184177249976;2377.286813955815;2473.6907886514186;2478.677771889652;2480.9751902481016;2481.7146028206807;2425.6846609940685;2441.2310122311505;2471.851688898663;2480.355107672009;2484.5527804995095;2021.878687278768;2348.330725743155;2417.129833260025;2443.5723748344058;2462.630605409185;2444.584420648494;2446.8531888086595;2460.9261722148362;2465.778079972793;2466.260121963404;8812.735617931472;8818.955905220497;8838.425502342392;8850.557472126367;8858.202761751474;5282.181261904411;5392.973035134838;5452.073147564924;5475.917861232085;5485.561155107582;3556.733245006609;3594.622564630702;3659.79871107089;3705.203381273039;3769.981150094232;873.275181599271;921.806420651664;969.9515024248759;1039.26212389203;1083.685731137969;11643.708907277301;11722.765544689144;11827.053835693125;11872.881271187263;12296.077794165383;4330.155619654201;4707.764611769398;4975.0547395994645;4990.975045124751;4991.975040124777;10082.798344033079;10148.188144948386;10168.33905796121;10221.33561318512;10228.48857557134;4766.642501812378;5441.537469315073;5567.860803479945;5571.66570005801;5576.944230557724;3713.591504934455;4873.537013983666;4974.502549744997;4981.651284410056;5031.949680503149;3867.57456679765;3959.604039596075;3961.870866802947;3972.801359931992;4007.358822588372;1324.635725175565;1331.8135461035463;1340.671535473815;1342.838859336886;1342.9932850335686;1384.2455861555477;1385;1388.8055672205899;1392.4291040673274;1422.3101795629111;8151.429399941947;8180.918190818015;8281.585920703941;8285.337173026144;8289.792755181048;1290.316132449803;1305.3473263368317;1333.7199188170594;1334.599620113962;1345.2533843716635;6187.102870083812;6190.938090619036;6287.434130928147;6318.368163183645;6355.968220158869;10165.796684066425;10636.41499717523;10662.933706629276;10671.94664026675;10695.893041069645;10428.634997775192;10492;10500.894991050145;10609.9469502652;10617.416042117758;8355.874661880076;8371.079181290053;8385.874211886827;8427;8582.78543036429;7902.4863383879865;7933.325667318342;7985.480943738638;7991.760247192594;8086.15095414973;9379.202767764817;9411.058894110534;9510.714678559654;9603.327767056238;9649.614015439585;9476.857847132436;9802.411855288705;9904.059114384121;9920.255980801325;9933.503324833873;6782.491313151632;7207.099112610924;7459.328660420588;7464.738734144279;7579.886301705368;8146.796330091795;8181.590920453835;8214.876776848232;8231.42380033392;8286.83426331482;7316.743913962986;7335.853282934205;7461.813454663677;7554.055743032121;7659.770206893802;6819.352161544645;6916.23921368639;7287.8178045547165;7352.96323518379;7385.741499047507;6005.279366476051;7603.88594171099;7637.236276372319;7770;7785.610719464117;6226.7235216781355;6261.5616906816085;6674.966625166843;6989.33601307875;7043.506954513135;6846.5892046477375;7125.964370178116;7133.892991605234;7224;7231.819204519929 02:07:37 INFO - PROCESS | 1660 | |4;prototype.html;278.56126600604046;311.58092365768033;332.49958811987955;333.29840685357317;335.79013116801997;5752.5685573581995;6686.264510903803;6744.966275168624;6917.584944903297;6947.965260173692;6634.900476492857;6734.090897728805;6798.082258895048;6829.795106146811;6842.486813488996;4666.370040044584;4770.594499467532;4894.192458244385;4954.281629163769;4981.501849815026;4875.756212189394;4893.681910675812;4899.093667671492;4900.338454308676;4919.827806026789;4801.18379875422;4808.927866081994;4829.975850120744;4834.7824347904425;4856.587190088847;4825.2279635258365;4842.564169224752;4868.537488938545;4881.560659540658;4888.877778055541;4143;4156.896077598054;4161.708680392374;4162.229987452331;4171.958280417218;6264.185655864754;6504.3170467100745;6507.121538592277;6533.18335208099;6564.1138446309615;5824.708764561755;5830.300363956352;5835.416458354173;5857.560682948753;5880.764769409218;6260.686965651745;6800.727970881158;7172.031775710265;7185.461090418187;7188.892166617505;4640.744759038252;4646.303054541812;4667.533246675339;4668.299755036738;4672.3692301539195;7611.467197296191;7667.923320766777;7680.9615951921;7698.191689872595;7707.113681926538;3930.4104384342004;4534.478534968455;4702.4592171899985;4704.623630109583;4709.62323014158;4760.166970780099;4770.499097594703;4782.832600858953;4792.592629626521;4794.400699912511;5767.36558978512;5785.392533783892;5797.391273916262;5803.7968671096305;5830.183774271605;7246.275372462712;7254.927450725425;7261.854762904818;7273.345398914017;7323.780286591411;1393.191948669769;1640.5406486183888;1661.3188592677186;1663.20166320167;1665.84174503422;1019.108280254777;1056.8467572201987;1057.0486562094022;1059.3061544688242;1069.6095924987324;5621;6697.430718388894;6710.16122984627;6774.729010839511;6827.385535301847;7514.849703005909;7518.624068796647;7534.849303014019;7535.510191837513;7538.698452061966;6551.6069035857045;6665.400113989667;6802.557833740791;7047.788566343018;7091.82270443243;3961.7622942623534;3979.1047014421524;3984.4222587724616;3993.4409182714444;3996.8001599920467;7915.050193976645;7917.7624671259955;7920.643571039317;7938.087119981161;7957.562334071682;6357.618542887349;7503.737369192052;7758.262965018314;7803.297703206738;7823.530588164728;6458.515611329169;7929.32600728933;7949.483283586548;7974.5613991229875;7982.082060562993;7514;7559.508631938907;7561.848763024599;7581.54510729358;7591;7393.223711510214;7411.518251313647;7426.591537465275;7432.108147022392;7476.25237476248;7640.235976402315;7898.723544675909;7923;7949.3243074339325;7961.243681850215;4665.580097791215;4724.338592597108;4726.598239149711;4731.810727570859;4742.834000809955;6125.693715314127;7116.359527642537;7550.848983020199;7561;7684.847272909108;7278.745243916437;7285.453590980804;7288.198298187302;7299.379552738077;7306.2693730626515;7027.297270272932;7173.0675012248075;7240.094988126484;7246.949192367183;7309.049823522908;7091.5390499619425;7102.573845569283;7105.0461123191535;7109.289071093056;7116.928830711627;5943.940560594512;7253.165885922976;7259.201487836228;7275.126984761862;7278.053852999288;6011.609245399035;6910.101686780687;7094.53885497441;7106.751263705745;7165.641717914188 02:07:37 INFO - PROCESS | 1660 | |5;yui.html;616.3866952382381;674.2549482821482;687.3779229797035;721.4516967105005;730.9926900730994;14848.030393921219;14855.257237138154;14947.850521494782;15039.774403383957;15083.547493575197;15387.384504619802;15671.84328156718;15713.84286157138;15754.684906301867;15787.447439339625;733.1678544851605;917.614601867214;931.2456909902967;932.4358762948386;932.9766755831091;861.2378045429808;920.4891285336636;929.2426672262085;930.6603089872182;936.2650319499195;793.9166387529312;938.9201917836992;940.9106134917172;978.3689520259428;985.1970643925214;944.8299306124894;950.5674917912368;965.7971825916566;975.229568640773;975.7024107647164;710.9253528379497;720.85582883423;723.8986541884141;724.3155218318691;728.4864170759655;15478.845211547852;15543.689126217525;15551.688966220725;15581.065136091871;15682.451114211062;12377.443015064344;12383.504659813596;12442.129050966436;12604.68488287791;12629.305388203646;10015.44915029673;10095.040971107734;10113.69658910234;10117.797644047152;10143.442110683909;3392.542006829096;3458.9654103458893;3493.4061209594174;3493.7030352420074;3510.526078979356;85464.14535854624;85826.57086714589;87414.56292718559;87899.56050219708;88397.55801220953;9282.582283797245;9355.625774968925;9456.57445414958;9491.620335186515;9689.031096890254;21168.364949051553;21358.572828543343;21370.252041178795;21403.822789746715;21415.571688566142;7192.352688258082;7353.485256032026;7368.668409921566;7431.071116110486;7451.925480745232;4118.19695159441;4165;4172.833086676499;4174.497181014833;4186.35111557709;3583.8028908409765;3609.5488063992;3621.94567081494;3631.891043268706;3666.523351964281;645.3643161485933;653.996115961996;657.4181849063517;657.6645910585636;661.4080398043724;529.3489008519466;574.5575906551932;582.2547139661241;586.1442294250357;596.2904144068631;8013.639386227634;8196.959015204886;8212.17878212186;8213.835723285501;8500.404971651926;535.5902734408181;572.4676051272273;587.6209844650176;611.065070442224;617.42159588122;3713.832877520518;3789.3368660484307;3835.7506762060375;3843.2121415109837;3845.5962123977138;95085;96902;97805;97853;97914.5104274474;72800.54398911992;73003.26996730072;73172.53654926871;73680.26319736734;74654.6267268671;72102.63948680223;73182;73502.63248683616;73630;74874;7657.502262352929;7693.3076023155945;7739.458237923516;7796.259355361231;7846;42846.57153428426;51742;52631.73684131555;53449.73275133599;53571.19643205433;67962.66018669875;73197;73248.26751732414;74248.62875685588;74479;9951.800963980824;10855.077318427706;10902.454877256265;11251.268667536584;11482.655520334403;11905.40472976365;11949.283043017447;12034.277943323428;12125.75748485043;12271.325077120488;11354.886451135713;11369.715757105807;11560.768784624428;11589.942050289694;11662.895871598052;9411.388259763093;9672.70981870545;10345.431001295;10593.735156621146;11163.720906977065;9815;10980.945095274472;10988.560457581607;10993.395363255098;11346.092312614806;9489.620415183315;9626.566804493674;9719.416834989923;9760.511974401394;9807.705768826947;8720.738377848675;9376.666483924635;9595.088466595662;9642.614295428384;9833.574131750713 02:07:37 INFO - PROCESS | 1660 | __end_tp_report 02:07:37 INFO - PROCESS | 1660 | __start_cc_report 02:07:37 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,363 02:07:37 INFO - PROCESS | 1660 | __end_cc_report 02:07:37 INFO - PROCESS | 1660 | __startTimestamp1458292057018__endTimestamp 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | ------- Summary: start ------- 02:07:37 INFO - PROCESS | 1660 | Number of tests: 6 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5766.58 Median:6051.39 stddev:690.77 (11.4%) stddev-sans-first:658.44 02:07:37 INFO - PROCESS | 1660 | Values: 3020.5 3531.3 3562.8 3564.1 3578.3 4493.4 5404.5 5811.8 5827.0 5862.0 5705.9 5836.6 5926.2 5932.6 5961.6 5168.5 5194.4 5248.6 5278.2 5317.1 5348.8 5350.3 5368.1 5402.7 5406.6 5176.6 5176.7 5298.9 5302.5 5334.8 5255.4 5262.9 5296.4 5299.4 5302.9 4182.5 4535.0 5217.4 5264.0 5278.2 4586.9 5580.6 5582.4 5628.4 5737.7 6218.0 6270.2 6275.1 6306.7 6316.3 6280.0 6287.4 6295.0 6311.2 6312.6 5803.9 5912.2 5924.3 5926.4 5990.6 6342.0 6363.9 6371.5 6442.9 6450.4 6206.1 6250.6 6256.2 6261.9 6265.1 6168.1 6260.0 6305.2 6344.7 6345.1 6139.8 6281.5 6289.6 6291.6 6302.9 6257.2 6270.2 6278.7 6302.6 6317.4 4158.4 4870.9 4925.3 4983.8 5006.1 4442.2 4504.2 4505.2 4510.2 4540.9 5940.4 6029.6 6030.2 6051.4 6053.2 5376.6 6166.3 6225.1 6276.7 6303.0 5980.3 5984.3 6015.0 6015.5 6039.2 5409.8 5452.1 5471.4 5481.5 5486.1 5998.8 6327.9 6468.5 6511.9 6584.7 5191.2 5743.7 6058.5 6080.8 6292.1 6332.2 6487.2 6539.4 6548.5 6557.4 5085.6 6165.5 6190.3 6235.5 6289.8 5260.3 6272.8 6277.4 6303.0 6315.2 4731.9 5554.6 6226.4 6257.9 6276.5 6144.8 6214.7 6219.0 6276.2 6283.2 5988.6 6063.5 6066.6 6121.6 6126.9 6112.6 6123.7 6127.7 6180.6 6255.8 6100.8 6101.2 6112.5 6124.8 6144.5 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:64435.77 Median:39235.41 stddev:131687.10 (335.6%) stddev-sans-first:131969.23 02:07:37 INFO - PROCESS | 1660 | Values: 577.7 578.7 599.7 640.9 643.5 30398.2 34437.1 37734.4 38445.4 38534.8 32512.3 34598.5 39920.0 40045.0 40424.6 8801.3 8930.5 9392.6 9631.6 9636.7 9368.4 9634.6 9679.4 9687.0 9687.0 9608.1 9699.4 9699.9 9737.0 9779.7 9564.7 9602.7 9660.2 9678.1 9701.9 8775.3 9562.6 9672.5 9695.9 9716.4 39386.2 39403.0 39629.8 39692.0 39758.2 3152.8 3153.4 3187.2 3264.6 3445.2 28297.7 28693.7 28762.3 29044.1 29292.4 2512.9 2743.8 2767.7 2774.2 2884.7 434388.0 472056.0 474022.6 478446.0 479283.0 68332.7 68686.7 68825.3 68920.0 68968.7 70412.6 75189.6 75223.2 75777.0 76248.5 17014.2 17245.6 17256.0 17405.5 17423.4 12950.3 13009.0 13074.0 13107.4 13160.5 21605.1 21797.2 21868.2 21931.8 21936.5 9591.7 9721.2 9729.5 9732.5 9774.2 941.8 982.4 999.5 1033.5 1078.8 29431.0 29721.9 29795.4 29829.0 29979.3 865.3 879.1 939.6 1075.5 1132.8 12271.1 14455.0 14860.2 14922.9 15173.8 517700.0 528659.7 529487.0 530817.0 531147.0 59196.0 59605.4 59731.7 59926.0 59976.0 1289.9 1315.1 1321.5 1351.8 1403.8 29227.7 29388.7 29515.1 29874.6 30046.0 43733.9 52645.0 52854.2 54115.2 57292.7 480670.0 485350.0 491427.0 492530.0 493559.0 33033.0 34049.7 34099.5 34283.5 34444.1 44742.3 45373.0 45827.0 46159.5 46699.5 36746.4 37931.2 37984.0 38846.6 39084.6 33194.5 35942.5 37444.6 37487.8 38156.0 34521.8 36381.9 36813.8 38010.2 38307.0 31307.5 32137.4 32225.2 32264.0 32647.7 20062.2 20975.2 21793.5 24571.3 24710.8 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:32600.68 Median:13324.06 stddev:96453.85 (723.9%) stddev-sans-first:96693.95 02:07:37 INFO - PROCESS | 1660 | Values: 306.4 338.3 356.3 356.9 367.7 18613.3 18706.3 19133.4 19293.8 19341.9 19175.7 20413.0 20468.6 20620.8 20659.1 5655.9 5950.3 5995.8 5998.9 6002.0 4169.4 5308.5 5847.4 6429.3 6453.1 5481.9 6361.4 6382.1 6394.4 6398.9 6137.7 6462.3 6467.1 6481.1 6483.3 5482.5 5582.0 5589.3 5596.7 5602.5 24347.1 24576.9 24732.5 24765.5 24835.6 2159.7 2175.0 2274.5 2301.0 2857.6 12158.8 13276.4 14461.9 14603.3 14792.9 1728.9 1756.0 1790.5 1825.2 1944.5 74825.0 99608.0 100636.0 101032.9 102907.5 10926.1 11155.7 11205.6 11240.9 11270.2 13544.3 13571.5 13583.9 13613.6 13624.3 8378.2 8533.4 8559.5 8601.1 8608.7 8589.9 8608.2 8666.6 8689.7 8691.7 4401.4 4465.5 4471.2 4471.7 4531.9 1589.6 1772.8 1821.6 1873.5 1882.1 741.8 878.4 912.5 970.7 1038.3 17524.4 19189.9 19238.4 20138.6 20162.8 927.7 965.1 965.6 966.3 1049.3 10342.4 10384.7 10417.3 10464.9 10587.1 485257.0 558765.0 610445.0 623336.0 630820.8 80692.0 94624.0 94987.0 105619.6 108258.0 1019.4 1025.2 1034.2 1040.4 1041.7 14623.6 17062.7 17675.2 17744.0 17777.9 35927.9 47966.8 49903.8 50412.7 50693.0 71543.6 71636.0 72455.0 72717.0 72954.6 7195.8 7653.8 7704.3 7731.9 8042.9 10087.4 11788.5 12233.9 12268.3 12353.4 10484.9 10560.0 10710.9 10818.4 10820.9 10397.9 10508.4 10546.4 10854.9 10858.7 10326.8 10922.8 10984.3 11044.4 11266.7 7685.2 7764.0 7779.8 7815.3 7967.7 10400.8 10666.7 10912.2 10920.5 10935.0 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:6044.53 Median:5446.81 stddev:3156.96 (58.0%) stddev-sans-first:3146.97 02:07:37 INFO - PROCESS | 1660 | Values: 1455.3 1557.6 1855.4 1974.6 1987.8 7938.5 8578.6 8680.1 8829.2 8832.3 8616.5 8631.1 8697.4 8713.4 8742.4 2437.6 2470.6 2470.9 2474.2 2485.0 2377.3 2473.7 2478.7 2481.0 2481.7 2425.7 2441.2 2471.9 2480.4 2484.6 2021.9 2348.3 2417.1 2443.6 2462.6 2444.6 2446.9 2460.9 2465.8 2466.3 8812.7 8819.0 8838.4 8850.6 8858.2 5282.2 5393.0 5452.1 5475.9 5485.6 3556.7 3594.6 3659.8 3705.2 3770.0 873.3 921.8 970.0 1039.3 1083.7 11643.7 11722.8 11827.1 11872.9 12296.1 4330.2 4707.8 4975.1 4991.0 4992.0 10082.8 10148.2 10168.3 10221.3 10228.5 4766.6 5441.5 5567.9 5571.7 5576.9 3713.6 4873.5 4974.5 4981.7 5031.9 3867.6 3959.6 3961.9 3972.8 4007.4 1324.6 1331.8 1340.7 1342.8 1343.0 1384.2 1385.0 1388.8 1392.4 1422.3 8151.4 8180.9 8281.6 8285.3 8289.8 1290.3 1305.3 1333.7 1334.6 1345.3 6187.1 6190.9 6287.4 6318.4 6356.0 10165.8 10636.4 10662.9 10671.9 10695.9 10428.6 10492.0 10500.9 10609.9 10617.4 8355.9 8371.1 8385.9 8427.0 8582.8 7902.5 7933.3 7985.5 7991.8 8086.2 9379.2 9411.1 9510.7 9603.3 9649.6 9476.9 9802.4 9904.1 9920.3 9933.5 6782.5 7207.1 7459.3 7464.7 7579.9 8146.8 8181.6 8214.9 8231.4 8286.8 7316.7 7335.9 7461.8 7554.1 7659.8 6819.4 6916.2 7287.8 7353.0 7385.7 6005.3 7603.9 7637.2 7770.0 7785.6 6226.7 6261.6 6675.0 6989.3 7043.5 6846.6 7126.0 7133.9 7224.0 7231.8 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5890.10 Median:6675.83 stddev:1916.98 (28.7%) stddev-sans-first:1875.52 02:07:37 INFO - PROCESS | 1660 | Values: 278.6 311.6 332.5 333.3 335.8 5752.6 6686.3 6745.0 6917.6 6948.0 6634.9 6734.1 6798.1 6829.8 6842.5 4666.4 4770.6 4894.2 4954.3 4981.5 4875.8 4893.7 4899.1 4900.3 4919.8 4801.2 4808.9 4830.0 4834.8 4856.6 4825.2 4842.6 4868.5 4881.6 4888.9 4143.0 4156.9 4161.7 4162.2 4172.0 6264.2 6504.3 6507.1 6533.2 6564.1 5824.7 5830.3 5835.4 5857.6 5880.8 6260.7 6800.7 7172.0 7185.5 7188.9 4640.7 4646.3 4667.5 4668.3 4672.4 7611.5 7667.9 7681.0 7698.2 7707.1 3930.4 4534.5 4702.5 4704.6 4709.6 4760.2 4770.5 4782.8 4792.6 4794.4 5767.4 5785.4 5797.4 5803.8 5830.2 7246.3 7254.9 7261.9 7273.3 7323.8 1393.2 1640.5 1661.3 1663.2 1665.8 1019.1 1056.8 1057.0 1059.3 1069.6 5621.0 6697.4 6710.2 6774.7 6827.4 7514.8 7518.6 7534.8 7535.5 7538.7 6551.6 6665.4 6802.6 7047.8 7091.8 3961.8 3979.1 3984.4 3993.4 3996.8 7915.1 7917.8 7920.6 7938.1 7957.6 6357.6 7503.7 7758.3 7803.3 7823.5 6458.5 7929.3 7949.5 7974.6 7982.1 7514.0 7559.5 7561.8 7581.5 7591.0 7393.2 7411.5 7426.6 7432.1 7476.3 7640.2 7898.7 7923.0 7949.3 7961.2 4665.6 4724.3 4726.6 4731.8 4742.8 6125.7 7116.4 7550.8 7561.0 7684.8 7278.7 7285.5 7288.2 7299.4 7306.3 7027.3 7173.1 7240.1 7246.9 7309.0 7091.5 7102.6 7105.0 7109.3 7116.9 5943.9 7253.2 7259.2 7275.1 7278.1 6011.6 6910.1 7094.5 7106.8 7165.6 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18722.73 Median:659.54 stddev:26751.55 (4056.1%) stddev-sans-first:26792.05 02:07:37 INFO - PROCESS | 1660 | Values: 616.4 674.3 687.4 721.5 731.0 14848.0 14855.3 14947.9 15039.8 15083.5 15387.4 15671.8 15713.8 15754.7 15787.4 733.2 917.6 931.2 932.4 933.0 861.2 920.5 929.2 930.7 936.3 793.9 938.9 940.9 978.4 985.2 944.8 950.6 965.8 975.2 975.7 710.9 720.9 723.9 724.3 728.5 15478.8 15543.7 15551.7 15581.1 15682.5 12377.4 12383.5 12442.1 12604.7 12629.3 10015.4 10095.0 10113.7 10117.8 10143.4 3392.5 3459.0 3493.4 3493.7 3510.5 85464.1 85826.6 87414.6 87899.6 88397.6 9282.6 9355.6 9456.6 9491.6 9689.0 21168.4 21358.6 21370.3 21403.8 21415.6 7192.4 7353.5 7368.7 7431.1 7451.9 4118.2 4165.0 4172.8 4174.5 4186.4 3583.8 3609.5 3621.9 3631.9 3666.5 645.4 654.0 657.4 657.7 661.4 529.3 574.6 582.3 586.1 596.3 8013.6 8197.0 8212.2 8213.8 8500.4 535.6 572.5 587.6 611.1 617.4 3713.8 3789.3 3835.8 3843.2 3845.6 95085.0 96902.0 97805.0 97853.0 97914.5 72800.5 73003.3 73172.5 73680.3 74654.6 72102.6 73182.0 73502.6 73630.0 74874.0 7657.5 7693.3 7739.5 7796.3 7846.0 42846.6 51742.0 52631.7 53449.7 53571.2 67962.7 73197.0 73248.3 74248.6 74479.0 9951.8 10855.1 10902.5 11251.3 11482.7 11905.4 11949.3 12034.3 12125.8 12271.3 11354.9 11369.7 11560.8 11589.9 11662.9 9411.4 9672.7 10345.4 10593.7 11163.7 9815.0 10980.9 10988.6 10993.4 11346.1 9489.6 9626.6 9719.4 9760.5 9807.7 8720.7 9376.7 9595.1 9642.6 9833.6 02:07:37 INFO - PROCESS | 1660 | -------- Summary: end -------- 02:07:37 INFO - PROCESS | 1660 | 02:07:37 INFO - TEST-INFO | 1660: exit 0 02:07:37 INFO - TEST-OK | dromaeo_css | took 1111455ms 02:07:37 INFO - TEST-START | kraken 02:07:37 INFO - operating with platform_type : mac_ 02:07:37 INFO - Initialising browser for kraken test... 02:07:37 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpVMuz_2/profile http://localhost:49272/getInfo.html) 02:07:39 INFO - PROCESS | 1672 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 02:07:40 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 02:07:40 INFO - PROCESS | 1672 | colorDepth:24 02:07:40 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 02:07:40 INFO - PROCESS | 1672 | __metrics 02:07:40 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 02:07:41 INFO - TEST-INFO | 1672: exit 0 02:07:41 INFO - Browser initialized. 02:07:41 INFO - Running cycle 1/1 for kraken test... 02:07:41 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpVMuz_2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:53 INFO - PROCESS | 1675 | RSS: Main: 255774720 02:07:53 INFO - PROCESS | 1675 | 02:07:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:07:56 INFO - PROCESS | 1675 | RSS: Main: 267927552 02:07:56 INFO - PROCESS | 1675 | 02:07:59 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:07:59 INFO - PROCESS | 1675 | RSS: Main: 277598208 02:07:59 INFO - PROCESS | 1675 | 02:08:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:08:03 INFO - PROCESS | 1675 | RSS: Main: 279957504 02:08:03 INFO - PROCESS | 1675 | 02:08:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:08:06 INFO - PROCESS | 1675 | RSS: Main: 281960448 02:08:06 INFO - PROCESS | 1675 | 02:08:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:08:09 INFO - PROCESS | 1675 | RSS: Main: 283443200 02:08:09 INFO - PROCESS | 1675 | 02:08:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:08:12 INFO - PROCESS | 1675 | RSS: Main: 284889088 02:08:12 INFO - PROCESS | 1675 | 02:08:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:08:16 INFO - PROCESS | 1675 | RSS: Main: 284708864 02:08:16 INFO - PROCESS | 1675 | 02:08:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:08:19 INFO - PROCESS | 1675 | RSS: Main: 284782592 02:08:19 INFO - PROCESS | 1675 | 02:08:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:08:22 INFO - PROCESS | 1675 | RSS: Main: 284835840 02:08:22 INFO - PROCESS | 1675 | 02:08:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:08:24 INFO - PROCESS | 1675 | RSS: Main: 283095040 02:08:24 INFO - PROCESS | 1675 | 02:08:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:08:27 INFO - PROCESS | 1675 | RSS: Main: 284069888 02:08:27 INFO - PROCESS | 1675 | 02:08:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:08:30 INFO - PROCESS | 1675 | RSS: Main: 283856896 02:08:30 INFO - PROCESS | 1675 | 02:08:33 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:08:33 INFO - PROCESS | 1675 | RSS: Main: 284078080 02:08:33 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:08:35 INFO - PROCESS | 1675 | RSS: Main: 285614080 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | __start_tp_report 02:08:35 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 02:08:35 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 02:08:35 INFO - PROCESS | 1675 | |i|pagename|runs| 02:08:35 INFO - PROCESS | 1675 | |0;ai-astar;115;112;116;116;116;126;115;114;114;114 02:08:35 INFO - PROCESS | 1675 | |1;audio-beat-detection;154;122;159;177;149;170;139;137;191;127 02:08:35 INFO - PROCESS | 1675 | |2;audio-dft;237;257;203;248;266;185;271;278;206;196 02:08:35 INFO - PROCESS | 1675 | |3;audio-fft;67;68;72;120;59;48;50;82;100;80 02:08:35 INFO - PROCESS | 1675 | |4;audio-oscillator;84;89;119;79;82;84;116;79;78;116 02:08:35 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;88;85;89;79;83;95;127;103;85;130 02:08:35 INFO - PROCESS | 1675 | |6;imaging-darkroom;94;96;95;97;89;99;146;147;103;148 02:08:35 INFO - PROCESS | 1675 | |7;imaging-desaturate;93;125;144;114;92;92;91;131;85;150 02:08:35 INFO - PROCESS | 1675 | |8;json-parse-financial;53;47;46;58;69;78;82;93;88;84 02:08:35 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;67;64;66;80;71;77;70;67;67;70 02:08:35 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;85;86;83;86;83;75;106;112;108;85 02:08:35 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;115;153;114;129;134;110;127;134;139;141 02:08:35 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;129;130;184;176;131;166;176;147;142;145 02:08:35 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;67;68;69;72;90;69;69;66;71 02:08:35 INFO - PROCESS | 1675 | __end_tp_report 02:08:35 INFO - PROCESS | 1675 | __start_cc_report 02:08:35 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,939 02:08:35 INFO - PROCESS | 1675 | __end_cc_report 02:08:35 INFO - PROCESS | 1675 | __startTimestamp1458292115911__endTimestamp 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | ------- Summary: start ------- 02:08:35 INFO - PROCESS | 1675 | Number of tests: 14 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.50 stddev:3.79 (3.3%) stddev-sans-first:4.01 02:08:35 INFO - PROCESS | 1675 | Values: 115.0 112.0 116.0 116.0 116.0 126.0 115.0 114.0 114.0 114.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:156.50 stddev:22.23 (14.2%) stddev-sans-first:23.57 02:08:35 INFO - PROCESS | 1675 | Values: 154.0 122.0 159.0 177.0 149.0 170.0 139.0 137.0 191.0 127.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:234.70 Median:252.50 stddev:34.40 (13.6%) stddev-sans-first:36.47 02:08:35 INFO - PROCESS | 1675 | Values: 237.0 257.0 203.0 248.0 266.0 185.0 271.0 278.0 206.0 196.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:74.60 Median:67.50 stddev:22.25 (33.0%) stddev-sans-first:23.43 02:08:35 INFO - PROCESS | 1675 | Values: 67.0 68.0 72.0 120.0 59.0 48.0 50.0 82.0 100.0 80.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:80.50 stddev:17.15 (21.3%) stddev-sans-first:17.91 02:08:35 INFO - PROCESS | 1675 | Values: 84.0 89.0 119.0 79.0 82.0 84.0 116.0 79.0 78.0 116.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:85.00 stddev:18.19 (21.4%) stddev-sans-first:19.04 02:08:35 INFO - PROCESS | 1675 | Values: 88.0 85.0 89.0 79.0 83.0 95.0 127.0 103.0 85.0 130.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:94.50 stddev:24.82 (26.3%) stddev-sans-first:25.52 02:08:35 INFO - PROCESS | 1675 | Values: 94.0 96.0 95.0 97.0 89.0 99.0 146.0 147.0 103.0 148.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:88.00 stddev:24.34 (27.7%) stddev-sans-first:24.86 02:08:35 INFO - PROCESS | 1675 | Values: 93.0 125.0 144.0 114.0 92.0 92.0 91.0 131.0 85.0 150.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:80.00 stddev:17.62 (22.0%) stddev-sans-first:17.61 02:08:35 INFO - PROCESS | 1675 | Values: 53.0 47.0 46.0 58.0 69.0 78.0 82.0 93.0 88.0 84.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:5.04 (7.2%) stddev-sans-first:5.24 02:08:35 INFO - PROCESS | 1675 | Values: 67.0 64.0 66.0 80.0 71.0 77.0 70.0 67.0 67.0 70.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:84.00 stddev:12.74 (15.2%) stddev-sans-first:13.33 02:08:35 INFO - PROCESS | 1675 | Values: 85.0 86.0 83.0 86.0 83.0 75.0 106.0 112.0 108.0 85.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:134.00 stddev:13.55 (10.1%) stddev-sans-first:13.30 02:08:35 INFO - PROCESS | 1675 | Values: 115.0 153.0 114.0 129.0 134.0 110.0 127.0 134.0 139.0 141.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:156.50 stddev:21.07 (13.5%) stddev-sans-first:20.55 02:08:35 INFO - PROCESS | 1675 | Values: 129.0 130.0 184.0 176.0 131.0 166.0 176.0 147.0 142.0 145.0 02:08:35 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:69.00 stddev:6.99 (10.1%) stddev-sans-first:7.28 02:08:35 INFO - PROCESS | 1675 | Values: 67.0 67.0 68.0 69.0 72.0 90.0 69.0 69.0 66.0 71.0 02:08:35 INFO - PROCESS | 1675 | -------- Summary: end -------- 02:08:35 INFO - PROCESS | 1675 | 02:08:36 INFO - TEST-INFO | 1675: exit 0 02:08:36 INFO - TEST-OK | kraken | took 59235ms 02:08:36 INFO - SUITE-END | took 1170s 02:08:37 INFO - Completed test suite (00:19:30) 02:08:37 INFO - javascript benchmark 02:08:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3020.5167173252275, 3531.2937412517495, 3562.83967221475, 3564.108972756811, 3578.2843431313713, 4493.415855938723, 5404.486573775494, 5811.767529298823, 5827.038538641124, 5862.0034594119, 5705.914411283824, 5836.562257830658, 5926.229590153274, 5932.644041357522, 5961.61249518781, 5168.457311982244, 5194.37667479902, 5248.632595718302, 5278.181881808326, 5317.069512835238, 5348.759305831228, 5350.27771250882, 5368.0605893968595, 5402.729863506809, 5406.59450541209, 5176.5858731301405, 5176.663516871391, 5298.947010529903, 5302.522772950453, 5334.813281535147, 5255.39562950258, 5262.947370526284, 5296.364436267634, 5299.417064122943, 5302.92045619316, 4182.477190351206, 4535.024969631512, 5217.399999000126, 5263.973525162595, 5278.2082687596785, 4586.862394128181, 5580.609357344987, 5582.441755824426, 5628.43715628438, 5737.7131143443075, 6217.968910155466, 6270.216222972129, 6275.090111933744, 6306.747730090791, 6316.336784637593, 6280.0, 6287.371262873722, 6295.0, 6311.2426508819235, 6312.558120931537, 5803.883922321572, 5912.172295878538, 5924.348321684612, 5926.407359264039, 5990.580659353847, 6342.04869269604, 6363.936360636427, 6371.5221358397375, 6442.871142577123, 6450.387213214737, 6206.10011548332, 6250.624962502265, 6256.186695729617, 6261.937380626136, 6265.091561723524, 6168.1056246844855, 6259.968700156561, 6305.243370795534, 6344.746210151635, 6345.111684364193, 6139.768135342631, 6281.497480201664, 6289.591176573508, 6291.591046581958, 6302.873942521124, 6257.217847769029, 6270.216222972129, 6278.717457714414, 6302.558820882494, 6317.368263173737, 4158.438610787565, 4870.853874383774, 4925.285833554115, 4983.828800231942, 5006.148954677714, 4442.178197033559, 4504.234280172379, 4505.234110201273, 4510.233260345683, 4540.931886021713, 5940.405959404025, 6029.60807547508, 6030.216071910623, 6051.394860513913, 6053.213082299361, 5376.623636345418, 6166.290876549165, 6225.066240064027, 6276.6547839869245, 6302.991521356561, 5980.312264089598, 5984.251968503937, 6015.037593984942, 6015.488683461867, 6039.245094363205, 5409.756560954766, 5452.073147564924, 5471.425500322488, 5481.506664400223, 5486.067368547277, 5998.770252098222, 6327.873442531123, 6468.450181734511, 6511.934880651228, 6584.670766461562, 5191.195364718475, 5743.740061116318, 6058.5153187745755, 6080.787172448943, 6292.11910332563, 6332.176817013758, 6487.1566696331065, 6539.444147247537, 6548.508861835287, 6557.377049180321, 5085.644004919768, 6165.506759459143, 6190.288116866618, 6235.46998505114, 6289.811305660837, 5260.342457192851, 6272.8431789203805, 6277.372262773686, 6302.9684851577285, 6315.210598675166, 4731.858044258678, 5554.611177217717, 6226.377362263737, 6257.8748425030335, 6276.529260305587, 6144.801763656223, 6214.663847272858, 6219.0, 6276.152719383008, 6283.183186185766, 5988.550858685703, 6063.454289113824, 6066.636001839904, 6121.632702037892, 6126.877462450637, 6112.572119951561, 6123.70969670409, 6127.6936153193055, 6180.598261113013, 6255.78104766331, 6100.75596976116, 6101.247350682792, 6112.4901134650945, 6124.758803966819, 6144.539159562962], "unit": "score", "name": "dojo.html", "value": 5724.284083561033}, {"lowerIsBetter": false, "replicates": [577.6505214345322, 578.6961845031358, 599.6671847124844, 640.9070684750711, 643.4884267007728, 30398.24004399891, 34437.13907152323, 37734.433983490235, 38445.423318650246, 38534.807325963404, 32512.349753004924, 34598.481022784676, 39920.0, 40045.0, 40424.59575404245, 8801.25189358902, 8930.508822014786, 9392.62429502819, 9631.566579503904, 9636.71089867305, 9368.437893726365, 9634.614615415376, 9679.419234845896, 9686.9515652422, 9687.031296870327, 9608.135267825894, 9699.418034917928, 9699.854502182472, 9737.0, 9779.706608801747, 9564.713058608253, 9602.711918642486, 9660.227181825507, 9678.080582344666, 9701.90298097017, 8775.297976161892, 9562.56968436422, 9672.468014259213, 9695.90304096957, 9716.417014979124, 39386.21227575461, 39403.0, 39629.80185099085, 39692.007699807735, 39758.20483590312, 3152.763542734281, 3153.4166179256913, 3187.235063584746, 3264.575605171336, 3445.1903802606366, 28297.717022829715, 28693.713062869523, 28762.280942976384, 29044.12867613975, 29292.414151716846, 2512.899484020637, 2743.7942154338502, 2767.7370649788236, 2774.18161642316, 2884.7403733664073, 434388.0, 472056.0, 474022.6298868518, 478446.0, 479283.0, 68332.65833670899, 68686.65656671785, 68825.3117468819, 68920.0, 68968.6551567239, 70412.64793675998, 75189.6240518794, 75223.24776752162, 75777.0, 76248.4750305002, 17014.234359453854, 17245.56886077833, 17256.0, 17405.47783566495, 17423.390181343846, 12950.287734174712, 13009.0243231758, 13074.019448541207, 13107.410166542528, 13160.473581056842, 21605.135794568356, 21797.237096701538, 21868.23461178851, 21931.780682192973, 21936.45158871041, 9591.664291749756, 9721.222302215805, 9729.464879431558, 9732.464714440632, 9774.16919561831, 941.8493041113389, 982.415462799633, 999.4608303212971, 1033.503918119292, 1078.8489611454402, 29430.969916052836, 29721.851390742908, 29795.40409191804, 29828.955986540368, 29979.25051873677, 865.2688478235881, 879.0945326313907, 939.5912777941618, 1075.516017791981, 1132.750794825137, 12271.141020128684, 14455.0, 14860.18268995194, 14922.850771492145, 15173.848261517243, 517700.0, 528659.7134028687, 529487.0, 530817.0, 531147.0, 59196.0, 59605.403945960854, 59731.70134149301, 59926.0, 59976.0, 1289.8645642207432, 1315.1122991980567, 1321.5044358365612, 1351.8310211223597, 1403.8385585657577, 29227.7077229225, 29388.7061129386, 29515.114546563636, 29874.551881722226, 30046.0, 43733.90665233395, 52645.0, 52854.20718689146, 54115.18827217674, 57292.71353643205, 480670.0, 485350.0, 491427.0, 492530.0, 493559.0, 33033.00900972974, 34049.65950340465, 34099.48850767191, 34283.485747713305, 34444.13889652779, 44742.328865066396, 45373.0, 45827.0, 46159.53840461552, 46699.52202877841, 36746.448803267434, 37931.2413751729, 37984.0, 38846.6115338843, 39084.609153908095, 33194.5020824683, 35942.460863087595, 37444.62555374411, 37487.81256093702, 38156.0, 34521.82739086288, 36381.90854274376, 36813.81593092017, 38010.239795203386, 38307.04232394212, 31307.53038704467, 32137.35725285528, 32225.194370140933, 32264.0, 32647.673523264464, 20062.197512099352, 20975.160993560086, 21793.455163621038, 24571.262862114167, 24710.752892470846], "unit": "score", "name": "ext.html", "value": 19902.711839207746}, {"lowerIsBetter": false, "replicates": [306.4376868446401, 338.3030956230166, 356.2803137661925, 356.94344739570863, 367.74993004756755, 18613.348532801356, 18706.345277915276, 19133.42599722009, 19293.807061929376, 19341.903290483562, 19175.712364314546, 20413.0, 20468.590628187427, 20620.793792062075, 20659.070341834617, 5655.943440565604, 5950.345461999198, 5995.790147344844, 5998.850028749294, 6002.039673652216, 4169.4162817205615, 5308.5487733542695, 5847.44449277318, 6429.32492088331, 6453.064305675674, 5481.945180548183, 6361.4274715275615, 6382.138411314483, 6394.392532709385, 6398.872022559546, 6137.693115344237, 6462.32145624712, 6467.094606755058, 6481.060246264313, 6483.319251478598, 5482.533984611313, 5582.0, 5589.329280486327, 5596.664200147963, 5602.467765562265, 24347.14784982535, 24576.877115614487, 24732.505349893083, 24765.5046899061, 24835.62746558803, 2159.676048592708, 2175.0, 2274.4541310085624, 2300.9654855177187, 2857.557078652812, 12158.756824863542, 13276.402561884643, 14461.91535634821, 14603.269836508132, 14792.926035369863, 1728.9221985010704, 1755.95610109747, 1790.498660375097, 1825.2151574822822, 1944.474991752219, 74825.0, 99608.0, 100636.0, 101032.93802371882, 102907.45638815424, 10926.125909927187, 11155.72110697239, 11205.551777928791, 11240.943795280971, 11270.211085223955, 13544.255065971467, 13571.52499662507, 13583.932080339535, 13613.591592252249, 13624.318784060757, 8378.204070613281, 8533.359998000175, 8559.529225892637, 8601.139886011473, 8608.741737747878, 8589.914100859036, 8608.182222688834, 8666.6100025499, 8689.6524139035, 8691.695790647424, 4401.40581021558, 4465.508794032654, 4471.1728330259, 4471.680854148034, 4531.864044078683, 1589.5628702106783, 1772.7961284452194, 1821.5537193387704, 1873.4754268804757, 1882.124811962444, 741.7885902517756, 878.3982971664431, 912.543728135932, 970.6942313171328, 1038.2991480750463, 17524.386646467567, 19189.904050479938, 19238.422847314603, 20138.59722805565, 20162.773956166944, 927.6614035876856, 965.0831709875646, 965.6330594374093, 966.3042609321277, 1049.2917280835406, 10342.431166285927, 10384.740381490372, 10417.270791044706, 10464.895351046544, 10587.100096491731, 485257.0, 558765.0, 610445.0, 623336.0, 630820.8458957768, 80692.0, 94624.0, 94987.0, 105619.55043596648, 108258.0, 1019.4087429290994, 1025.2259544044198, 1034.2088302448783, 1040.3653771199563, 1041.739565108723, 14623.561293161221, 17062.744058838878, 17675.204615792576, 17744.0, 17777.911110444365, 35927.92216233517, 47966.76016619895, 49903.75048124736, 50412.739681508254, 50693.0, 71543.64228178826, 71636.0, 72455.0, 72717.0, 72954.63522682352, 7195.812690906151, 7653.808654783675, 7704.30661240491, 7731.92268077312, 8042.879356809535, 10087.445190514298, 11788.4695188715, 12233.898949094624, 12268.263904165779, 12353.38233088324, 10484.895151048391, 10560.0, 10710.946445267724, 10818.404987725437, 10820.89179108199, 10397.896021039693, 10508.369497830156, 10546.367217966947, 10854.945725271324, 10858.728531786768, 10326.793464130826, 10922.781544369227, 10984.340939543654, 11044.447777611247, 11266.66200014001, 7685.23147685227, 7764.0, 7779.7666070017995, 7815.25755053269, 7967.681292748225, 10400.843987340044, 10666.679999600025, 10912.181586381212, 10920.453977300944, 10935.0], "unit": "score", "name": "jquery.html", "value": 9284.012612764047}, {"lowerIsBetter": false, "replicates": [1455.3160014793048, 1557.629286228119, 1855.3599008342126, 1974.624821283955, 1987.8210961013506, 7938.523688578689, 8578.571071446433, 8680.131986801316, 8829.205371516562, 8832.293416526678, 8616.483011019327, 8631.093735157812, 8697.391182617219, 8713.433626814269, 8742.431741936785, 2437.5740191987666, 2470.567650661136, 2470.9135180268604, 2474.208253358926, 2485.0184177249976, 2377.286813955815, 2473.6907886514186, 2478.677771889652, 2480.9751902481016, 2481.7146028206807, 2425.6846609940685, 2441.2310122311505, 2471.851688898663, 2480.355107672009, 2484.5527804995095, 2021.878687278768, 2348.330725743155, 2417.129833260025, 2443.5723748344058, 2462.630605409185, 2444.584420648494, 2446.8531888086595, 2460.9261722148362, 2465.778079972793, 2466.260121963404, 8812.735617931472, 8818.955905220497, 8838.425502342392, 8850.557472126367, 8858.202761751474, 5282.181261904411, 5392.973035134838, 5452.073147564924, 5475.917861232085, 5485.561155107582, 3556.733245006609, 3594.622564630702, 3659.79871107089, 3705.203381273039, 3769.981150094232, 873.275181599271, 921.806420651664, 969.9515024248759, 1039.26212389203, 1083.685731137969, 11643.708907277301, 11722.765544689144, 11827.053835693125, 11872.881271187263, 12296.077794165383, 4330.155619654201, 4707.764611769398, 4975.0547395994645, 4990.975045124751, 4991.975040124777, 10082.798344033079, 10148.188144948386, 10168.33905796121, 10221.33561318512, 10228.48857557134, 4766.642501812378, 5441.537469315073, 5567.860803479945, 5571.66570005801, 5576.944230557724, 3713.591504934455, 4873.537013983666, 4974.502549744997, 4981.651284410056, 5031.949680503149, 3867.57456679765, 3959.604039596075, 3961.870866802947, 3972.801359931992, 4007.358822588372, 1324.635725175565, 1331.8135461035463, 1340.671535473815, 1342.838859336886, 1342.9932850335686, 1384.2455861555477, 1385.0, 1388.8055672205899, 1392.4291040673274, 1422.3101795629111, 8151.429399941947, 8180.918190818015, 8281.585920703941, 8285.337173026144, 8289.792755181048, 1290.316132449803, 1305.3473263368317, 1333.7199188170594, 1334.599620113962, 1345.2533843716635, 6187.102870083812, 6190.938090619036, 6287.434130928147, 6318.368163183645, 6355.968220158869, 10165.796684066425, 10636.41499717523, 10662.933706629276, 10671.94664026675, 10695.893041069645, 10428.634997775192, 10492.0, 10500.894991050145, 10609.9469502652, 10617.416042117758, 8355.874661880076, 8371.079181290053, 8385.874211886827, 8427.0, 8582.78543036429, 7902.4863383879865, 7933.325667318342, 7985.480943738638, 7991.760247192594, 8086.15095414973, 9379.202767764817, 9411.058894110534, 9510.714678559654, 9603.327767056238, 9649.614015439585, 9476.857847132436, 9802.411855288705, 9904.059114384121, 9920.255980801325, 9933.503324833873, 6782.491313151632, 7207.099112610924, 7459.328660420588, 7464.738734144279, 7579.886301705368, 8146.796330091795, 8181.590920453835, 8214.876776848232, 8231.42380033392, 8286.83426331482, 7316.743913962986, 7335.853282934205, 7461.813454663677, 7554.055743032121, 7659.770206893802, 6819.352161544645, 6916.23921368639, 7287.8178045547165, 7352.96323518379, 7385.741499047507, 6005.279366476051, 7603.88594171099, 7637.236276372319, 7770.0, 7785.610719464117, 6226.7235216781355, 6261.5616906816085, 6674.966625166843, 6989.33601307875, 7043.506954513135, 6846.5892046477375, 7125.964370178116, 7133.892991605234, 7224.0, 7231.819204519929], "unit": "score", "name": "mootools.html", "value": 4962.617850761047}, {"lowerIsBetter": false, "replicates": [278.56126600604046, 311.58092365768033, 332.49958811987955, 333.29840685357317, 335.79013116801997, 5752.5685573581995, 6686.264510903803, 6744.966275168624, 6917.584944903297, 6947.965260173692, 6634.900476492857, 6734.090897728805, 6798.082258895048, 6829.795106146811, 6842.486813488996, 4666.370040044584, 4770.594499467532, 4894.192458244385, 4954.281629163769, 4981.501849815026, 4875.756212189394, 4893.681910675812, 4899.093667671492, 4900.338454308676, 4919.827806026789, 4801.18379875422, 4808.927866081994, 4829.975850120744, 4834.7824347904425, 4856.587190088847, 4825.2279635258365, 4842.564169224752, 4868.537488938545, 4881.560659540658, 4888.877778055541, 4143.0, 4156.896077598054, 4161.708680392374, 4162.229987452331, 4171.958280417218, 6264.185655864754, 6504.3170467100745, 6507.121538592277, 6533.18335208099, 6564.1138446309615, 5824.708764561755, 5830.300363956352, 5835.416458354173, 5857.560682948753, 5880.764769409218, 6260.686965651745, 6800.727970881158, 7172.031775710265, 7185.461090418187, 7188.892166617505, 4640.744759038252, 4646.303054541812, 4667.533246675339, 4668.299755036738, 4672.3692301539195, 7611.467197296191, 7667.923320766777, 7680.9615951921, 7698.191689872595, 7707.113681926538, 3930.4104384342004, 4534.478534968455, 4702.4592171899985, 4704.623630109583, 4709.62323014158, 4760.166970780099, 4770.499097594703, 4782.832600858953, 4792.592629626521, 4794.400699912511, 5767.36558978512, 5785.392533783892, 5797.391273916262, 5803.7968671096305, 5830.183774271605, 7246.275372462712, 7254.927450725425, 7261.854762904818, 7273.345398914017, 7323.780286591411, 1393.191948669769, 1640.5406486183888, 1661.3188592677186, 1663.20166320167, 1665.84174503422, 1019.108280254777, 1056.8467572201987, 1057.0486562094022, 1059.3061544688242, 1069.6095924987324, 5621.0, 6697.430718388894, 6710.16122984627, 6774.729010839511, 6827.385535301847, 7514.849703005909, 7518.624068796647, 7534.849303014019, 7535.510191837513, 7538.698452061966, 6551.6069035857045, 6665.400113989667, 6802.557833740791, 7047.788566343018, 7091.82270443243, 3961.7622942623534, 3979.1047014421524, 3984.4222587724616, 3993.4409182714444, 3996.8001599920467, 7915.050193976645, 7917.7624671259955, 7920.643571039317, 7938.087119981161, 7957.562334071682, 6357.618542887349, 7503.737369192052, 7758.262965018314, 7803.297703206738, 7823.530588164728, 6458.515611329169, 7929.32600728933, 7949.483283586548, 7974.5613991229875, 7982.082060562993, 7514.0, 7559.508631938907, 7561.848763024599, 7581.54510729358, 7591.0, 7393.223711510214, 7411.518251313647, 7426.591537465275, 7432.108147022392, 7476.25237476248, 7640.235976402315, 7898.723544675909, 7923.0, 7949.3243074339325, 7961.243681850215, 4665.580097791215, 4724.338592597108, 4726.598239149711, 4731.810727570859, 4742.834000809955, 6125.693715314127, 7116.359527642537, 7550.848983020199, 7561.0, 7684.847272909108, 7278.745243916437, 7285.453590980804, 7288.198298187302, 7299.379552738077, 7306.2693730626515, 7027.297270272932, 7173.0675012248075, 7240.094988126484, 7246.949192367183, 7309.049823522908, 7091.5390499619425, 7102.573845569283, 7105.0461123191535, 7109.289071093056, 7116.928830711627, 5943.940560594512, 7253.165885922976, 7259.201487836228, 7275.126984761862, 7278.053852999288, 6011.609245399035, 6910.101686780687, 7094.53885497441, 7106.751263705745, 7165.641717914188], "unit": "score", "name": "prototype.html", "value": 5238.216504148215}, {"lowerIsBetter": false, "replicates": [616.3866952382381, 674.2549482821482, 687.3779229797035, 721.4516967105005, 730.9926900730994, 14848.030393921219, 14855.257237138154, 14947.850521494782, 15039.774403383957, 15083.547493575197, 15387.384504619802, 15671.84328156718, 15713.84286157138, 15754.684906301867, 15787.447439339625, 733.1678544851605, 917.614601867214, 931.2456909902967, 932.4358762948386, 932.9766755831091, 861.2378045429808, 920.4891285336636, 929.2426672262085, 930.6603089872182, 936.2650319499195, 793.9166387529312, 938.9201917836992, 940.9106134917172, 978.3689520259428, 985.1970643925214, 944.8299306124894, 950.5674917912368, 965.7971825916566, 975.229568640773, 975.7024107647164, 710.9253528379497, 720.85582883423, 723.8986541884141, 724.3155218318691, 728.4864170759655, 15478.845211547852, 15543.689126217525, 15551.688966220725, 15581.065136091871, 15682.451114211062, 12377.443015064344, 12383.504659813596, 12442.129050966436, 12604.68488287791, 12629.305388203646, 10015.44915029673, 10095.040971107734, 10113.69658910234, 10117.797644047152, 10143.442110683909, 3392.542006829096, 3458.9654103458893, 3493.4061209594174, 3493.7030352420074, 3510.526078979356, 85464.14535854624, 85826.57086714589, 87414.56292718559, 87899.56050219708, 88397.55801220953, 9282.582283797245, 9355.625774968925, 9456.57445414958, 9491.620335186515, 9689.031096890254, 21168.364949051553, 21358.572828543343, 21370.252041178795, 21403.822789746715, 21415.571688566142, 7192.352688258082, 7353.485256032026, 7368.668409921566, 7431.071116110486, 7451.925480745232, 4118.19695159441, 4165.0, 4172.833086676499, 4174.497181014833, 4186.35111557709, 3583.8028908409765, 3609.5488063992, 3621.94567081494, 3631.891043268706, 3666.523351964281, 645.3643161485933, 653.996115961996, 657.4181849063517, 657.6645910585636, 661.4080398043724, 529.3489008519466, 574.5575906551932, 582.2547139661241, 586.1442294250357, 596.2904144068631, 8013.639386227634, 8196.959015204886, 8212.17878212186, 8213.835723285501, 8500.404971651926, 535.5902734408181, 572.4676051272273, 587.6209844650176, 611.065070442224, 617.42159588122, 3713.832877520518, 3789.3368660484307, 3835.7506762060375, 3843.2121415109837, 3845.5962123977138, 95085.0, 96902.0, 97805.0, 97853.0, 97914.5104274474, 72800.54398911992, 73003.26996730072, 73172.53654926871, 73680.26319736734, 74654.6267268671, 72102.63948680223, 73182.0, 73502.63248683616, 73630.0, 74874.0, 7657.502262352929, 7693.3076023155945, 7739.458237923516, 7796.259355361231, 7846.0, 42846.57153428426, 51742.0, 52631.73684131555, 53449.73275133599, 53571.19643205433, 67962.66018669875, 73197.0, 73248.26751732414, 74248.62875685588, 74479.0, 9951.800963980824, 10855.077318427706, 10902.454877256265, 11251.268667536584, 11482.655520334403, 11905.40472976365, 11949.283043017447, 12034.277943323428, 12125.75748485043, 12271.325077120488, 11354.886451135713, 11369.715757105807, 11560.768784624428, 11589.942050289694, 11662.895871598052, 9411.388259763093, 9672.70981870545, 10345.431001295, 10593.735156621146, 11163.720906977065, 9815.0, 10980.945095274472, 10988.560457581607, 10993.395363255098, 11346.092312614806, 9489.620415183315, 9626.566804493674, 9719.416834989923, 9760.511974401394, 9807.705768826947, 8720.738377848675, 9376.666483924635, 9595.088466595662, 9642.614295428384, 9833.574131750713], "unit": "score", "name": "yui.html", "value": 6923.226245679756}], "name": "dromaeo_css", "value": 7584.628876624092}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 112.0, 116.0, 116.0, 116.0, 126.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 159.0, 177.0, 149.0, 170.0, 139.0, 137.0, 191.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [237.0, 257.0, 203.0, 248.0, 266.0, 185.0, 271.0, 278.0, 206.0, 196.0], "unit": "score", "name": "audio-dft", "value": 234.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 120.0, 59.0, 48.0, 50.0, 82.0, 100.0, 80.0], "unit": "score", "name": "audio-fft", "value": 74.6}, {"lowerIsBetter": true, "replicates": [84.0, 89.0, 119.0, 79.0, 82.0, 84.0, 116.0, 79.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 92.6}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 79.0, 83.0, 95.0, 127.0, 103.0, 85.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.4}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 97.0, 89.0, 99.0, 146.0, 147.0, 103.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 111.4}, {"lowerIsBetter": true, "replicates": [93.0, 125.0, 144.0, 114.0, 92.0, 92.0, 91.0, 131.0, 85.0, 150.0], "unit": "score", "name": "imaging-desaturate", "value": 111.7}, {"lowerIsBetter": true, "replicates": [53.0, 47.0, 46.0, 58.0, 69.0, 78.0, 82.0, 93.0, 88.0, 84.0], "unit": "score", "name": "json-parse-financial", "value": 69.8}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 66.0, 80.0, 71.0, 77.0, 70.0, 67.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 83.0, 86.0, 83.0, 75.0, 106.0, 112.0, 108.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.9}, {"lowerIsBetter": true, "replicates": [115.0, 153.0, 114.0, 129.0, 134.0, 110.0, 127.0, 134.0, 139.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.6}, {"lowerIsBetter": true, "replicates": [129.0, 130.0, 184.0, 176.0, 131.0, 166.0, 176.0, 147.0, 142.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 72.0, 90.0, 69.0, 69.0, 66.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1573.3}]} 02:08:37 INFO - Return code: 0 02:08:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:08:37 ERROR - # TBPL SUCCESS # 02:08:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:08:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:08:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:08:37 INFO - 2016-03-18 02:08:37.240 screenresolution[1680:10625] starting screenresolution argv=screenresolution get 02:08:37 INFO - 2016-03-18 02:08:37.244 screenresolution[1680:10625] Display 0: 1600x1200x32@60 02:08:37 INFO - 2016-03-18 02:08:37.250 screenresolution[1681:10628] starting screenresolution argv=screenresolution list 02:08:37 INFO - Available Modes on Display 0 02:08:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:08:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:08:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:08:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:08:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:08:37 INFO - Intel Iris: 02:08:37 INFO - Chipset Model: Intel Iris 02:08:37 INFO - Type: GPU 02:08:37 INFO - Bus: Built-In 02:08:37 INFO - VRAM (Dynamic, Max): 1536 MB 02:08:37 INFO - Vendor: Intel (0x8086) 02:08:37 INFO - Device ID: 0x0a2e 02:08:37 INFO - Revision ID: 0x0009 02:08:37 INFO - Displays: 02:08:37 INFO - Display: 02:08:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:08:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:08:37 INFO - Display Serial Number: 1600x1200 60 02:08:37 INFO - Main Display: Yes 02:08:37 INFO - Mirror: Off 02:08:37 INFO - Online: Yes 02:08:37 INFO - Rotation: Supported 02:08:37 INFO - Return code: 0 02:08:37 INFO - Running post-action listener: _resource_record_post_action 02:08:37 INFO - Running post-run listener: _resource_record_post_run 02:08:38 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39134720; Write bytes: 704870912; Read time: 430; Write time: 1839 02:08:38 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397777408; Write bytes: 391755264; Read time: 30104; Write time: 671 02:08:38 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37320192; Write bytes: 300045312; Read time: 410; Write time: 1131 02:08:38 INFO - Running post-run listener: _upload_blobber_files 02:08:38 INFO - Blob upload gear active. 02:08:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:08:38 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 02:08:38 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'] 02:08:38 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 02:08:38 INFO - (blobuploader) - INFO - Open directory for files ... 02:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:40 INFO - (blobuploader) - INFO - Done attempting. 02:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:41 INFO - (blobuploader) - INFO - Done attempting. 02:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 02:08:41 INFO - Return code: 0 02:08:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4713d08fc1c951689d8423608e131ec81dbd21cd7eb2bcabf27d23511a1a0a19a12614d0cad580b8adb7cdb48f988945ce135cd59b40546495d42f8f9dedbb85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de25cd286fc02c371750d2f2d537a0cee51446c1e4bcbe29fb35f5370faf74830f23e6a974c668f082c0de0cbc49f8ac17f90ee6de7402e52c171fae10cf8018"} 02:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:08:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:08:41 INFO - Contents: 02:08:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4713d08fc1c951689d8423608e131ec81dbd21cd7eb2bcabf27d23511a1a0a19a12614d0cad580b8adb7cdb48f988945ce135cd59b40546495d42f8f9dedbb85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de25cd286fc02c371750d2f2d537a0cee51446c1e4bcbe29fb35f5370faf74830f23e6a974c668f082c0de0cbc49f8ac17f90ee6de7402e52c171fae10cf8018"} 02:08:41 INFO - Running post-run listener: copy_logs_to_upload_dir 02:08:41 INFO - Copying logs to upload dir... 02:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs 02:08:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.829495 ========= master_lag: 30.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-03-18 02:09:11.754046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-18 02:09:11.757255) ========= 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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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/4713d08fc1c951689d8423608e131ec81dbd21cd7eb2bcabf27d23511a1a0a19a12614d0cad580b8adb7cdb48f988945ce135cd59b40546495d42f8f9dedbb85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de25cd286fc02c371750d2f2d537a0cee51446c1e4bcbe29fb35f5370faf74830f23e6a974c668f082c0de0cbc49f8ac17f90ee6de7402e52c171fae10cf8018"} build_url:https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/C-x5ert7TGCM_0yDR5cokg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4713d08fc1c951689d8423608e131ec81dbd21cd7eb2bcabf27d23511a1a0a19a12614d0cad580b8adb7cdb48f988945ce135cd59b40546495d42f8f9dedbb85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de25cd286fc02c371750d2f2d537a0cee51446c1e4bcbe29fb35f5370faf74830f23e6a974c668f082c0de0cbc49f8ac17f90ee6de7402e52c171fae10cf8018"}' ========= master_lag: 4.83 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-18 02:09:16.602723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-03-18 02:09:16.603091) ========= 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.aj4oGWRVU6/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.VWhBxDO9zi/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005178 ========= master_lag: 8.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-03-18 02:09:25.400068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 02:09:25.400400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 02:09:25.945961) ========= ========= Total master_lag: 43.83 =========