builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0114 starttime: 1456251131.45 results: success (0) buildid: 20160223080008 builduid: 2dbdab544e6a47e3bd2a96aa2fe27131 revision: 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.452396) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.452811) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.453113) ========= 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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005675 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.477567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.477840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.521254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.521515) ========= 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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005367 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.576801) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.577104) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.577446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.577718) ========= 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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-23 10:12:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.18M=0.001s 2016-02-23 10:12:11 (8.18 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.697410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.698113) ========= 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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.019841 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.751591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:11.752387) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 --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 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-23 10:12:11,831 truncating revision to first 12 chars 2016-02-23 10:12:11,831 Setting DEBUG logging. 2016-02-23 10:12:11,831 attempt 1/10 2016-02-23 10:12:11,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d32d1f87b74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 10:12:12,497 unpacking tar archive at: fx-team-4d32d1f87b74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914906 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.690889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.691308) ========= echo 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 program finished with exit code 0 elapsedTime=0.005403 script_repo_revision: '4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.747982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.748326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:12:12.762700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-02-23 10:12:12.763162) ========= /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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:12 INFO - MultiFileLogger online at 20160223 10:12:12 in /builds/slave/test 10:12:12 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 10:12:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:12 INFO - {'append_to_log': False, 10:12:12 INFO - 'base_work_dir': '/builds/slave/test', 10:12:12 INFO - 'blob_upload_branch': 'Fx-Team', 10:12:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:12 INFO - 'branch': 'Fx-Team', 10:12:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:12 INFO - 'config_files': ('talos/mac_config.py',), 10:12:12 INFO - 'default_actions': ('clobber', 10:12:12 INFO - 'read-buildbot-config', 10:12:12 INFO - 'download-and-extract', 10:12:12 INFO - 'populate-webroot', 10:12:12 INFO - 'create-virtualenv', 10:12:12 INFO - 'install', 10:12:12 INFO - 'run-tests'), 10:12:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:12 INFO - 'download_minidump_stackwalk': True, 10:12:12 INFO - 'download_symbols': 'ondemand', 10:12:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:12 INFO - 'installer_path': 'installer.exe', 10:12:12 INFO - 'log_level': 'info', 10:12:12 INFO - 'log_name': 'talos', 10:12:12 INFO - 'log_to_console': True, 10:12:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:12:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:12:12 INFO - 'opt_config_files': (), 10:12:12 INFO - 'pip_index': False, 10:12:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:12 INFO - 'cmd': ('bash', 10:12:12 INFO - '-c', 10:12:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:12 INFO - 'enabled': True, 10:12:12 INFO - 'halt_on_failure': False, 10:12:12 INFO - 'name': 'check_screen_resolution'},), 10:12:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:12 INFO - 'cmd': ('bash', 10:12:12 INFO - '-c', 10:12:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:12 INFO - 'enabled': True, 10:12:12 INFO - 'halt_on_failure': False, 10:12:12 INFO - 'name': 'check_screen_resolution'},), 10:12:12 INFO - 'run_cmd_checks_enabled': True, 10:12:12 INFO - 'sps_profile': False, 10:12:12 INFO - 'sps_profile_interval': 0, 10:12:12 INFO - 'suite': 'dromaeojs-e10s', 10:12:12 INFO - 'system_bits': '32', 10:12:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:12 INFO - 'title': 't-yosemite-r7-0114', 10:12:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:12 INFO - 'use_talos_json': True, 10:12:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:12 INFO - 'work_dir': 'build'} 10:12:12 INFO - ##### 10:12:12 INFO - ##### Running clobber step. 10:12:12 INFO - ##### 10:12:12 INFO - Running pre-action listener: _resource_record_pre_action 10:12:12 INFO - Running main action method: clobber 10:12:12 INFO - rmtree: /builds/slave/test/build 10:12:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - ##### 10:12:13 INFO - ##### Running read-buildbot-config step. 10:12:13 INFO - ##### 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: read_buildbot_config 10:12:13 INFO - Using buildbot properties: 10:12:13 INFO - { 10:12:13 INFO - "project": "", 10:12:13 INFO - "product": "firefox", 10:12:13 INFO - "script_repo_revision": "production", 10:12:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:12:13 INFO - "repository": "", 10:12:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:12:13 INFO - "buildid": "20160223080008", 10:12:13 INFO - "pgo_build": "False", 10:12:13 INFO - "basedir": "/builds/slave/test", 10:12:13 INFO - "buildnumber": 493, 10:12:13 INFO - "slavename": "t-yosemite-r7-0114", 10:12:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:12:13 INFO - "platform": "yosemite_r7", 10:12:13 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:12:13 INFO - "branch": "fx-team", 10:12:13 INFO - "repo_path": "integration/fx-team", 10:12:13 INFO - "revision": "4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099", 10:12:13 INFO - "stage_platform": "macosx64", 10:12:13 INFO - "builduid": "2dbdab544e6a47e3bd2a96aa2fe27131", 10:12:13 INFO - "slavebuilddir": "test" 10:12:13 INFO - } 10:12:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:12:13 INFO - Running post-action listener: _resource_record_post_action 10:12:13 INFO - ##### 10:12:13 INFO - ##### Running download-and-extract step. 10:12:13 INFO - ##### 10:12:13 INFO - Running pre-action listener: _resource_record_pre_action 10:12:13 INFO - Running main action method: download_and_extract 10:12:13 INFO - mkdir: /builds/slave/test/build/tests 10:12:13 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')]} 10:12:13 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:12:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json 10:12:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json 10:12:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:12:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:12:14 INFO - Downloaded 1277 bytes. 10:12:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:12:14 INFO - Using the following test package requirements: 10:12:14 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:12:14 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:12:14 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:12:14 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'jsshell-mac.zip'], 10:12:14 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:12:14 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:12:14 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:12:14 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:12:14 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:12:14 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:12:14 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:12:14 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:12:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:14 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:12:15 INFO - Downloaded 17825734 bytes. 10:12:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:12:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:12:18 INFO - Return code: 0 10:12:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:12:19 INFO - Downloaded 17825734 bytes. 10:12:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:12:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:12:23 INFO - Return code: 0 10:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:23 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:12:24 INFO - Downloaded 10707015 bytes. 10:12:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:12:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:12:24 INFO - Return code: 0 10:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:24 INFO - https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:12:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:12:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:12:28 INFO - Downloaded 111443570 bytes. 10:12:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:28 INFO - mkdir: /builds/slave/test/properties 10:12:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:28 INFO - Contents: 10:12:28 INFO - build_url:https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:12:29 INFO - Running post-action listener: _resource_record_post_action 10:12:29 INFO - Running post-action listener: set_extra_try_arguments 10:12:29 INFO - ##### 10:12:29 INFO - ##### Running populate-webroot step. 10:12:29 INFO - ##### 10:12:29 INFO - Running pre-action listener: _resource_record_pre_action 10:12:29 INFO - Running main action method: populate_webroot 10:12:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:29 INFO - '--tppagecycles', 10:12:29 INFO - '7'], 10:12:29 INFO - 'tests': ['tsvgm']}}, 10:12:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:12:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:12:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'tests': ['damp', 'tps']}, 10:12:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['damp', 'tps']}, 10:12:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:12:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:29 INFO - 'other': {'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore']}, 10:12:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore']}, 10:12:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore']}, 10:12:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore']}, 10:12:29 INFO - 'other_l64': {'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore']}, 10:12:29 INFO - 'other_nol64': {'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore']}, 10:12:29 INFO - 'svgr': {'tests': ['tsvgx', 10:12:29 INFO - 'tsvgr_opacity', 10:12:29 INFO - 'tart', 10:12:29 INFO - 'tscrollx', 10:12:29 INFO - 'cart']}, 10:12:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['tsvgx', 10:12:29 INFO - 'tsvgr_opacity', 10:12:29 INFO - 'tart', 10:12:29 INFO - 'tscrollx', 10:12:29 INFO - 'cart']}, 10:12:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'tests': ['tp5o']}, 10:12:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--e10s'], 10:12:29 INFO - 'tests': ['tp5o']}, 10:12:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--xperf_path', 10:12:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:29 INFO - 'tests': ['tp5n']}, 10:12:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--e10s', 10:12:29 INFO - '--xperf_path', 10:12:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:29 INFO - 'tests': ['tp5n']}}, 10:12:29 INFO - 'talos.zip': {'path': '', 10:12:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:29 INFO - Running post-action listener: _resource_record_post_action 10:12:29 INFO - ##### 10:12:29 INFO - ##### Running create-virtualenv step. 10:12:29 INFO - ##### 10:12:29 INFO - Running pre-action listener: _resource_record_pre_action 10:12:29 INFO - Running main action method: create_virtualenv 10:12:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:12:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:29 INFO - Using real prefix '/tools/python27' 10:12:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:33 INFO - Installing pip.................done. 10:12:33 INFO - Return code: 0 10:12:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:33 INFO - 'HOME': '/Users/cltbld', 10:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:33 INFO - 'LOGNAME': 'cltbld', 10:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:33 INFO - 'MOZ_NO_REMOTE': '1', 10:12:33 INFO - 'NO_EM_RESTART': '1', 10:12:33 INFO - 'PAGER': '/bin/cat', 10:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:33 INFO - 'PWD': '/builds/slave/test', 10:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:33 INFO - 'SHELL': '/bin/bash', 10:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:33 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:33 INFO - 'USER': 'cltbld', 10:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:33 INFO - 'XPC_FLAGS': '0x0', 10:12:33 INFO - 'XPC_SERVICE_NAME': '0', 10:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:12:33 INFO - Cleaning up... 10:12:33 INFO - Return code: 0 10:12:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:33 INFO - 'HOME': '/Users/cltbld', 10:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:33 INFO - 'LOGNAME': 'cltbld', 10:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:33 INFO - 'MOZ_NO_REMOTE': '1', 10:12:33 INFO - 'NO_EM_RESTART': '1', 10:12:33 INFO - 'PAGER': '/bin/cat', 10:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:33 INFO - 'PWD': '/builds/slave/test', 10:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:33 INFO - 'SHELL': '/bin/bash', 10:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:33 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:33 INFO - 'USER': 'cltbld', 10:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:33 INFO - 'XPC_FLAGS': '0x0', 10:12:33 INFO - 'XPC_SERVICE_NAME': '0', 10:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:33 INFO - Downloading/unpacking psutil>=0.7.1 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 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 10:12:33 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 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:36 INFO - Installing collected packages: psutil 10:12:36 INFO - Running setup.py install for psutil 10:12:36 INFO - building 'psutil._psutil_osx' extension 10:12:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:12:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:12:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:12:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:12:37 INFO - building 'psutil._psutil_posix' extension 10:12:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:12:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:12:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:12:37 INFO - ^ 10:12:37 INFO - 1 warning generated. 10:12:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:12:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:37 INFO - Successfully installed psutil 10:12:37 INFO - Cleaning up... 10:12:37 INFO - Return code: 0 10:12:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:37 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 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:37 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 10:12:37 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 10:12:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:37 INFO - 'HOME': '/Users/cltbld', 10:12:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:37 INFO - 'LOGNAME': 'cltbld', 10:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:37 INFO - 'MOZ_NO_REMOTE': '1', 10:12:37 INFO - 'NO_EM_RESTART': '1', 10:12:37 INFO - 'PAGER': '/bin/cat', 10:12:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:37 INFO - 'PWD': '/builds/slave/test', 10:12:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:37 INFO - 'SHELL': '/bin/bash', 10:12:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:37 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:37 INFO - 'USER': 'cltbld', 10:12:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:37 INFO - 'XPC_FLAGS': '0x0', 10:12:37 INFO - 'XPC_SERVICE_NAME': '0', 10:12:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:37 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 10:12:37 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 10:12:37 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 10:12:37 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 10:12:37 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 10:12:37 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 10:12:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:12:40 INFO - Installing collected packages: mozsystemmonitor 10:12:40 INFO - Running setup.py install for mozsystemmonitor 10:12:40 INFO - Successfully installed mozsystemmonitor 10:12:40 INFO - Cleaning up... 10:12:40 INFO - Return code: 0 10:12:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:12:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:40 INFO - 'HOME': '/Users/cltbld', 10:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:40 INFO - 'LOGNAME': 'cltbld', 10:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:40 INFO - 'MOZ_NO_REMOTE': '1', 10:12:40 INFO - 'NO_EM_RESTART': '1', 10:12:40 INFO - 'PAGER': '/bin/cat', 10:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:40 INFO - 'PWD': '/builds/slave/test', 10:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:40 INFO - 'SHELL': '/bin/bash', 10:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:40 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:40 INFO - 'USER': 'cltbld', 10:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:40 INFO - 'XPC_FLAGS': '0x0', 10:12:40 INFO - 'XPC_SERVICE_NAME': '0', 10:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:40 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:40 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 10:12:40 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 10:12:40 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 10:12:40 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 10:12:40 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 10:12:40 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 10:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:44 INFO - Downloading docopt-0.6.1.tar.gz 10:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:44 INFO - Running setup.py install for blobuploader 10:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:44 INFO - Running setup.py install for requests 10:12:45 INFO - Running setup.py install for docopt 10:12:45 INFO - Successfully installed blobuploader requests docopt 10:12:45 INFO - Cleaning up... 10:12:45 INFO - Return code: 0 10:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:45 INFO - 'HOME': '/Users/cltbld', 10:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:45 INFO - 'LOGNAME': 'cltbld', 10:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:45 INFO - 'MOZ_NO_REMOTE': '1', 10:12:45 INFO - 'NO_EM_RESTART': '1', 10:12:45 INFO - 'PAGER': '/bin/cat', 10:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:45 INFO - 'PWD': '/builds/slave/test', 10:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:45 INFO - 'SHELL': '/bin/bash', 10:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:45 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:45 INFO - 'USER': 'cltbld', 10:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:45 INFO - 'XPC_FLAGS': '0x0', 10:12:45 INFO - 'XPC_SERVICE_NAME': '0', 10:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-0F3PvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-SdGAIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-C8As7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-8WhvoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:45 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YvpMYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-l3PUXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-0SmBdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bhUBmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-y2j_mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-UDSKjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-5R6rDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-D4ZzZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-tNfs3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:46 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-LNi45Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:47 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-yV7X3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:47 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-WM4wj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:47 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-etLwVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:47 INFO - Running setup.py install for manifestparser 10:12:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:47 INFO - Running setup.py install for mozcrash 10:12:47 INFO - Running setup.py install for mozdebug 10:12:47 INFO - Running setup.py install for mozdevice 10:12:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:47 INFO - Running setup.py install for mozfile 10:12:48 INFO - Running setup.py install for mozhttpd 10:12:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Running setup.py install for mozinfo 10:12:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Running setup.py install for mozInstall 10:12:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Running setup.py install for mozleak 10:12:48 INFO - Running setup.py install for mozlog 10:12:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:48 INFO - Running setup.py install for moznetwork 10:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozprocess 10:12:49 INFO - Running setup.py install for mozprofile 10:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozrunner 10:12:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Running setup.py install for mozscreenshot 10:12:49 INFO - Running setup.py install for moztest 10:12:49 INFO - Running setup.py install for mozversion 10:12:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:49 INFO - Cleaning up... 10:12:49 INFO - Return code: 0 10:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:49 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 10:12:49 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 10:12:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:49 INFO - 'HOME': '/Users/cltbld', 10:12:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:49 INFO - 'LOGNAME': 'cltbld', 10:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:49 INFO - 'MOZ_NO_REMOTE': '1', 10:12:49 INFO - 'NO_EM_RESTART': '1', 10:12:49 INFO - 'PAGER': '/bin/cat', 10:12:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:49 INFO - 'PWD': '/builds/slave/test', 10:12:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:49 INFO - 'SHELL': '/bin/bash', 10:12:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:49 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:49 INFO - 'USER': 'cltbld', 10:12:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:49 INFO - 'XPC_FLAGS': '0x0', 10:12:49 INFO - 'XPC_SERVICE_NAME': '0', 10:12:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-sj2CUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-JcJLGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-vKzTxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-tqXgXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-H7SPDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-2OEo1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:50 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)) 10:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:50 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-F3QqWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-vWilNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-v2jJXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-HdYHbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-X5YdRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-CXDMLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-_1RQwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-5SWz6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Birhes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:51 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)) 10:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:51 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-whOhgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:52 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-CiaFOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:54 INFO - Downloading blessings-1.6.tar.gz 10:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:54 INFO - Installing collected packages: blessings 10:12:54 INFO - Running setup.py install for blessings 10:12:54 INFO - Successfully installed blessings 10:12:54 INFO - Cleaning up... 10:12:54 INFO - Return code: 0 10:12:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:55 INFO - Reading from file tmpfile_stdout 10:12:55 INFO - Current package versions: 10:12:55 INFO - blessings == 1.6 10:12:55 INFO - blobuploader == 1.2.4 10:12:55 INFO - docopt == 0.6.1 10:12:55 INFO - manifestparser == 1.1 10:12:55 INFO - mozInstall == 1.12 10:12:55 INFO - mozcrash == 0.16 10:12:55 INFO - mozdebug == 0.1 10:12:55 INFO - mozdevice == 0.48 10:12:55 INFO - mozfile == 1.2 10:12:55 INFO - mozhttpd == 0.7 10:12:55 INFO - mozinfo == 0.9 10:12:55 INFO - mozleak == 0.1 10:12:55 INFO - mozlog == 3.1 10:12:55 INFO - moznetwork == 0.27 10:12:55 INFO - mozprocess == 0.22 10:12:55 INFO - mozprofile == 0.28 10:12:55 INFO - mozrunner == 6.11 10:12:55 INFO - mozscreenshot == 0.1 10:12:55 INFO - mozsystemmonitor == 0.0 10:12:55 INFO - moztest == 0.7 10:12:55 INFO - mozversion == 1.4 10:12:55 INFO - psutil == 3.1.1 10:12:55 INFO - requests == 1.2.3 10:12:55 INFO - wsgiref == 0.1.2 10:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:55 INFO - 'HOME': '/Users/cltbld', 10:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:55 INFO - 'LOGNAME': 'cltbld', 10:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:55 INFO - 'MOZ_NO_REMOTE': '1', 10:12:55 INFO - 'NO_EM_RESTART': '1', 10:12:55 INFO - 'PAGER': '/bin/cat', 10:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:55 INFO - 'PWD': '/builds/slave/test', 10:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:55 INFO - 'SHELL': '/bin/bash', 10:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:55 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:55 INFO - 'USER': 'cltbld', 10:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:55 INFO - 'XPC_FLAGS': '0x0', 10:12:55 INFO - 'XPC_SERVICE_NAME': '0', 10:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:12:55 INFO - Cleaning up... 10:12:55 INFO - Return code: 0 10:12:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:55 INFO - 'HOME': '/Users/cltbld', 10:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:55 INFO - 'LOGNAME': 'cltbld', 10:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:55 INFO - 'MOZ_NO_REMOTE': '1', 10:12:55 INFO - 'NO_EM_RESTART': '1', 10:12:55 INFO - 'PAGER': '/bin/cat', 10:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:55 INFO - 'PWD': '/builds/slave/test', 10:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:55 INFO - 'SHELL': '/bin/bash', 10:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:55 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:55 INFO - 'USER': 'cltbld', 10:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:55 INFO - 'XPC_FLAGS': '0x0', 10:12:55 INFO - 'XPC_SERVICE_NAME': '0', 10:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:55 INFO - Downloading/unpacking jsonschema 10:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:57 INFO - Downloading/unpacking functools32 (from jsonschema) 10:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:58 INFO - warning: no files found matching '*.txt' 10:12:58 INFO - no previously-included directories found matching 'build' 10:12:58 INFO - no previously-included directories found matching 'dist' 10:12:58 INFO - no previously-included directories found matching '.git*' 10:12:58 INFO - Installing collected packages: jsonschema, functools32 10:12:58 INFO - Running setup.py install for functools32 10:12:58 INFO - warning: no files found matching '*.txt' 10:12:58 INFO - no previously-included directories found matching 'build' 10:12:58 INFO - no previously-included directories found matching 'dist' 10:12:58 INFO - no previously-included directories found matching '.git*' 10:12:58 INFO - Successfully installed jsonschema functools32 10:12:58 INFO - Cleaning up... 10:12:58 INFO - Return code: 0 10:12:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:59 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')]} 10:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:59 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 0x108d1da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d244c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1dba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, '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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 10:12:59 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 10:12:59 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 10:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:59 INFO - 'HOME': '/Users/cltbld', 10:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:59 INFO - 'LOGNAME': 'cltbld', 10:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:59 INFO - 'MOZ_NO_REMOTE': '1', 10:12:59 INFO - 'NO_EM_RESTART': '1', 10:12:59 INFO - 'PAGER': '/bin/cat', 10:12:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:59 INFO - 'PWD': '/builds/slave/test', 10:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:59 INFO - 'SHELL': '/bin/bash', 10:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:12:59 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:59 INFO - 'USER': 'cltbld', 10:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:59 INFO - 'XPC_FLAGS': '0x0', 10:12:59 INFO - 'XPC_SERVICE_NAME': '0', 10:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:59 INFO - Downloading/unpacking flake8 10:12:59 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 10:12:59 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 10:12:59 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 10:12:59 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 10:12:59 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 10:12:59 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 10:13:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:13:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:13:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:13:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:02 INFO - no previously-included directories found matching 'docs/_build' 10:13:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:13:03 INFO - Running setup.py install for pep8 10:13:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:03 INFO - no previously-included directories found matching 'docs/_build' 10:13:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:13:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:13:03 INFO - Cleaning up... 10:13:03 INFO - Return code: 0 10:13:03 INFO - Running post-action listener: _resource_record_post_action 10:13:03 INFO - Running post-action listener: _start_resource_monitoring 10:13:03 INFO - Starting resource monitoring. 10:13:03 INFO - ##### 10:13:03 INFO - ##### Running install step. 10:13:03 INFO - ##### 10:13:03 INFO - Running pre-action listener: _resource_record_pre_action 10:13:03 INFO - Running main action method: install 10:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:03 INFO - Reading from file tmpfile_stdout 10:13:03 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:03 INFO - Reading from file tmpfile_stdout 10:13:03 INFO - Output received: 10:13:03 INFO - Usage: mozinstall [options] installer 10:13:03 INFO - Options: 10:13:03 INFO - -h, --help show this help message and exit 10:13:03 INFO - -d DEST, --destination=DEST 10:13:03 INFO - Directory to install application into. [default: 10:13:03 INFO - "/builds/slave/test"] 10:13:03 INFO - --app=APP Application being installed. [default: firefox] 10:13:03 INFO - mkdir: /builds/slave/test/build/application 10:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:13:37 INFO - Reading from file tmpfile_stdout 10:13:37 INFO - Output received: 10:13:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:13:37 INFO - Running post-action listener: _resource_record_post_action 10:13:37 INFO - ##### 10:13:37 INFO - ##### Running run-tests step. 10:13:37 INFO - ##### 10:13:37 INFO - Running pre-action listener: _resource_record_pre_action 10:13:37 INFO - Running main action method: run_tests 10:13:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:37 INFO - 2016-02-23 10:13:37.586 screenresolution[7576:141379] starting screenresolution argv=screenresolution get 10:13:37 INFO - 2016-02-23 10:13:37.588 screenresolution[7576:141379] Display 0: 1600x1200x32@60 10:13:37 INFO - 2016-02-23 10:13:37.594 screenresolution[7577:141381] starting screenresolution argv=screenresolution list 10:13:37 INFO - Available Modes on Display 0 10:13:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:37 INFO - Intel Iris: 10:13:37 INFO - Chipset Model: Intel Iris 10:13:37 INFO - Type: GPU 10:13:37 INFO - Bus: Built-In 10:13:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:37 INFO - Vendor: Intel (0x8086) 10:13:37 INFO - Device ID: 0x0a2e 10:13:37 INFO - Revision ID: 0x0009 10:13:37 INFO - Displays: 10:13:37 INFO - Display: 10:13:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:37 INFO - Display Serial Number: 1600x1200 60 10:13:37 INFO - Main Display: Yes 10:13:37 INFO - Mirror: Off 10:13:37 INFO - Online: Yes 10:13:37 INFO - Rotation: Supported 10:13:37 INFO - Return code: 0 10:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:37 INFO - Python 2.7.3 10:13:37 INFO - Return code: 0 10:13:37 INFO - grabbing minidump binary from tooltool 10:13: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')]} 10:13:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc1d30>, '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 0x1089e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:13:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:13:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:37 INFO - Return code: 0 10:13:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:13:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:13:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:39 INFO - Return code: 0 10:13:39 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/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 10:13:39 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/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --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 10:13:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9ZtZJ0G2Fi/Render', 10:13:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:39 INFO - 'HOME': '/Users/cltbld', 10:13:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:39 INFO - 'LOGNAME': 'cltbld', 10:13:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:39 INFO - 'MOZ_NO_REMOTE': '1', 10:13:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:39 INFO - 'NO_EM_RESTART': '1', 10:13:39 INFO - 'PAGER': '/bin/cat', 10:13:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:39 INFO - 'PWD': '/builds/slave/test', 10:13:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:39 INFO - 'SHELL': '/bin/bash', 10:13:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sdBjGn4afn/Listeners', 10:13:39 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 10:13:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:39 INFO - 'USER': 'cltbld', 10:13:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:39 INFO - 'XPC_FLAGS': '0x0', 10:13:39 INFO - 'XPC_SERVICE_NAME': '0', 10:13:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:39 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/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 10:13:39 INFO - mozversion application_buildid: 20160223080008 10:13:39 INFO - mozversion application_changeset: 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 10:13:39 INFO - mozversion application_display_name: Nightly 10:13:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:39 INFO - mozversion application_name: Firefox 10:13:39 INFO - mozversion application_remotingname: firefox 10:13:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:13:39 INFO - mozversion application_vendor: Mozilla 10:13:39 INFO - mozversion application_version: 47.0a1 10:13:39 INFO - mozversion platform_buildid: 20160223080008 10:13:39 INFO - mozversion platform_changeset: 4d32d1f87b74a73f07ce343dd3e48c7c5c1eb099 10:13:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:13:39 INFO - mozversion platform_version: 47.0a1 10:13:39 INFO - using testdate: 1456251219 10:13:39 INFO - actual date: 1456251219 10:13:39 INFO - starting webserver on 'localhost:52013' 10:13:39 INFO - SUITE-START | Running 2 tests 10:13:39 INFO - TEST-START | dromaeo_css 10:13:39 INFO - operating with platform_type : mac_ 10:13:39 INFO - Initialising browser for dromaeo_css test... 10:13:39 INFO - TEST-INFO | started process 7595 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmp5uhjpK/profile http://localhost:52013/getInfo.html) 10:13:42 INFO - PROCESS | 7595 | __metrics Screen width/height:1600/1200 10:13:42 INFO - PROCESS | 7595 | colorDepth:24 10:13:42 INFO - PROCESS | 7595 | Browser inner width/height: 1024/689 10:13:42 INFO - PROCESS | 7595 | __metrics 10:13:42 ERROR - PROCESS | 7595 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:13:43 INFO - TEST-INFO | 7595: exit 0 10:13:43 INFO - Browser initialized. 10:13:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:43 INFO - TEST-INFO | started process 7599 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmp5uhjpK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:55 INFO - PROCESS | 7599 | RSS: Main: 255692800 10:13:55 INFO - PROCESS | 7599 | 10:14:44 INFO - PROCESS | 7599 | 1456251284707 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] 10:16:54 INFO - PROCESS | 7599 | Cycle 1(1): loaded http://localhost:52013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52013/tests/dromaeo/cssquery-ext.html) 10:16:55 INFO - PROCESS | 7599 | RSS: Main: 268599296 10:16:55 INFO - PROCESS | 7599 | 10:19:57 INFO - PROCESS | 7599 | Cycle 1(1): loaded http://localhost:52013/tests/dromaeo/cssquery-ext.html (next: http://localhost:52013/tests/dromaeo/cssquery-jquery.html) 10:19:58 INFO - PROCESS | 7599 | RSS: Main: 280297472 10:19:58 INFO - PROCESS | 7599 | 10:23:00 INFO - PROCESS | 7599 | Cycle 1(1): loaded http://localhost:52013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52013/tests/dromaeo/cssquery-mootools.html) 10:23:00 INFO - PROCESS | 7599 | RSS: Main: 281763840 10:23:00 INFO - PROCESS | 7599 | 10:26:02 INFO - PROCESS | 7599 | Cycle 1(1): loaded http://localhost:52013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52013/tests/dromaeo/cssquery-prototype.html) 10:26:03 INFO - PROCESS | 7599 | RSS: Main: 284127232 10:26:03 INFO - PROCESS | 7599 | 10:29:05 INFO - PROCESS | 7599 | Cycle 1(1): loaded http://localhost:52013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52013/tests/dromaeo/cssquery-yui.html) 10:29:06 INFO - PROCESS | 7599 | RSS: Main: 286355456 10:29:06 INFO - PROCESS | 7599 | 10:32:08 INFO - PROCESS | 7599 | Cycle 1(1): loaded http://localhost:52013/tests/dromaeo/cssquery-yui.html (next: http://localhost:52013/tests/dromaeo/cssquery-dojo.html) 10:32:09 INFO - PROCESS | 7599 | RSS: Main: 288137216 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | __start_tp_report 10:32:09 INFO - PROCESS | 7599 | _x_x_mozilla_page_load 10:32:09 INFO - PROCESS | 7599 | _x_x_mozilla_page_load_details 10:32:09 INFO - PROCESS | 7599 | |i|pagename|runs| 10:32:09 INFO - PROCESS | 7599 | |0;dojo.html;2890.8120972136808;2917.4894393481122;3023.758099352052;3438.9484157737625;3531.929361412771;5439.238506609073;5550.333959924815;5556.638818476797;5563.833085007446;5582.5254853337465;4545.4545454545505;5467.6719396836215;5611.494965453108;5613.4386561343845;5782.190493330937;5070.67040642358;5125.231215317714;5128.05131050755;5176.404713457963;5187.584993200554;5156.793728250866;5171.5862730981435;5205.557527610158;5221.399539053001;5250.133727934886;5019.322391477141;5064.366954130734;5125.513076257749;5165.845024649267;5204.193350030751;5093.79624815007;5146.511081447256;5149.639525233235;5179.326687530634;5187.948120518822;5014.548690617826;5051.191809310492;5123.820666276662;5134.743262836881;5147.922781158286;5378.327709036371;5495.917561236584;5506.146547285177;5509.614326997112;5525.0883604205255;6145.784897528565;6152.477039451652;6154.353792851775;6190.164327815733;6205.03821907605;6054.273487181566;6138.0792881067755;6168.75324987;6178.042403427431;6204.379562043805;5627.099664053731;5654.773809047674;5666.065099258617;5688.260526131577;5691.886162276773;4863.221884498464;6097.615421629297;6172.629642221481;6174.722137503823;6184.938150618526;5957.463828255478;5994.880102397928;5996;6016.969915150396;6086.208792856989;6007.549433792483;6101.389861013952;6139.079138129317;6140.565599444524;6173.96913015441;5883.794067207627;5886.735096920649;6051;6065.969670151621;6069.666168360783;6146.846328841725;6161.106639537242;6165.938340616626;6172.290186628506;6196;4786.928196077061;4815.518448155157;4827.541383568555;4833.685810422311;4908;4213.325867861189;4334.566543345641;4337.371081193272;4353.978230108829;4356.215881141425;5786.450287222707;5790.739416726257;5811.4479124483105;5817.272840894888;5849.88300233993;5155.536001759785;5627.043402621564;6149.754009839557;6165.136880836686;6169.167162433104;4965.056639238605;5506.64206826555;5777.826665200051;5848;5909.497692696083;5274.287971123926;5274.3670759509105;5294.364676238799;5306.071437498423;5362.329708786402;6121.483458747687;6179.134921111048;6245.437910587887;6246.361596369813;6313.08460273267;6130.111133885651;6149.72326245329;6160.938390616216;6161.353057928853;6164.352742961924;6277.435030847063;6286.8428289291305;6291.389073534615;6304.810855674337;6308.842278943063;5919.378465261258;6032.245969253843;6123.130109042811;6134.41182344721;6140.04415716754;6092.969535152296;6142.815715528542;6145.631262124287;6177.444030037139;6200.782972596118;5740.282464691913;6060.153817071129;6088.147659327609;6097.481714054177;6101.389861013863;5977.701114944322;6033.54748393881;6054.091886217103;6057.545684073801;6118.174046503665;5755.625884317506;5811.593188476766;5869.236999190078;5870.0607902735355;5890.911636325544;5890;6004.699765011819;6063.211782468427;6078.969605151946;6100.725467353891;5857.882842343214;5928.140419639214;5937.643741375531;5955.196048533393;5955.196048533393 10:32:09 INFO - PROCESS | 7599 | |1;ext.html;438.8990532177599;464.9790759415826;493.66184163847754;565.7652074389129;590.968759514647;36049.459258111114;36878.631213687855;36933;36977.260454790885;37028.25943481129;37590.43614345787;38157.61842381575;38208.61791382085;38307.80846095773;38308.425373619415;9278.072192780719;9498.620055197784;9516.904830951706;9544.61821527138;9558.091981261803;9310.534473276342;9486.33595648305;9572.664956726516;9586.185174260196;9594.712158635251;7919.960400197991;8577.185167409087;9534.04659534048;9611.038896110404;9613.711588652352;9571.425714457155;9585.616575336944;9594.328397012212;9602.855957160647;9623.133917947383;9424.151826335663;9565.473898935556;9576.61693532258;9580.329376943617;9588.520573971273;35720;35750.64249357499;35770.64229357725;35858;36231.27537449262;2504.93540245395;2720.91837244883;2914.985425072882;3418.29924865402;3477.8608855646;21406.52074329303;21509;25864.353391165183;26182.86908565445;27031;2696.6359541461848;2735.8905643774424;2745.23133522614;2856.5429531274895;2930.970690293091;371072;420116.9999999969;425561;427465;428152;37971.810140949674;58221;58533.41466585365;58627.41372586305;58794.11808822871;42834.143317134105;42881;43025.569744302156;43137.35293970593;43365.78317108457;15011.624709382135;15113.622159446102;15151.090934543963;15155.772663410058;15246.618834529225;9826.950865245772;12181.512739490321;12243.387830608433;12247.326397048248;12305.815412768816;13829.654258643614;13858.237796921065;14072;14101.78847317291;14202.076865003743;5705.400932902068;6365.809025729235;6391.296957334689;6456.483481321483;6516.478681705452;895;973.7468258252906;990.9009099090177;995.6216637677636;1079.8164312066967;28470.85764571164;28547.71452285492;28887.56668649972;28902.566461503095;28915.722421764913;925.9675911343071;1013.368476752428;1039.8440233964966;1083.1443159903745;1090.7382228265317;13767.808154148266;13861.376238069312;13925.721485570231;14239.359228834728;14381.64045898861;646899;651359;653825;659060;660879;54049.72975135099;54500.45499545033;54674.72662636741;54676.45323546793;54863;1404.3048690897867;1425.583635737415;1448.341004842794;1449.029150469167;1454.1711224601875;25932.22203333903;27082.45835083248;27431.588526171723;27525.44949101047;27715.44569108647;44850.551494485946;44894.3265851019;45339.86650333768;45374.865628359556;45478.545214547434;486977;488831;491564;492297;493488;30412.391752165277;31352.52971205388;31401.05796826099;31682.841585791924;31710.68289317077;40523.797381012904;41074.794626026676;41406;41902.37146442745;42122.36816447817;34868.65131348654;35041.824790875886;35455.11362215965;35474.290514190085;35665.930022099375;33123.66876331206;34793.826030869684;35145.297094058486;35512;36868;31480;34413.96758097261;34432.65567344295;36207.45688814722;36693.89918302455;29887.850560747058;30530.931417400283;30683;30695.846520768147;30799.538006929466;16996.915015424845;20041.29855455052;23028.194013209457;24202.878985605665;24208.031678732652 10:32:09 INFO - PROCESS | 7599 | |2;jquery.html;355.381635953441;356.59526437493435;361.0900530662729;365.3168574765188;368.6221622836594;15869;18657.62684746304;19374.418767436982;21296.4675883103;21745;18203.271869125252;19380.80619193811;19445.611087778238;19772.110255038522;19971.901545414996;5871.207387002764;6102.847428814271;6892.931070689279;7212.567245965232;7233.132024157108;6883.8967415488805;7016.087908571904;7111.679974401139;7785.338246249075;7844.215578442138;4597.540245975392;6401.711922963478;7513.2862378074;7745.264199901;7774.8445031099345;7237.638118094074;7444.925550744478;7478.2895624915545;7483.289087536676;7493.4005279577505;7425.628718564104;7455.66449509768;7462.776116716507;7480.9251907480775;7504.5872477013745;23320.88339558308;26704.8664756675;26946.78739456729;27483;27574.448511029666;2170.9240176593744;2278.646809744492;2603.0108558747556;2990.132861470171;3081.4145312390574;12942.547010854574;15458.308927915594;15607.297671604805;15644.296006679726;16225.188740562924;1903.790583035865;1943.689009758446;1955.2374573916184;1995.9900200498905;2087.561612061469;108891.91108088897;114225.42887285593;115989.42005290004;117034;118538;19257;19902.203911843364;19908.50228744293;19978.20087196496;20063.197472101245;13094.869051309555;13616.931915340558;13661.316934153252;28639.997600083898;28686.426271474455;8225.218604232588;8349.081601023883;8489.915100849035;8533.104024077382;8647.178518040777;8647;8695.434796738191;8748.8687669685;8754.21212090915;8782;4442.244818380883;4510.503844577094;4523.276275795923;4523.95476045242;4532.206863798888;1589.8711914540575;1680.915954202285;1945.319138301583;1947.8246957773868;1981.6135853508715;854.1287886355882;904.1455824246156;907.7775944893411;931.8648795924553;978.9412635241908;18456.907715461337;19460.4161875144;20564.588708226052;21302.57394852094;21753.67369489459;925.7037747920601;932.8367535681228;995.1342332170913;1011.1607365886297;1042.2698320787456;10391.896081039244;10635.04284614373;10702.892971070345;10703.411312377739;10777.137828973664;434213;494969;506424;510018;516433;109827;113465;115119;126718.7328126707;128116.43767124791;1020.2756043209256;1040.432964034603;1041.9739506512246;1044.0499145777305;1071.276888100529;17445.738313925554;18181.54546136357;18390.356337528123;19090.618187635893;19193.616127677647;37340.813295933345;38473.807630961666;49963.75018125032;51044.97910041704;51196.97606047933;58698.413015871;73085.26914730784;77332;82888.17111828804;83160.58419707863;7997.360211183208;8167.795805104683;8182.1817818217705;8319.750407487785;8339.666413343399;10812.80395439685;12707.80938285945;12896.871031289567;13622;13746.518871839438;10629.627963021258;11134.4968429261;11969.461374238006;11969.700757481132;11973.10201734856;11404.48679809394;11624.535018599161;11736.295822250693;11789.705257368634;11817.82273265919;10032.347897386646;10411.583536658449;11652.126090543074;12077.698057548632;12147.696307592027;6027.78902738402;6569.948808190667;6723;8273.586320684062;8380.16198380157;8710.520921349387;9800.901990980285;10617.522211500656;11962.700932476757;12089.395530223277 10:32:09 INFO - PROCESS | 7599 | |3;mootools.html;1423.8077859488967;1552.4333618229346;1758.6131051168738;1901.420066879602;1903.1530968718926;7043.823904402379;8284.834303313937;8497.532635705034;8613.83713198718;8808.867866981993;7196.640167991605;8493.702720404786;8625.309975201984;8639.352048596365;8641.049484556694;2425.757424257578;2442.1696623148127;2453.2885463215734;2473.9628905566433;2481.7766401023905;2402.2072716003763;2469.7653722896384;2473.6042233242683;2475.814313926454;2477.690288713911;2151.440625437382;2395.772401621843;2428.574999375111;2449.6937882764655;2458.0045081741923;1912.722655214993;2384.070212617081;2431.1369463840347;2439.9634005489934;2447.49826285611;2405.579023670851;2411.4212588978517;2415.7946574541184;2419.11702228687;2430.793382562484;8747.781305467413;8761.7809554761;8770.473771573726;8797;8910.55447227636;4512.503624601291;5290.677330667333;5293.894122117575;5429;5484.341878974548;3567.5362202913716;3596.6942809861193;3677.7057835373107;3703.7962912039825;3726.329260733067;1037.704254287532;1046.4558429616634;1076.94615269237;1079.1259080145107;1080.870490337599;10482.37105773656;11420.828687569694;11583.536658533649;11674.949254567046;11708.824367634492;4783.832565860178;4841.273808928619;4860.416749989953;4880;4906.852794416173;9934.552945117486;9991.350562213433;9998.650047248311;10024.448655324028;10044.246681498917;4883.974365383238;5388.515033646991;5419.430959749248;5475.4524547544925;5514.172874068841;4890.510948905081;4945.505449455098;4952.579030782352;4992.650514463952;4998.475160108136;3889.183271512957;3913.5695073541888;3928.2143571285856;3979.6816254700134;3979.9602003980167;1202.4168278384977;1278.3799857069314;1298.7727147749106;1303.2962200411862;1315.9210447373189;1104.9668509944715;1110.611286049876;1138.5844166879194;1244.3591550351575;1356.6404902700792;7891.289783919475;7970.2826745593175;7988.520688758693;8080.111187769341;8342;1183.875693052217;1188.1920294199854;1216.6714986953473;1227.9623717958311;1251.9186252893533;6167.907481387782;6216.912040392913;6272.780452684134;6296.811095667137;6306.211723534559;10388.532516036796;10693.198010149114;10737.731556710989;10835.783284334428;10885.020348168702;9885.406875587487;10189;10565.260431769702;10592;10608.522616482276;7967.760967170994;8060.31487323584;8106.189381061847;8131.9186808132345;8176.3458923286;7756.418268629763;7834.020747406575;7864.252895974873;7918;7939.920600793918;9067.229285510806;9193.908060919306;9325.626974921199;9331.53342332867;9361.017093205115;9263.490508022123;9487.762805929908;9712.223022158068;9760.072793084646;9874.85187722199;7393.223711510214;7421;7524.887126693214;7529.209433009674;7540.698372065056;8140.552269625227;8144.75565733029;8146.307563857138;8177.6320065596;8202.753917382488;6769.458443324424;7206.927930720835;7337.633118344168;7472.738454154079;7545.962270188614;7084.043654106836;7111.751088711871;7144.535605185646;7196.316349946746;7229.819254518679;7218.530795498275;7476.25237476248;7501.474896757175;7503.09962804467;7560.4329675273475;6788.93211067883;6856.897146542906;6861.828454288483;6902.516823822284;6952.5133240674695;5872.383399742966;6919.100516932766;6945.097137372311;6967.442604591519;7024.683889224895 10:32:09 INFO - PROCESS | 7599 | |4;prototype.html;317.22280412988175;322.79341221618154;325.76870422000377;328.1730040298448;331.3009549849818;5324.334458192726;6528.34716528347;6641.900371494431;6651.068850360947;6678.065070890073;6626.370494802998;6659.90010149847;6660.500462465322;6682.966585167067;6688.83277918051;4377.649788016951;4649.349091127245;4946.505349465043;4972.2044472884345;5005.5995520358465;5018.071656743514;5019.3725784276785;5023.120953833083;5030.647854650176;5063.46833582474;4967.081089998362;4974.776135073912;4977.50224977503;4991.32617096691;4994.250862370655;4716.245400735866;4906.362172917534;4961.776720047588;4972.353594032788;4978.626603004771;4224.859287992225;4236.766977816219;4249.065205654751;4255.276602977501;4263.360495925605;6351.142595749561;6370.458511026568;6375.904361434582;6380.808575742735;6380.968095159495;4719.787609557578;5731.484166425;5867.647941123546;5868.794592189295;5879.265091863517;7119;7146.892796608055;7148.213696493382;7155.356017958408;7189.17324507683;4763.69036012658;4766.213574760161;4770.522947705236;4773.570378665937;4780.043991201774;7517.17311095779;7535.208803075708;7627.6567554459625;7630.351420129296;7644.312011918954;4011.538673052578;4102.2410853992105;4629.282461218517;4734.313524538922;4826.348442960156;4899.2896030075435;4908.288298196741;4915.926261106087;4930.506949305112;4945.554900059012;5773.422657734193;5781.508571771363;5799.159121927297;5804.1293805929445;5807.5644326675665;5684.261046063985;5710.229119068956;5771.913421298684;7125.53684010548;7126.465515086389;1703.2590822992038;1723.3709695960883;1727.9827201727821;1737.6611560745787;1737.7045902196405;1088.77135801481;1125.1842414249604;1127.1827924754487;1134.6539305511733;1149.6091328948198;6802.115724955823;6841;6843.076184715;6894.103766510321;6898.241193468714;7513.098428188652;7520;7538.246175382418;7540.095188577406;7554.924450755422;6808.536164724608;6819.829504262334;6819.931800682029;6856.211535673461;6860.862782744417;3708.980030491636;3897.922041559153;3970.6426421621613;4006.399040144002;4015.678745700395;6809.706155830377;7727.150013498511;7805.37556995439;8058.597070146469;8060.879086813702;5928.3775203603;7242.49302548827;7374.746293130073;7886.960565197252;7902.3678105751405;8019.599020048974;8023.077346105156;8024.759257222293;8045.034595848536;8060.758177254692;7313.926860731324;7611.2769286917655;7640.579768112807;7653.502522336031;7656.846863062819;7416.814579635552;7462.029936108272;7471.813204669927;7478.6260686966525;7490;6519.869602608016;6935.445164386736;8027.4380793346245;8034.437589368688;8053.919460805317;3627.5646922369483;4424.446944131983;4894.804207831647;4919.901601968012;4921.384826896638;7295.966182130043;7532.661030253761;7563.697452101855;7587.468877178544;7599.392048636207;5890.263717035371;7272.200057993722;7304.306090921354;7309.195988441374;7320.377767889789;7293.161286451914;7309.707611695472;7326.9267307326245;7336.96331518339;7364;5778.306603207642;7143.749968751069;7148.463865210234;7150;7169.426445884213;7013;7265.273472652692;7274.8908766369605;7281.344678978918;7320.450966177665;7146.821329466805;7180.60506672138;7191.820204494929;7197.1363436387965;7215.639218039182 10:32:09 INFO - PROCESS | 7599 | |5;yui.html;651.1730102769482;655.9897757453521;691.3535843985874;695.2630211975306;723.3309189000173;14757.335919883604;15114.168720720356;15131.31909064092;16885.98684078953;17150.399736009243;14766.557003289892;15837.60405989851;15889.841101588981;15947.282372293246;15974;698.4482259015372;749.1946157880274;838.8364268967523;856.6830272799073;884.3146561414923;862.1507814802414;865.68835219321;868.1405408645427;869.6825658634616;871.6382701179003;906.5512571277227;915.1534830281996;922.2391526990226;922.5202894494859;923.0953665407905;890.6259371064168;900.8334207201657;903.4804987132393;913.0230653201045;914.1087439746261;670.1924181361447;678.725116327888;679.6771533521538;680.3740558686021;681.0805412692874;15057.698846023019;15133.54599362021;15184.240787960558;15289.082655040622;15293.388264469408;12557.372131393486;12577.496900123984;12662.55681051168;12878.71212878714;12974.935125324313;8183.304419124322;8661.610227539775;9960.750981225456;10040.598376064949;10181.898181018169;3490.2670439207795;3533.0990597397754;3540.0972751948348;3544.3974524330924;3622.456631505269;85846;85894.14105858987;86086;86430;86680;9174.495402752778;9277.953610231905;9305.860412093823;9315;9570.856437153448;16672;20264;20461.18155273802;20518.692219616718;20544.972751362373;7038.92961070393;7287.599182044933;7330.523515971445;7389.113306403266;7568.205338439495;4099.61053699898;4149.605787450248;4150.398192262105;4154.5222299435345;4156.334986402161;3459.636738142459;3479.7564170508326;3493.63316851732;3503.649635036527;3503.8773642922374;615.237105988571;629.3266205160435;629.8456878064903;630.5995692735146;639.5810743962712;524.9448807875194;589.4959809363019;590.4774274766862;591.4913174669781;617.4566381584177;8256.669733210605;8559.272461840688;8619.61211745473;8634.309255259564;8712.21590056898;509.3632958801498;541.6614615865084;593.6104841355906;604.3956043956044;615.5444970721724;3461.913452163716;3705.925881482355;3974.364101743707;4073.920411091063;4330.242207613655;84584.57707711423;84914.15085849063;85647.57176214203;87141;87220.25559488774;64811.703765924416;66363.66818165878;67208.6639566799;71580;75369.62315188498;63130.684346577975;63971;64537.35462645407;65372.097092718235;66468.33531664718;6609.570377925419;7418.016888968357;8439.409241353047;8664.133586641285;8690.522021288889;45314.86712832074;47964.76017620029;47968.321108761025;48106.51893481021;48296.517034830606;60678.39321606904;61269;62002;62330;64472.677636611515;10130.89869101329;10389.272750907667;10669.57321707123;10697.946510267398;11158.832617510907;11724.413779311171;11776.352300623204;12153.817692734792;12172.14794964344;12430.378481076092;10436.791264174826;10987.230893837355;11019.614313498989;11238.494267757807;11245.887541124484;10052.64815731446;10976.560937562408;11252;11826;12124.75750485003;9370.625174993196;11049.28179668319;11097.833532497181;11525.769484610428;11731.061515078944;8620.439671421338;9552.761180970532;9678.225741940769;9731.708048758548;9782.217422606032;9183.586738596645;9749.707508774749;9824.4105353679;9844.852327214954;9889.50552472388 10:32:09 INFO - PROCESS | 7599 | __end_tp_report 10:32:09 INFO - PROCESS | 7599 | __start_cc_report 10:32:09 INFO - PROCESS | 7599 | _x_x_mozilla_cycle_collect,348 10:32:09 INFO - PROCESS | 7599 | __end_cc_report 10:32:09 INFO - PROCESS | 7599 | __startTimestamp1456252329077__endTimestamp 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | ------- Summary: start ------- 10:32:09 INFO - PROCESS | 7599 | Number of tests: 6 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | [#0] dojo.html Cycles:165 Average:5634.03 Median:5870.06 stddev:662.79 (11.3%) stddev-sans-first:628.91 10:32:09 INFO - PROCESS | 7599 | Values: 2890.8 2917.5 3023.8 3438.9 3531.9 5439.2 5550.3 5556.6 5563.8 5582.5 4545.5 5467.7 5611.5 5613.4 5782.2 5070.7 5125.2 5128.1 5176.4 5187.6 5156.8 5171.6 5205.6 5221.4 5250.1 5019.3 5064.4 5125.5 5165.8 5204.2 5093.8 5146.5 5149.6 5179.3 5187.9 5014.5 5051.2 5123.8 5134.7 5147.9 5378.3 5495.9 5506.1 5509.6 5525.1 6145.8 6152.5 6154.4 6190.2 6205.0 6054.3 6138.1 6168.8 6178.0 6204.4 5627.1 5654.8 5666.1 5688.3 5691.9 4863.2 6097.6 6172.6 6174.7 6184.9 5957.5 5994.9 5996.0 6017.0 6086.2 6007.5 6101.4 6139.1 6140.6 6174.0 5883.8 5886.7 6051.0 6066.0 6069.7 6146.8 6161.1 6165.9 6172.3 6196.0 4786.9 4815.5 4827.5 4833.7 4908.0 4213.3 4334.6 4337.4 4354.0 4356.2 5786.5 5790.7 5811.4 5817.3 5849.9 5155.5 5627.0 6149.8 6165.1 6169.2 4965.1 5506.6 5777.8 5848.0 5909.5 5274.3 5274.4 5294.4 5306.1 5362.3 6121.5 6179.1 6245.4 6246.4 6313.1 6130.1 6149.7 6160.9 6161.4 6164.4 6277.4 6286.8 6291.4 6304.8 6308.8 5919.4 6032.2 6123.1 6134.4 6140.0 6093.0 6142.8 6145.6 6177.4 6200.8 5740.3 6060.2 6088.1 6097.5 6101.4 5977.7 6033.5 6054.1 6057.5 6118.2 5755.6 5811.6 5869.2 5870.1 5890.9 5890.0 6004.7 6063.2 6079.0 6100.7 5857.9 5928.1 5937.6 5955.2 5955.2 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | [#1] ext.html Cycles:180 Average:63775.31 Median:36905.82 stddev:141821.25 (384.3%) stddev-sans-first:142139.37 10:32:09 INFO - PROCESS | 7599 | Values: 438.9 465.0 493.7 565.8 591.0 36049.5 36878.6 36933.0 36977.3 37028.3 37590.4 38157.6 38208.6 38307.8 38308.4 9278.1 9498.6 9516.9 9544.6 9558.1 9310.5 9486.3 9572.7 9586.2 9594.7 7920.0 8577.2 9534.0 9611.0 9613.7 9571.4 9585.6 9594.3 9602.9 9623.1 9424.2 9565.5 9576.6 9580.3 9588.5 35720.0 35750.6 35770.6 35858.0 36231.3 2504.9 2720.9 2915.0 3418.3 3477.9 21406.5 21509.0 25864.4 26182.9 27031.0 2696.6 2735.9 2745.2 2856.5 2931.0 371072.0 420117.0 425561.0 427465.0 428152.0 37971.8 58221.0 58533.4 58627.4 58794.1 42834.1 42881.0 43025.6 43137.4 43365.8 15011.6 15113.6 15151.1 15155.8 15246.6 9827.0 12181.5 12243.4 12247.3 12305.8 13829.7 13858.2 14072.0 14101.8 14202.1 5705.4 6365.8 6391.3 6456.5 6516.5 895.0 973.7 990.9 995.6 1079.8 28470.9 28547.7 28887.6 28902.6 28915.7 926.0 1013.4 1039.8 1083.1 1090.7 13767.8 13861.4 13925.7 14239.4 14381.6 646899.0 651359.0 653825.0 659060.0 660879.0 54049.7 54500.5 54674.7 54676.5 54863.0 1404.3 1425.6 1448.3 1449.0 1454.2 25932.2 27082.5 27431.6 27525.4 27715.4 44850.6 44894.3 45339.9 45374.9 45478.5 486977.0 488831.0 491564.0 492297.0 493488.0 30412.4 31352.5 31401.1 31682.8 31710.7 40523.8 41074.8 41406.0 41902.4 42122.4 34868.7 35041.8 35455.1 35474.3 35665.9 33123.7 34793.8 35145.3 35512.0 36868.0 31480.0 34414.0 34432.7 36207.5 36693.9 29887.9 30530.9 30683.0 30695.8 30799.5 16996.9 20041.3 23028.2 24202.9 24208.0 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | [#2] jquery.html Cycles:180 Average:32113.84 Median:12961.95 stddev:82902.13 (639.6%) stddev-sans-first:83100.40 10:32:09 INFO - PROCESS | 7599 | Values: 355.4 356.6 361.1 365.3 368.6 15869.0 18657.6 19374.4 21296.5 21745.0 18203.3 19380.8 19445.6 19772.1 19971.9 5871.2 6102.8 6892.9 7212.6 7233.1 6883.9 7016.1 7111.7 7785.3 7844.2 4597.5 6401.7 7513.3 7745.3 7774.8 7237.6 7444.9 7478.3 7483.3 7493.4 7425.6 7455.7 7462.8 7480.9 7504.6 23320.9 26704.9 26946.8 27483.0 27574.4 2170.9 2278.6 2603.0 2990.1 3081.4 12942.5 15458.3 15607.3 15644.3 16225.2 1903.8 1943.7 1955.2 1996.0 2087.6 108891.9 114225.4 115989.4 117034.0 118538.0 19257.0 19902.2 19908.5 19978.2 20063.2 13094.9 13616.9 13661.3 28640.0 28686.4 8225.2 8349.1 8489.9 8533.1 8647.2 8647.0 8695.4 8748.9 8754.2 8782.0 4442.2 4510.5 4523.3 4524.0 4532.2 1589.9 1680.9 1945.3 1947.8 1981.6 854.1 904.1 907.8 931.9 978.9 18456.9 19460.4 20564.6 21302.6 21753.7 925.7 932.8 995.1 1011.2 1042.3 10391.9 10635.0 10702.9 10703.4 10777.1 434213.0 494969.0 506424.0 510018.0 516433.0 109827.0 113465.0 115119.0 126718.7 128116.4 1020.3 1040.4 1042.0 1044.0 1071.3 17445.7 18181.5 18390.4 19090.6 19193.6 37340.8 38473.8 49963.8 51045.0 51197.0 58698.4 73085.3 77332.0 82888.2 83160.6 7997.4 8167.8 8182.2 8319.8 8339.7 10812.8 12707.8 12896.9 13622.0 13746.5 10629.6 11134.5 11969.5 11969.7 11973.1 11404.5 11624.5 11736.3 11789.7 11817.8 10032.3 10411.6 11652.1 12077.7 12147.7 6027.8 6569.9 6723.0 8273.6 8380.2 8710.5 9800.9 10617.5 11962.7 12089.4 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | [#3] mootools.html Cycles:180 Average:5958.67 Median:5403.97 stddev:3099.85 (57.4%) stddev-sans-first:3089.80 10:32:09 INFO - PROCESS | 7599 | Values: 1423.8 1552.4 1758.6 1901.4 1903.2 7043.8 8284.8 8497.5 8613.8 8808.9 7196.6 8493.7 8625.3 8639.4 8641.0 2425.8 2442.2 2453.3 2474.0 2481.8 2402.2 2469.8 2473.6 2475.8 2477.7 2151.4 2395.8 2428.6 2449.7 2458.0 1912.7 2384.1 2431.1 2440.0 2447.5 2405.6 2411.4 2415.8 2419.1 2430.8 8747.8 8761.8 8770.5 8797.0 8910.6 4512.5 5290.7 5293.9 5429.0 5484.3 3567.5 3596.7 3677.7 3703.8 3726.3 1037.7 1046.5 1076.9 1079.1 1080.9 10482.4 11420.8 11583.5 11674.9 11708.8 4783.8 4841.3 4860.4 4880.0 4906.9 9934.6 9991.4 9998.7 10024.4 10044.2 4884.0 5388.5 5419.4 5475.5 5514.2 4890.5 4945.5 4952.6 4992.7 4998.5 3889.2 3913.6 3928.2 3979.7 3980.0 1202.4 1278.4 1298.8 1303.3 1315.9 1105.0 1110.6 1138.6 1244.4 1356.6 7891.3 7970.3 7988.5 8080.1 8342.0 1183.9 1188.2 1216.7 1228.0 1251.9 6167.9 6216.9 6272.8 6296.8 6306.2 10388.5 10693.2 10737.7 10835.8 10885.0 9885.4 10189.0 10565.3 10592.0 10608.5 7967.8 8060.3 8106.2 8131.9 8176.3 7756.4 7834.0 7864.3 7918.0 7939.9 9067.2 9193.9 9325.6 9331.5 9361.0 9263.5 9487.8 9712.2 9760.1 9874.9 7393.2 7421.0 7524.9 7529.2 7540.7 8140.6 8144.8 8146.3 8177.6 8202.8 6769.5 7206.9 7337.6 7472.7 7546.0 7084.0 7111.8 7144.5 7196.3 7229.8 7218.5 7476.3 7501.5 7503.1 7560.4 6788.9 6856.9 6861.8 6902.5 6952.5 5872.4 6919.1 6945.1 6967.4 7024.7 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | [#4] prototype.html Cycles:180 Average:5875.54 Median:6646.48 stddev:1898.33 (28.6%) stddev-sans-first:1857.25 10:32:09 INFO - PROCESS | 7599 | Values: 317.2 322.8 325.8 328.2 331.3 5324.3 6528.3 6641.9 6651.1 6678.1 6626.4 6659.9 6660.5 6683.0 6688.8 4377.6 4649.3 4946.5 4972.2 5005.6 5018.1 5019.4 5023.1 5030.6 5063.5 4967.1 4974.8 4977.5 4991.3 4994.3 4716.2 4906.4 4961.8 4972.4 4978.6 4224.9 4236.8 4249.1 4255.3 4263.4 6351.1 6370.5 6375.9 6380.8 6381.0 4719.8 5731.5 5867.6 5868.8 5879.3 7119.0 7146.9 7148.2 7155.4 7189.2 4763.7 4766.2 4770.5 4773.6 4780.0 7517.2 7535.2 7627.7 7630.4 7644.3 4011.5 4102.2 4629.3 4734.3 4826.3 4899.3 4908.3 4915.9 4930.5 4945.6 5773.4 5781.5 5799.2 5804.1 5807.6 5684.3 5710.2 5771.9 7125.5 7126.5 1703.3 1723.4 1728.0 1737.7 1737.7 1088.8 1125.2 1127.2 1134.7 1149.6 6802.1 6841.0 6843.1 6894.1 6898.2 7513.1 7520.0 7538.2 7540.1 7554.9 6808.5 6819.8 6819.9 6856.2 6860.9 3709.0 3897.9 3970.6 4006.4 4015.7 6809.7 7727.2 7805.4 8058.6 8060.9 5928.4 7242.5 7374.7 7887.0 7902.4 8019.6 8023.1 8024.8 8045.0 8060.8 7313.9 7611.3 7640.6 7653.5 7656.8 7416.8 7462.0 7471.8 7478.6 7490.0 6519.9 6935.4 8027.4 8034.4 8053.9 3627.6 4424.4 4894.8 4919.9 4921.4 7296.0 7532.7 7563.7 7587.5 7599.4 5890.3 7272.2 7304.3 7309.2 7320.4 7293.2 7309.7 7326.9 7337.0 7364.0 5778.3 7143.7 7148.5 7150.0 7169.4 7013.0 7265.3 7274.9 7281.3 7320.5 7146.8 7180.6 7191.8 7197.1 7215.6 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - PROCESS | 7599 | [#5] yui.html Cycles:180 Average:17610.03 Median:31479.66 stddev:24369.92 (77.4%) stddev-sans-first:24405.02 10:32:09 INFO - PROCESS | 7599 | Values: 651.2 656.0 691.4 695.3 723.3 14757.3 15114.2 15131.3 16886.0 17150.4 14766.6 15837.6 15889.8 15947.3 15974.0 698.4 749.2 838.8 856.7 884.3 862.2 865.7 868.1 869.7 871.6 906.6 915.2 922.2 922.5 923.1 890.6 900.8 903.5 913.0 914.1 670.2 678.7 679.7 680.4 681.1 15057.7 15133.5 15184.2 15289.1 15293.4 12557.4 12577.5 12662.6 12878.7 12974.9 8183.3 8661.6 9960.8 10040.6 10181.9 3490.3 3533.1 3540.1 3544.4 3622.5 85846.0 85894.1 86086.0 86430.0 86680.0 9174.5 9278.0 9305.9 9315.0 9570.9 16672.0 20264.0 20461.2 20518.7 20545.0 7038.9 7287.6 7330.5 7389.1 7568.2 4099.6 4149.6 4150.4 4154.5 4156.3 3459.6 3479.8 3493.6 3503.6 3503.9 615.2 629.3 629.8 630.6 639.6 524.9 589.5 590.5 591.5 617.5 8256.7 8559.3 8619.6 8634.3 8712.2 509.4 541.7 593.6 604.4 615.5 3461.9 3705.9 3974.4 4073.9 4330.2 84584.6 84914.2 85647.6 87141.0 87220.3 64811.7 66363.7 67208.7 71580.0 75369.6 63130.7 63971.0 64537.4 65372.1 66468.3 6609.6 7418.0 8439.4 8664.1 8690.5 45314.9 47964.8 47968.3 48106.5 48296.5 60678.4 61269.0 62002.0 62330.0 64472.7 10130.9 10389.3 10669.6 10697.9 11158.8 11724.4 11776.4 12153.8 12172.1 12430.4 10436.8 10987.2 11019.6 11238.5 11245.9 10052.6 10976.6 11252.0 11826.0 12124.8 9370.6 11049.3 11097.8 11525.8 11731.1 8620.4 9552.8 9678.2 9731.7 9782.2 9183.6 9749.7 9824.4 9844.9 9889.5 10:32:09 INFO - PROCESS | 7599 | -------- Summary: end -------- 10:32:09 INFO - PROCESS | 7599 | 10:32:09 INFO - TEST-INFO | 7599: exit 0 10:32:09 INFO - TEST-OK | dromaeo_css | took 1110139ms 10:32:09 INFO - TEST-START | kraken 10:32:09 INFO - operating with platform_type : mac_ 10:32:09 INFO - Initialising browser for kraken test... 10:32:09 INFO - TEST-INFO | started process 7604 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmprd7vo3/profile http://localhost:52013/getInfo.html) 10:32:12 INFO - PROCESS | 7604 | __metrics Screen width/height:1600/1200 10:32:12 INFO - PROCESS | 7604 | colorDepth:24 10:32:12 INFO - PROCESS | 7604 | Browser inner width/height: 1024/689 10:32:12 INFO - PROCESS | 7604 | __metrics 10:32:12 ERROR - PROCESS | 7604 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:32:13 INFO - TEST-INFO | 7604: exit 0 10:32:13 INFO - Browser initialized. 10:32:13 INFO - Running cycle 1/1 for kraken test... 10:32:13 INFO - TEST-INFO | started process 7607 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmprd7vo3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:25 INFO - PROCESS | 7607 | RSS: Main: 256020480 10:32:25 INFO - PROCESS | 7607 | 10:32:27 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52013/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:28 INFO - PROCESS | 7607 | RSS: Main: 269033472 10:32:28 INFO - PROCESS | 7607 | 10:32:31 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52013/tests/kraken/driver.html?testName=audio-dft) 10:32:31 INFO - PROCESS | 7607 | RSS: Main: 278917120 10:32:31 INFO - PROCESS | 7607 | 10:32:34 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52013/tests/kraken/driver.html?testName=audio-fft) 10:32:35 INFO - PROCESS | 7607 | RSS: Main: 281505792 10:32:35 INFO - PROCESS | 7607 | 10:32:37 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52013/tests/kraken/driver.html?testName=audio-oscillator) 10:32:37 INFO - PROCESS | 7607 | RSS: Main: 283455488 10:32:37 INFO - PROCESS | 7607 | 10:32:40 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:40 INFO - PROCESS | 7607 | RSS: Main: 283467776 10:32:40 INFO - PROCESS | 7607 | 10:32:43 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52013/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:44 INFO - PROCESS | 7607 | RSS: Main: 283590656 10:32:44 INFO - PROCESS | 7607 | 10:32:47 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52013/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:47 INFO - PROCESS | 7607 | RSS: Main: 283213824 10:32:47 INFO - PROCESS | 7607 | 10:32:50 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52013/tests/kraken/driver.html?testName=json-parse-financial) 10:32:51 INFO - PROCESS | 7607 | RSS: Main: 283824128 10:32:51 INFO - PROCESS | 7607 | 10:32:52 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:53 INFO - PROCESS | 7607 | RSS: Main: 283328512 10:32:53 INFO - PROCESS | 7607 | 10:32:55 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:56 INFO - PROCESS | 7607 | RSS: Main: 284401664 10:32:56 INFO - PROCESS | 7607 | 10:32:58 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:59 INFO - PROCESS | 7607 | RSS: Main: 284618752 10:32:59 INFO - PROCESS | 7607 | 10:33:01 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:02 INFO - PROCESS | 7607 | RSS: Main: 283865088 10:33:02 INFO - PROCESS | 7607 | 10:33:04 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:05 INFO - PROCESS | 7607 | RSS: Main: 284762112 10:33:05 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | Cycle 1(1): loaded http://localhost:52013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52013/tests/kraken/driver.html?testName=ai-astar) 10:33:07 INFO - PROCESS | 7607 | RSS: Main: 285433856 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | __start_tp_report 10:33:07 INFO - PROCESS | 7607 | _x_x_mozilla_page_load 10:33:07 INFO - PROCESS | 7607 | _x_x_mozilla_page_load_details 10:33:07 INFO - PROCESS | 7607 | |i|pagename|runs| 10:33:07 INFO - PROCESS | 7607 | |0;ai-astar;113;109;115;113;114;127;91;168;103;156 10:33:07 INFO - PROCESS | 7607 | |1;audio-beat-detection;160;124;152;180;125;142;139;122;159;122 10:33:07 INFO - PROCESS | 7607 | |2;audio-dft;194;200;202;200;202;217;217;224;203;201 10:33:07 INFO - PROCESS | 7607 | |3;audio-fft;61;76;61;74;105;57;57;59;59;113 10:33:07 INFO - PROCESS | 7607 | |4;audio-oscillator;82;91;118;78;79;82;117;81;83;117 10:33:07 INFO - PROCESS | 7607 | |5;imaging-gaussian-blur;117;92;85;113;86;112;111;83;133;142 10:33:07 INFO - PROCESS | 7607 | |6;imaging-darkroom;127;99;143;153;96;94;131;150;97;94 10:33:07 INFO - PROCESS | 7607 | |7;imaging-desaturate;91;96;144;145;131;90;95;92;92;93 10:33:07 INFO - PROCESS | 7607 | |8;json-parse-financial;58;56;57;55;58;56;56;65;57;57 10:33:07 INFO - PROCESS | 7607 | |9;json-stringify-tinderbox;65;65;74;69;87;65;79;100;104;100 10:33:07 INFO - PROCESS | 7607 | |10;stanford-crypto-aes;88;91;102;108;116;75;102;115;113;113 10:33:07 INFO - PROCESS | 7607 | |11;stanford-crypto-ccm;137;139;130;122;126;131;128;137;125;155 10:33:07 INFO - PROCESS | 7607 | |12;stanford-crypto-pbkdf2;157;193;146;150;150;139;155;167;153;136 10:33:07 INFO - PROCESS | 7607 | |13;stanford-crypto-sha256-iterative;69;72;96;94;100;93;70;70;68;72 10:33:07 INFO - PROCESS | 7607 | __end_tp_report 10:33:07 INFO - PROCESS | 7607 | __start_cc_report 10:33:07 INFO - PROCESS | 7607 | _x_x_mozilla_cycle_collect,881 10:33:07 INFO - PROCESS | 7607 | __end_cc_report 10:33:07 INFO - PROCESS | 7607 | __startTimestamp1456252387653__endTimestamp 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | ------- Summary: start ------- 10:33:07 INFO - PROCESS | 7607 | Number of tests: 14 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#0] ai-astar Cycles:10 Average:120.90 Median:121.00 stddev:23.69 (19.6%) stddev-sans-first:24.95 10:33:07 INFO - PROCESS | 7607 | Values: 113.0 109.0 115.0 113.0 114.0 127.0 91.0 168.0 103.0 156.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.00 stddev:19.93 (13.6%) stddev-sans-first:20.11 10:33:07 INFO - PROCESS | 7607 | Values: 160.0 124.0 152.0 180.0 125.0 142.0 139.0 122.0 159.0 122.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#2] audio-dft Cycles:10 Average:206.00 Median:202.50 stddev:9.71 (4.8%) stddev-sans-first:9.27 10:33:07 INFO - PROCESS | 7607 | Values: 194.0 200.0 202.0 200.0 202.0 217.0 217.0 224.0 203.0 201.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#3] audio-fft Cycles:10 Average:72.20 Median:60.00 stddev:20.60 (34.3%) stddev-sans-first:21.45 10:33:07 INFO - PROCESS | 7607 | Values: 61.0 76.0 61.0 74.0 105.0 57.0 57.0 59.0 59.0 113.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:81.50 stddev:17.28 (21.2%) stddev-sans-first:17.88 10:33:07 INFO - PROCESS | 7607 | Values: 82.0 91.0 118.0 78.0 79.0 82.0 117.0 81.0 83.0 117.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#5] imaging-gaussian-blur Cycles:10 Average:107.40 Median:112.50 stddev:20.55 (18.3%) stddev-sans-first:21.51 10:33:07 INFO - PROCESS | 7607 | Values: 117.0 92.0 85.0 113.0 86.0 112.0 111.0 83.0 133.0 142.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#6] imaging-darkroom Cycles:10 Average:118.40 Median:94.00 stddev:24.86 (26.4%) stddev-sans-first:26.17 10:33:07 INFO - PROCESS | 7607 | Values: 127.0 99.0 143.0 153.0 96.0 94.0 131.0 150.0 97.0 94.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#7] imaging-desaturate Cycles:10 Average:106.90 Median:92.00 stddev:23.20 (25.2%) stddev-sans-first:23.89 10:33:07 INFO - PROCESS | 7607 | Values: 91.0 96.0 144.0 145.0 131.0 90.0 95.0 92.0 92.0 93.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.80 (4.9%) stddev-sans-first:2.96 10:33:07 INFO - PROCESS | 7607 | Values: 58.0 56.0 57.0 55.0 58.0 56.0 56.0 65.0 57.0 57.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#9] json-stringify-tinderbox Cycles:10 Average:80.80 Median:67.00 stddev:15.82 (23.6%) stddev-sans-first:15.71 10:33:07 INFO - PROCESS | 7607 | Values: 65.0 65.0 74.0 69.0 87.0 65.0 79.0 100.0 104.0 100.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#10] stanford-crypto-aes Cycles:10 Average:102.30 Median:115.50 stddev:13.70 (11.9%) stddev-sans-first:13.51 10:33:07 INFO - PROCESS | 7607 | Values: 88.0 91.0 102.0 108.0 116.0 75.0 102.0 115.0 113.0 113.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:134.00 stddev:9.57 (7.1%) stddev-sans-first:10.04 10:33:07 INFO - PROCESS | 7607 | Values: 137.0 139.0 130.0 122.0 126.0 131.0 128.0 137.0 125.0 155.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:154.00 stddev:16.13 (10.5%) stddev-sans-first:17.09 10:33:07 INFO - PROCESS | 7607 | Values: 157.0 193.0 146.0 150.0 150.0 139.0 155.0 167.0 153.0 136.0 10:33:07 INFO - PROCESS | 7607 | 10:33:07 INFO - PROCESS | 7607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:72.00 stddev:13.38 (18.6%) stddev-sans-first:13.55 10:33:07 INFO - PROCESS | 7607 | Values: 69.0 72.0 96.0 94.0 100.0 93.0 70.0 70.0 68.0 72.0 10:33:07 INFO - PROCESS | 7607 | -------- Summary: end -------- 10:33:07 INFO - PROCESS | 7607 | 10:33:08 INFO - TEST-INFO | 7607: exit 0 10:33:08 INFO - TEST-OK | kraken | took 58979ms 10:33:08 INFO - SUITE-END | took 1169s 10:33:08 INFO - Completed test suite (00:19:29) 10:33:08 INFO - Working with test: dromaeo_css 10:33:08 INFO - Generating results file: dromaeo_css 10:33:08 INFO - Working with test: kraken 10:33:08 INFO - Generating results file: kraken 10:33:08 INFO - javascript benchmark 10:33:08 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:33:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 10:33:08 INFO - process_Request line: dromaeo_css 7502.24 graph.html#tests=[[72,64,61]] 10:33:08 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:33:08 INFO - process_Request line: kraken 1575.70 graph.html#tests=[[232,64,61]] 10:33:08 INFO - RETURN: dromaeo_css: 7502.24 10:33:08 INFO - RETURN: kraken: 1575.70 10:33:08 INFO - javascript benchmark 10:33:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2890.8120972136808, 2917.4894393481122, 3023.758099352052, 3438.9484157737625, 3531.929361412771, 5439.238506609073, 5550.333959924815, 5556.638818476797, 5563.833085007446, 5582.5254853337465, 4545.4545454545505, 5467.6719396836215, 5611.494965453108, 5613.4386561343845, 5782.190493330937, 5070.67040642358, 5125.231215317714, 5128.05131050755, 5176.404713457963, 5187.584993200554, 5156.793728250866, 5171.5862730981435, 5205.557527610158, 5221.399539053001, 5250.133727934886, 5019.322391477141, 5064.366954130734, 5125.513076257749, 5165.845024649267, 5204.193350030751, 5093.79624815007, 5146.511081447256, 5149.639525233235, 5179.326687530634, 5187.948120518822, 5014.548690617826, 5051.191809310492, 5123.820666276662, 5134.743262836881, 5147.922781158286, 5378.327709036371, 5495.917561236584, 5506.146547285177, 5509.614326997112, 5525.0883604205255, 6145.784897528565, 6152.477039451652, 6154.353792851775, 6190.164327815733, 6205.03821907605, 6054.273487181566, 6138.0792881067755, 6168.75324987, 6178.042403427431, 6204.379562043805, 5627.099664053731, 5654.773809047674, 5666.065099258617, 5688.260526131577, 5691.886162276773, 4863.221884498464, 6097.615421629297, 6172.629642221481, 6174.722137503823, 6184.938150618526, 5957.463828255478, 5994.880102397928, 5996.0, 6016.969915150396, 6086.208792856989, 6007.549433792483, 6101.389861013952, 6139.079138129317, 6140.565599444524, 6173.96913015441, 5883.794067207627, 5886.735096920649, 6051.0, 6065.969670151621, 6069.666168360783, 6146.846328841725, 6161.106639537242, 6165.938340616626, 6172.290186628506, 6196.0, 4786.928196077061, 4815.518448155157, 4827.541383568555, 4833.685810422311, 4908.0, 4213.325867861189, 4334.566543345641, 4337.371081193272, 4353.978230108829, 4356.215881141425, 5786.450287222707, 5790.739416726257, 5811.4479124483105, 5817.272840894888, 5849.88300233993, 5155.536001759785, 5627.043402621564, 6149.754009839557, 6165.136880836686, 6169.167162433104, 4965.056639238605, 5506.64206826555, 5777.826665200051, 5848.0, 5909.497692696083, 5274.287971123926, 5274.3670759509105, 5294.364676238799, 5306.071437498423, 5362.329708786402, 6121.483458747687, 6179.134921111048, 6245.437910587887, 6246.361596369813, 6313.08460273267, 6130.111133885651, 6149.72326245329, 6160.938390616216, 6161.353057928853, 6164.352742961924, 6277.435030847063, 6286.8428289291305, 6291.389073534615, 6304.810855674337, 6308.842278943063, 5919.378465261258, 6032.245969253843, 6123.130109042811, 6134.41182344721, 6140.04415716754, 6092.969535152296, 6142.815715528542, 6145.631262124287, 6177.444030037139, 6200.782972596118, 5740.282464691913, 6060.153817071129, 6088.147659327609, 6097.481714054177, 6101.389861013863, 5977.701114944322, 6033.54748393881, 6054.091886217103, 6057.545684073801, 6118.174046503665, 5755.625884317506, 5811.593188476766, 5869.236999190078, 5870.0607902735355, 5890.911636325544, 5890.0, 6004.699765011819, 6063.211782468427, 6078.969605151946, 6100.725467353891, 5857.882842343214, 5928.140419639214, 5937.643741375531, 5955.196048533393, 5955.196048533393], "unit": "score", "name": "dojo.html", "value": 5589.845663989237}, {"lowerIsBetter": false, "replicates": [438.8990532177599, 464.9790759415826, 493.66184163847754, 565.7652074389129, 590.968759514647, 36049.459258111114, 36878.631213687855, 36933.0, 36977.260454790885, 37028.25943481129, 37590.43614345787, 38157.61842381575, 38208.61791382085, 38307.80846095773, 38308.425373619415, 9278.072192780719, 9498.620055197784, 9516.904830951706, 9544.61821527138, 9558.091981261803, 9310.534473276342, 9486.33595648305, 9572.664956726516, 9586.185174260196, 9594.712158635251, 7919.960400197991, 8577.185167409087, 9534.04659534048, 9611.038896110404, 9613.711588652352, 9571.425714457155, 9585.616575336944, 9594.328397012212, 9602.855957160647, 9623.133917947383, 9424.151826335663, 9565.473898935556, 9576.61693532258, 9580.329376943617, 9588.520573971273, 35720.0, 35750.64249357499, 35770.64229357725, 35858.0, 36231.27537449262, 2504.93540245395, 2720.91837244883, 2914.985425072882, 3418.29924865402, 3477.8608855646, 21406.52074329303, 21509.0, 25864.353391165183, 26182.86908565445, 27031.0, 2696.6359541461848, 2735.8905643774424, 2745.23133522614, 2856.5429531274895, 2930.970690293091, 371072.0, 420116.9999999969, 425561.0, 427465.0, 428152.0, 37971.810140949674, 58221.0, 58533.41466585365, 58627.41372586305, 58794.11808822871, 42834.143317134105, 42881.0, 43025.569744302156, 43137.35293970593, 43365.78317108457, 15011.624709382135, 15113.622159446102, 15151.090934543963, 15155.772663410058, 15246.618834529225, 9826.950865245772, 12181.512739490321, 12243.387830608433, 12247.326397048248, 12305.815412768816, 13829.654258643614, 13858.237796921065, 14072.0, 14101.78847317291, 14202.076865003743, 5705.400932902068, 6365.809025729235, 6391.296957334689, 6456.483481321483, 6516.478681705452, 895.0, 973.7468258252906, 990.9009099090177, 995.6216637677636, 1079.8164312066967, 28470.85764571164, 28547.71452285492, 28887.56668649972, 28902.566461503095, 28915.722421764913, 925.9675911343071, 1013.368476752428, 1039.8440233964966, 1083.1443159903745, 1090.7382228265317, 13767.808154148266, 13861.376238069312, 13925.721485570231, 14239.359228834728, 14381.64045898861, 646899.0, 651359.0, 653825.0, 659060.0, 660879.0, 54049.72975135099, 54500.45499545033, 54674.72662636741, 54676.45323546793, 54863.0, 1404.3048690897867, 1425.583635737415, 1448.341004842794, 1449.029150469167, 1454.1711224601875, 25932.22203333903, 27082.45835083248, 27431.588526171723, 27525.44949101047, 27715.44569108647, 44850.551494485946, 44894.3265851019, 45339.86650333768, 45374.865628359556, 45478.545214547434, 486977.0, 488831.0, 491564.0, 492297.0, 493488.0, 30412.391752165277, 31352.52971205388, 31401.05796826099, 31682.841585791924, 31710.68289317077, 40523.797381012904, 41074.794626026676, 41406.0, 41902.37146442745, 42122.36816447817, 34868.65131348654, 35041.824790875886, 35455.11362215965, 35474.290514190085, 35665.930022099375, 33123.66876331206, 34793.826030869684, 35145.297094058486, 35512.0, 36868.0, 31480.0, 34413.96758097261, 34432.65567344295, 36207.45688814722, 36693.89918302455, 29887.850560747058, 30530.931417400283, 30683.0, 30695.846520768147, 30799.538006929466, 16996.915015424845, 20041.29855455052, 23028.194013209457, 24202.878985605665, 24208.031678732652], "unit": "score", "name": "ext.html", "value": 18300.21831553764}, {"lowerIsBetter": false, "replicates": [355.381635953441, 356.59526437493435, 361.0900530662729, 365.3168574765188, 368.6221622836594, 15869.0, 18657.62684746304, 19374.418767436982, 21296.4675883103, 21745.0, 18203.271869125252, 19380.80619193811, 19445.611087778238, 19772.110255038522, 19971.901545414996, 5871.207387002764, 6102.847428814271, 6892.931070689279, 7212.567245965232, 7233.132024157108, 6883.8967415488805, 7016.087908571904, 7111.679974401139, 7785.338246249075, 7844.215578442138, 4597.540245975392, 6401.711922963478, 7513.2862378074, 7745.264199901, 7774.8445031099345, 7237.638118094074, 7444.925550744478, 7478.2895624915545, 7483.289087536676, 7493.4005279577505, 7425.628718564104, 7455.66449509768, 7462.776116716507, 7480.9251907480775, 7504.5872477013745, 23320.88339558308, 26704.8664756675, 26946.78739456729, 27483.0, 27574.448511029666, 2170.9240176593744, 2278.646809744492, 2603.0108558747556, 2990.132861470171, 3081.4145312390574, 12942.547010854574, 15458.308927915594, 15607.297671604805, 15644.296006679726, 16225.188740562924, 1903.790583035865, 1943.689009758446, 1955.2374573916184, 1995.9900200498905, 2087.561612061469, 108891.91108088897, 114225.42887285593, 115989.42005290004, 117034.0, 118538.0, 19257.0, 19902.203911843364, 19908.50228744293, 19978.20087196496, 20063.197472101245, 13094.869051309555, 13616.931915340558, 13661.316934153252, 28639.997600083898, 28686.426271474455, 8225.218604232588, 8349.081601023883, 8489.915100849035, 8533.104024077382, 8647.178518040777, 8647.0, 8695.434796738191, 8748.8687669685, 8754.21212090915, 8782.0, 4442.244818380883, 4510.503844577094, 4523.276275795923, 4523.95476045242, 4532.206863798888, 1589.8711914540575, 1680.915954202285, 1945.319138301583, 1947.8246957773868, 1981.6135853508715, 854.1287886355882, 904.1455824246156, 907.7775944893411, 931.8648795924553, 978.9412635241908, 18456.907715461337, 19460.4161875144, 20564.588708226052, 21302.57394852094, 21753.67369489459, 925.7037747920601, 932.8367535681228, 995.1342332170913, 1011.1607365886297, 1042.2698320787456, 10391.896081039244, 10635.04284614373, 10702.892971070345, 10703.411312377739, 10777.137828973664, 434213.0, 494969.0, 506424.0, 510018.0, 516433.0, 109827.0, 113465.0, 115119.0, 126718.7328126707, 128116.43767124791, 1020.2756043209256, 1040.432964034603, 1041.9739506512246, 1044.0499145777305, 1071.276888100529, 17445.738313925554, 18181.54546136357, 18390.356337528123, 19090.618187635893, 19193.616127677647, 37340.813295933345, 38473.807630961666, 49963.75018125032, 51044.97910041704, 51196.97606047933, 58698.413015871, 73085.26914730784, 77332.0, 82888.17111828804, 83160.58419707863, 7997.360211183208, 8167.795805104683, 8182.1817818217705, 8319.750407487785, 8339.666413343399, 10812.80395439685, 12707.80938285945, 12896.871031289567, 13622.0, 13746.518871839438, 10629.627963021258, 11134.4968429261, 11969.461374238006, 11969.700757481132, 11973.10201734856, 11404.48679809394, 11624.535018599161, 11736.295822250693, 11789.705257368634, 11817.82273265919, 10032.347897386646, 10411.583536658449, 11652.126090543074, 12077.698057548632, 12147.696307592027, 6027.78902738402, 6569.948808190667, 6723.0, 8273.586320684062, 8380.16198380157, 8710.520921349387, 9800.901990980285, 10617.522211500656, 11962.700932476757, 12089.395530223277], "unit": "score", "name": "jquery.html", "value": 10069.859944597209}, {"lowerIsBetter": false, "replicates": [1423.8077859488967, 1552.4333618229346, 1758.6131051168738, 1901.420066879602, 1903.1530968718926, 7043.823904402379, 8284.834303313937, 8497.532635705034, 8613.83713198718, 8808.867866981993, 7196.640167991605, 8493.702720404786, 8625.309975201984, 8639.352048596365, 8641.049484556694, 2425.757424257578, 2442.1696623148127, 2453.2885463215734, 2473.9628905566433, 2481.7766401023905, 2402.2072716003763, 2469.7653722896384, 2473.6042233242683, 2475.814313926454, 2477.690288713911, 2151.440625437382, 2395.772401621843, 2428.574999375111, 2449.6937882764655, 2458.0045081741923, 1912.722655214993, 2384.070212617081, 2431.1369463840347, 2439.9634005489934, 2447.49826285611, 2405.579023670851, 2411.4212588978517, 2415.7946574541184, 2419.11702228687, 2430.793382562484, 8747.781305467413, 8761.7809554761, 8770.473771573726, 8797.0, 8910.55447227636, 4512.503624601291, 5290.677330667333, 5293.894122117575, 5429.0, 5484.341878974548, 3567.5362202913716, 3596.6942809861193, 3677.7057835373107, 3703.7962912039825, 3726.329260733067, 1037.704254287532, 1046.4558429616634, 1076.94615269237, 1079.1259080145107, 1080.870490337599, 10482.37105773656, 11420.828687569694, 11583.536658533649, 11674.949254567046, 11708.824367634492, 4783.832565860178, 4841.273808928619, 4860.416749989953, 4880.0, 4906.852794416173, 9934.552945117486, 9991.350562213433, 9998.650047248311, 10024.448655324028, 10044.246681498917, 4883.974365383238, 5388.515033646991, 5419.430959749248, 5475.4524547544925, 5514.172874068841, 4890.510948905081, 4945.505449455098, 4952.579030782352, 4992.650514463952, 4998.475160108136, 3889.183271512957, 3913.5695073541888, 3928.2143571285856, 3979.6816254700134, 3979.9602003980167, 1202.4168278384977, 1278.3799857069314, 1298.7727147749106, 1303.2962200411862, 1315.9210447373189, 1104.9668509944715, 1110.611286049876, 1138.5844166879194, 1244.3591550351575, 1356.6404902700792, 7891.289783919475, 7970.2826745593175, 7988.520688758693, 8080.111187769341, 8342.0, 1183.875693052217, 1188.1920294199854, 1216.6714986953473, 1227.9623717958311, 1251.9186252893533, 6167.907481387782, 6216.912040392913, 6272.780452684134, 6296.811095667137, 6306.211723534559, 10388.532516036796, 10693.198010149114, 10737.731556710989, 10835.783284334428, 10885.020348168702, 9885.406875587487, 10189.0, 10565.260431769702, 10592.0, 10608.522616482276, 7967.760967170994, 8060.31487323584, 8106.189381061847, 8131.9186808132345, 8176.3458923286, 7756.418268629763, 7834.020747406575, 7864.252895974873, 7918.0, 7939.920600793918, 9067.229285510806, 9193.908060919306, 9325.626974921199, 9331.53342332867, 9361.017093205115, 9263.490508022123, 9487.762805929908, 9712.223022158068, 9760.072793084646, 9874.85187722199, 7393.223711510214, 7421.0, 7524.887126693214, 7529.209433009674, 7540.698372065056, 8140.552269625227, 8144.75565733029, 8146.307563857138, 8177.6320065596, 8202.753917382488, 6769.458443324424, 7206.927930720835, 7337.633118344168, 7472.738454154079, 7545.962270188614, 7084.043654106836, 7111.751088711871, 7144.535605185646, 7196.316349946746, 7229.819254518679, 7218.530795498275, 7476.25237476248, 7501.474896757175, 7503.09962804467, 7560.4329675273475, 6788.93211067883, 6856.897146542906, 6861.828454288483, 6902.516823822284, 6952.5133240674695, 5872.383399742966, 6919.100516932766, 6945.097137372311, 6967.442604591519, 7024.683889224895], "unit": "score", "name": "mootools.html", "value": 4883.418783217382}, {"lowerIsBetter": false, "replicates": [317.22280412988175, 322.79341221618154, 325.76870422000377, 328.1730040298448, 331.3009549849818, 5324.334458192726, 6528.34716528347, 6641.900371494431, 6651.068850360947, 6678.065070890073, 6626.370494802998, 6659.90010149847, 6660.500462465322, 6682.966585167067, 6688.83277918051, 4377.649788016951, 4649.349091127245, 4946.505349465043, 4972.2044472884345, 5005.5995520358465, 5018.071656743514, 5019.3725784276785, 5023.120953833083, 5030.647854650176, 5063.46833582474, 4967.081089998362, 4974.776135073912, 4977.50224977503, 4991.32617096691, 4994.250862370655, 4716.245400735866, 4906.362172917534, 4961.776720047588, 4972.353594032788, 4978.626603004771, 4224.859287992225, 4236.766977816219, 4249.065205654751, 4255.276602977501, 4263.360495925605, 6351.142595749561, 6370.458511026568, 6375.904361434582, 6380.808575742735, 6380.968095159495, 4719.787609557578, 5731.484166425, 5867.647941123546, 5868.794592189295, 5879.265091863517, 7119.0, 7146.892796608055, 7148.213696493382, 7155.356017958408, 7189.17324507683, 4763.69036012658, 4766.213574760161, 4770.522947705236, 4773.570378665937, 4780.043991201774, 7517.17311095779, 7535.208803075708, 7627.6567554459625, 7630.351420129296, 7644.312011918954, 4011.538673052578, 4102.2410853992105, 4629.282461218517, 4734.313524538922, 4826.348442960156, 4899.2896030075435, 4908.288298196741, 4915.926261106087, 4930.506949305112, 4945.554900059012, 5773.422657734193, 5781.508571771363, 5799.159121927297, 5804.1293805929445, 5807.5644326675665, 5684.261046063985, 5710.229119068956, 5771.913421298684, 7125.53684010548, 7126.465515086389, 1703.2590822992038, 1723.3709695960883, 1727.9827201727821, 1737.6611560745787, 1737.7045902196405, 1088.77135801481, 1125.1842414249604, 1127.1827924754487, 1134.6539305511733, 1149.6091328948198, 6802.115724955823, 6841.0, 6843.076184715, 6894.103766510321, 6898.241193468714, 7513.098428188652, 7520.0, 7538.246175382418, 7540.095188577406, 7554.924450755422, 6808.536164724608, 6819.829504262334, 6819.931800682029, 6856.211535673461, 6860.862782744417, 3708.980030491636, 3897.922041559153, 3970.6426421621613, 4006.399040144002, 4015.678745700395, 6809.706155830377, 7727.150013498511, 7805.37556995439, 8058.597070146469, 8060.879086813702, 5928.3775203603, 7242.49302548827, 7374.746293130073, 7886.960565197252, 7902.3678105751405, 8019.599020048974, 8023.077346105156, 8024.759257222293, 8045.034595848536, 8060.758177254692, 7313.926860731324, 7611.2769286917655, 7640.579768112807, 7653.502522336031, 7656.846863062819, 7416.814579635552, 7462.029936108272, 7471.813204669927, 7478.6260686966525, 7490.0, 6519.869602608016, 6935.445164386736, 8027.4380793346245, 8034.437589368688, 8053.919460805317, 3627.5646922369483, 4424.446944131983, 4894.804207831647, 4919.901601968012, 4921.384826896638, 7295.966182130043, 7532.661030253761, 7563.697452101855, 7587.468877178544, 7599.392048636207, 5890.263717035371, 7272.200057993722, 7304.306090921354, 7309.195988441374, 7320.377767889789, 7293.161286451914, 7309.707611695472, 7326.9267307326245, 7336.96331518339, 7364.0, 5778.306603207642, 7143.749968751069, 7148.463865210234, 7150.0, 7169.426445884213, 7013.0, 7265.273472652692, 7274.8908766369605, 7281.344678978918, 7320.450966177665, 7146.821329466805, 7180.60506672138, 7191.820204494929, 7197.1363436387965, 7215.639218039182], "unit": "score", "name": "prototype.html", "value": 5247.080351067343}, {"lowerIsBetter": false, "replicates": [651.1730102769482, 655.9897757453521, 691.3535843985874, 695.2630211975306, 723.3309189000173, 14757.335919883604, 15114.168720720356, 15131.31909064092, 16885.98684078953, 17150.399736009243, 14766.557003289892, 15837.60405989851, 15889.841101588981, 15947.282372293246, 15974.0, 698.4482259015372, 749.1946157880274, 838.8364268967523, 856.6830272799073, 884.3146561414923, 862.1507814802414, 865.68835219321, 868.1405408645427, 869.6825658634616, 871.6382701179003, 906.5512571277227, 915.1534830281996, 922.2391526990226, 922.5202894494859, 923.0953665407905, 890.6259371064168, 900.8334207201657, 903.4804987132393, 913.0230653201045, 914.1087439746261, 670.1924181361447, 678.725116327888, 679.6771533521538, 680.3740558686021, 681.0805412692874, 15057.698846023019, 15133.54599362021, 15184.240787960558, 15289.082655040622, 15293.388264469408, 12557.372131393486, 12577.496900123984, 12662.55681051168, 12878.71212878714, 12974.935125324313, 8183.304419124322, 8661.610227539775, 9960.750981225456, 10040.598376064949, 10181.898181018169, 3490.2670439207795, 3533.0990597397754, 3540.0972751948348, 3544.3974524330924, 3622.456631505269, 85846.0, 85894.14105858987, 86086.0, 86430.0, 86680.0, 9174.495402752778, 9277.953610231905, 9305.860412093823, 9315.0, 9570.856437153448, 16672.0, 20264.0, 20461.18155273802, 20518.692219616718, 20544.972751362373, 7038.92961070393, 7287.599182044933, 7330.523515971445, 7389.113306403266, 7568.205338439495, 4099.61053699898, 4149.605787450248, 4150.398192262105, 4154.5222299435345, 4156.334986402161, 3459.636738142459, 3479.7564170508326, 3493.63316851732, 3503.649635036527, 3503.8773642922374, 615.237105988571, 629.3266205160435, 629.8456878064903, 630.5995692735146, 639.5810743962712, 524.9448807875194, 589.4959809363019, 590.4774274766862, 591.4913174669781, 617.4566381584177, 8256.669733210605, 8559.272461840688, 8619.61211745473, 8634.309255259564, 8712.21590056898, 509.3632958801498, 541.6614615865084, 593.6104841355906, 604.3956043956044, 615.5444970721724, 3461.913452163716, 3705.925881482355, 3974.364101743707, 4073.920411091063, 4330.242207613655, 84584.57707711423, 84914.15085849063, 85647.57176214203, 87141.0, 87220.25559488774, 64811.703765924416, 66363.66818165878, 67208.6639566799, 71580.0, 75369.62315188498, 63130.684346577975, 63971.0, 64537.35462645407, 65372.097092718235, 66468.33531664718, 6609.570377925419, 7418.016888968357, 8439.409241353047, 8664.133586641285, 8690.522021288889, 45314.86712832074, 47964.76017620029, 47968.321108761025, 48106.51893481021, 48296.517034830606, 60678.39321606904, 61269.0, 62002.0, 62330.0, 64472.677636611515, 10130.89869101329, 10389.272750907667, 10669.57321707123, 10697.946510267398, 11158.832617510907, 11724.413779311171, 11776.352300623204, 12153.817692734792, 12172.14794964344, 12430.378481076092, 10436.791264174826, 10987.230893837355, 11019.614313498989, 11238.494267757807, 11245.887541124484, 10052.64815731446, 10976.560937562408, 11252.0, 11826.0, 12124.75750485003, 9370.625174993196, 11049.28179668319, 11097.833532497181, 11525.769484610428, 11731.061515078944, 8620.439671421338, 9552.761180970532, 9678.225741940769, 9731.708048758548, 9782.217422606032, 9183.586738596645, 9749.707508774749, 9824.4105353679, 9844.852327214954, 9889.50552472388], "unit": "score", "name": "yui.html", "value": 6754.481059412207}], "name": "dromaeo_css", "value": 7502.2419643520025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 115.0, 113.0, 114.0, 127.0, 91.0, 168.0, 103.0, 156.0], "unit": "score", "name": "ai-astar", "value": 120.9}, {"lowerIsBetter": true, "replicates": [160.0, 124.0, 152.0, 180.0, 125.0, 142.0, 139.0, 122.0, 159.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [194.0, 200.0, 202.0, 200.0, 202.0, 217.0, 217.0, 224.0, 203.0, 201.0], "unit": "score", "name": "audio-dft", "value": 206.0}, {"lowerIsBetter": true, "replicates": [61.0, 76.0, 61.0, 74.0, 105.0, 57.0, 57.0, 59.0, 59.0, 113.0], "unit": "score", "name": "audio-fft", "value": 72.2}, {"lowerIsBetter": true, "replicates": [82.0, 91.0, 118.0, 78.0, 79.0, 82.0, 117.0, 81.0, 83.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 92.8}, {"lowerIsBetter": true, "replicates": [117.0, 92.0, 85.0, 113.0, 86.0, 112.0, 111.0, 83.0, 133.0, 142.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 107.4}, {"lowerIsBetter": true, "replicates": [127.0, 99.0, 143.0, 153.0, 96.0, 94.0, 131.0, 150.0, 97.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 118.4}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 144.0, 145.0, 131.0, 90.0, 95.0, 92.0, 92.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 106.9}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 57.0, 55.0, 58.0, 56.0, 56.0, 65.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 74.0, 69.0, 87.0, 65.0, 79.0, 100.0, 104.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.8}, {"lowerIsBetter": true, "replicates": [88.0, 91.0, 102.0, 108.0, 116.0, 75.0, 102.0, 115.0, 113.0, 113.0], "unit": "score", "name": "stanford-crypto-aes", "value": 102.3}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 130.0, 122.0, 126.0, 131.0, 128.0, 137.0, 125.0, 155.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.0}, {"lowerIsBetter": true, "replicates": [157.0, 193.0, 146.0, 150.0, 150.0, 139.0, 155.0, 167.0, 153.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.6}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 96.0, 94.0, 100.0, 93.0, 70.0, 70.0, 68.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.4}], "name": "kraken", "value": 1575.6999999999998}]} 10:33:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1575.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7502.24"}}} 10:33:08 INFO - Return code: 0 10:33:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:33:09 ERROR - # TBPL SUCCESS # 10:33:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:09 INFO - 2016-02-23 10:33:09.052 screenresolution[7612:144094] starting screenresolution argv=screenresolution get 10:33:09 INFO - 2016-02-23 10:33:09.055 screenresolution[7612:144094] Display 0: 1600x1200x32@60 10:33:09 INFO - 2016-02-23 10:33:09.062 screenresolution[7613:144097] starting screenresolution argv=screenresolution list 10:33:09 INFO - Available Modes on Display 0 10:33:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:09 INFO - Intel Iris: 10:33:09 INFO - Chipset Model: Intel Iris 10:33:09 INFO - Type: GPU 10:33:09 INFO - Bus: Built-In 10:33:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:09 INFO - Vendor: Intel (0x8086) 10:33:09 INFO - Device ID: 0x0a2e 10:33:09 INFO - Revision ID: 0x0009 10:33:09 INFO - Displays: 10:33:09 INFO - Display: 10:33:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:09 INFO - Display Serial Number: 1600x1200 60 10:33:09 INFO - Main Display: Yes 10:33:09 INFO - Mirror: Off 10:33:09 INFO - Online: Yes 10:33:09 INFO - Rotation: Supported 10:33:09 INFO - Return code: 0 10:33:09 INFO - Running post-action listener: _resource_record_post_action 10:33:09 INFO - Running post-run listener: _resource_record_post_run 10:33:10 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 0; Write bytes: 710412288; Read time: 0; Write time: 2117 10:33:10 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403945984; Write bytes: 406533120; Read time: 30348; Write time: 774 10:33:10 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 0; Write bytes: 302220288; Read time: 0; Write time: 1337 10:33:10 INFO - Running post-run listener: _upload_blobber_files 10:33:10 INFO - Blob upload gear active. 10:33:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:10 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 10:33:10 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'] 10:33:10 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 10:33:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:33:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:12 INFO - (blobuploader) - INFO - Done attempting. 10:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:13 INFO - (blobuploader) - INFO - Done attempting. 10:33:13 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:13 INFO - Return code: 0 10:33:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2541b01f233fde5435d454c7b855b7f7a5bfbe6731b31354aa7dc3b90d79056ae666e611f681833f086db527ae67a7b1bdf275d64a502c593ce0f71b799c75a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5743aca679cd651c1e04bf903cc6fdeae10e28fd7b5f3c43816025ebf8c144fda06fdaf9753e42e2b9b1e3a7e64d09c6615353e18e9f85d905675adfe16a205"} 10:33:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:13 INFO - Contents: 10:33:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2541b01f233fde5435d454c7b855b7f7a5bfbe6731b31354aa7dc3b90d79056ae666e611f681833f086db527ae67a7b1bdf275d64a502c593ce0f71b799c75a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5743aca679cd651c1e04bf903cc6fdeae10e28fd7b5f3c43816025ebf8c144fda06fdaf9753e42e2b9b1e3a7e64d09c6615353e18e9f85d905675adfe16a205"} 10:33:13 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:13 INFO - Copying logs to upload dir... 10:33:13 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.884352 ========= master_lag: 37.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-02-23 10:33:51.574334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 10:33:51.575552) ========= 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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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/e2541b01f233fde5435d454c7b855b7f7a5bfbe6731b31354aa7dc3b90d79056ae666e611f681833f086db527ae67a7b1bdf275d64a502c593ce0f71b799c75a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5743aca679cd651c1e04bf903cc6fdeae10e28fd7b5f3c43816025ebf8c144fda06fdaf9753e42e2b9b1e3a7e64d09c6615353e18e9f85d905675adfe16a205"} build_url:https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/KpkSn_VaScGY8f874UPPVQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2541b01f233fde5435d454c7b855b7f7a5bfbe6731b31354aa7dc3b90d79056ae666e611f681833f086db527ae67a7b1bdf275d64a502c593ce0f71b799c75a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5743aca679cd651c1e04bf903cc6fdeae10e28fd7b5f3c43816025ebf8c144fda06fdaf9753e42e2b9b1e3a7e64d09c6615353e18e9f85d905675adfe16a205"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 10:33:52.009695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:33:52.009990) ========= 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.9ZtZJ0G2Fi/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.sdBjGn4afn/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005477 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 10:33:52.083578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:33:52.083901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 10:33:52.108080) ========= ========= Total master_lag: 38.61 =========