builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0043 starttime: 1456183600.78 results: success (0) buildid: 20160222142848 builduid: 9d91b02336de41ff822fa811416d915e revision: 061710a98fa4a8353f63076c34aa318565e59ec8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.779983) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.780463) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.780788) ========= 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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.005587 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.802944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.803247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.819017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.819318) ========= 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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.004856 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.867589) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.867921) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.868295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:40.868603) ========= 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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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-22 15:26:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-02-22 15:26:41 (46.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:41.055640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:41.056106) ========= 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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.020132 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:41.106003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 15:26:41.106431) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 061710a98fa4a8353f63076c34aa318565e59ec8 --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 061710a98fa4a8353f63076c34aa318565e59ec8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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-22 15:26:41,186 truncating revision to first 12 chars 2016-02-22 15:26:41,186 Setting DEBUG logging. 2016-02-22 15:26:41,186 attempt 1/10 2016-02-22 15:26:41,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/061710a98fa4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 15:26:42,702 unpacking tar archive at: fx-team-061710a98fa4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.761164 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 15:26:42.884472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:42.884986) ========= echo 061710a98fa4a8353f63076c34aa318565e59ec8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'061710a98fa4a8353f63076c34aa318565e59ec8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 061710a98fa4a8353f63076c34aa318565e59ec8 program finished with exit code 0 elapsedTime=0.005017 script_repo_revision: '061710a98fa4a8353f63076c34aa318565e59ec8' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:42.934819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:42.935205) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:42.948475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-22 15:26:42.948922) ========= /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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:26:43 INFO - MultiFileLogger online at 20160222 15:26:43 in /builds/slave/test 15:26:43 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 15:26:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:43 INFO - {'append_to_log': False, 15:26:43 INFO - 'base_work_dir': '/builds/slave/test', 15:26:43 INFO - 'blob_upload_branch': 'Fx-Team', 15:26:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:43 INFO - 'branch': 'Fx-Team', 15:26:43 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:43 INFO - 'config_files': ('talos/mac_config.py',), 15:26:43 INFO - 'default_actions': ('clobber', 15:26:43 INFO - 'read-buildbot-config', 15:26:43 INFO - 'download-and-extract', 15:26:43 INFO - 'populate-webroot', 15:26:43 INFO - 'create-virtualenv', 15:26:43 INFO - 'install', 15:26:43 INFO - 'run-tests'), 15:26:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:43 INFO - 'download_minidump_stackwalk': True, 15:26:43 INFO - 'download_symbols': 'ondemand', 15:26:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:43 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:43 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:43 INFO - 'installer_path': 'installer.exe', 15:26:43 INFO - 'log_level': 'info', 15:26:43 INFO - 'log_name': 'talos', 15:26:43 INFO - 'log_to_console': True, 15:26:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:26:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:26:43 INFO - 'opt_config_files': (), 15:26:43 INFO - 'pip_index': False, 15:26:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:43 INFO - 'cmd': ('bash', 15:26:43 INFO - '-c', 15:26:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:43 INFO - 'enabled': True, 15:26:43 INFO - 'halt_on_failure': False, 15:26:43 INFO - 'name': 'check_screen_resolution'},), 15:26:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:43 INFO - 'cmd': ('bash', 15:26:43 INFO - '-c', 15:26:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:43 INFO - 'enabled': True, 15:26:43 INFO - 'halt_on_failure': False, 15:26:43 INFO - 'name': 'check_screen_resolution'},), 15:26:43 INFO - 'run_cmd_checks_enabled': True, 15:26:43 INFO - 'sps_profile': False, 15:26:43 INFO - 'sps_profile_interval': 0, 15:26:43 INFO - 'suite': 'dromaeojs-e10s', 15:26:43 INFO - 'system_bits': '32', 15:26:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:43 INFO - 'title': 't-yosemite-r7-0043', 15:26:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:43 INFO - 'use_talos_json': True, 15:26:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:43 INFO - 'work_dir': 'build'} 15:26:43 INFO - ##### 15:26:43 INFO - ##### Running clobber step. 15:26:43 INFO - ##### 15:26:43 INFO - Running pre-action listener: _resource_record_pre_action 15:26:43 INFO - Running main action method: clobber 15:26:43 INFO - rmtree: /builds/slave/test/build 15:26:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:45 INFO - Running post-action listener: _resource_record_post_action 15:26:45 INFO - ##### 15:26:45 INFO - ##### Running read-buildbot-config step. 15:26:45 INFO - ##### 15:26:45 INFO - Running pre-action listener: _resource_record_pre_action 15:26:45 INFO - Running main action method: read_buildbot_config 15:26:45 INFO - Using buildbot properties: 15:26:45 INFO - { 15:26:45 INFO - "project": "", 15:26:45 INFO - "product": "firefox", 15:26:45 INFO - "script_repo_revision": "production", 15:26:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:26:45 INFO - "repository": "", 15:26:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:26:45 INFO - "buildid": "20160222142848", 15:26:45 INFO - "pgo_build": "False", 15:26:45 INFO - "basedir": "/builds/slave/test", 15:26:45 INFO - "buildnumber": 431, 15:26:45 INFO - "slavename": "t-yosemite-r7-0043", 15:26:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:26:45 INFO - "platform": "yosemite_r7", 15:26:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:26:45 INFO - "branch": "fx-team", 15:26:45 INFO - "repo_path": "integration/fx-team", 15:26:45 INFO - "revision": "061710a98fa4a8353f63076c34aa318565e59ec8", 15:26:45 INFO - "stage_platform": "macosx64", 15:26:45 INFO - "builduid": "9d91b02336de41ff822fa811416d915e", 15:26:45 INFO - "slavebuilddir": "test" 15:26:45 INFO - } 15:26:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:26:45 INFO - Running post-action listener: _resource_record_post_action 15:26:45 INFO - ##### 15:26:45 INFO - ##### Running download-and-extract step. 15:26:45 INFO - ##### 15:26:45 INFO - Running pre-action listener: _resource_record_pre_action 15:26:45 INFO - Running main action method: download_and_extract 15:26:45 INFO - mkdir: /builds/slave/test/build/tests 15:26: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')]} 15:26:45 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json 15:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json 15:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:26:46 INFO - Downloaded 1277 bytes. 15:26:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:26:46 INFO - Using the following test package requirements: 15:26:46 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:26:46 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:26:46 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:26:46 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'jsshell-mac.zip'], 15:26:46 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:26:46 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:26:46 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:26:46 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:26:46 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:26:46 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:26:46 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:46 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:26:46 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:46 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:48 INFO - Downloaded 17825424 bytes. 15:26:48 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'] 15:26:48 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 15:26:51 INFO - Return code: 0 15:26:51 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 15:26:51 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')]} 15:26:51 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:52 INFO - Downloaded 17825424 bytes. 15:26:52 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'] 15:26:52 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 15:26:55 INFO - Return code: 0 15:26: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')]} 15:26:55 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:57 INFO - Downloaded 10707015 bytes. 15:26:57 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'] 15:26:57 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 15:26:57 INFO - Return code: 0 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:26:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:26:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:26:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:26:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:27:01 INFO - Downloaded 111277349 bytes. 15:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:27:01 INFO - mkdir: /builds/slave/test/properties 15:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 15:27:01 INFO - Contents: 15:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:27:02 INFO - Running post-action listener: _resource_record_post_action 15:27:02 INFO - Running post-action listener: set_extra_try_arguments 15:27:02 INFO - ##### 15:27:02 INFO - ##### Running populate-webroot step. 15:27:02 INFO - ##### 15:27:02 INFO - Running pre-action listener: _resource_record_pre_action 15:27:02 INFO - Running main action method: populate_webroot 15:27:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:27:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:27:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:27:02 INFO - '--tppagecycles', 15:27:02 INFO - '7'], 15:27:02 INFO - 'tests': ['tsvgm']}}, 15:27:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:27:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:27:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:27:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:27:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'tests': ['damp', 'tps']}, 15:27:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['damp', 'tps']}, 15:27:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:27:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:27:02 INFO - 'other': {'tests': ['a11yr', 15:27:02 INFO - 'ts_paint', 15:27:02 INFO - 'tpaint', 15:27:02 INFO - 'sessionrestore', 15:27:02 INFO - 'sessionrestore_no_auto_restore']}, 15:27:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['a11yr', 15:27:02 INFO - 'ts_paint', 15:27:02 INFO - 'tpaint', 15:27:02 INFO - 'sessionrestore', 15:27:02 INFO - 'sessionrestore_no_auto_restore']}, 15:27:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['a11yr', 15:27:02 INFO - 'ts_paint', 15:27:02 INFO - 'tpaint', 15:27:02 INFO - 'sessionrestore', 15:27:02 INFO - 'sessionrestore_no_auto_restore']}, 15:27:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['a11yr', 15:27:02 INFO - 'ts_paint', 15:27:02 INFO - 'tpaint', 15:27:02 INFO - 'sessionrestore', 15:27:02 INFO - 'sessionrestore_no_auto_restore']}, 15:27:02 INFO - 'other_l64': {'tests': ['a11yr', 15:27:02 INFO - 'ts_paint', 15:27:02 INFO - 'tpaint', 15:27:02 INFO - 'sessionrestore', 15:27:02 INFO - 'sessionrestore_no_auto_restore']}, 15:27:02 INFO - 'other_nol64': {'tests': ['a11yr', 15:27:02 INFO - 'ts_paint', 15:27:02 INFO - 'tpaint', 15:27:02 INFO - 'sessionrestore', 15:27:02 INFO - 'sessionrestore_no_auto_restore']}, 15:27:02 INFO - 'svgr': {'tests': ['tsvgx', 15:27:02 INFO - 'tsvgr_opacity', 15:27:02 INFO - 'tart', 15:27:02 INFO - 'tscrollx', 15:27:02 INFO - 'cart']}, 15:27:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['tsvgx', 15:27:02 INFO - 'tsvgr_opacity', 15:27:02 INFO - 'tart', 15:27:02 INFO - 'tscrollx', 15:27:02 INFO - 'cart']}, 15:27:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'tests': ['tp5o']}, 15:27:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'talos_options': ['--e10s'], 15:27:02 INFO - 'tests': ['tp5o']}, 15:27:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'talos_options': ['--xperf_path', 15:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:02 INFO - 'tests': ['tp5n']}, 15:27:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:02 INFO - 'talos_options': ['--e10s', 15:27:02 INFO - '--xperf_path', 15:27:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:02 INFO - 'tests': ['tp5n']}}, 15:27:02 INFO - 'talos.zip': {'path': '', 15:27:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:27:02 INFO - Running post-action listener: _resource_record_post_action 15:27:02 INFO - ##### 15:27:02 INFO - ##### Running create-virtualenv step. 15:27:02 INFO - ##### 15:27:02 INFO - Running pre-action listener: _resource_record_pre_action 15:27:02 INFO - Running main action method: create_virtualenv 15:27:02 INFO - Creating virtualenv /builds/slave/test/build/venv 15:27:02 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 15:27:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:27:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:27:02 INFO - Using real prefix '/tools/python27' 15:27:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:27:03 INFO - Installing distribute.............................................................................................................................................................................................done. 15:27:06 INFO - Installing pip.................done. 15:27:06 INFO - Return code: 0 15:27:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:27:06 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')]} 15:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:06 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')]} 15:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:06 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:06 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 15:27:06 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 15:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:06 INFO - 'HOME': '/Users/cltbld', 15:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:06 INFO - 'LOGNAME': 'cltbld', 15:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:06 INFO - 'MOZ_NO_REMOTE': '1', 15:27:06 INFO - 'NO_EM_RESTART': '1', 15:27:06 INFO - 'PAGER': '/bin/cat', 15:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:06 INFO - 'PWD': '/builds/slave/test', 15:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:06 INFO - 'SHELL': '/bin/bash', 15:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:06 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:06 INFO - 'USER': 'cltbld', 15:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:06 INFO - 'XPC_FLAGS': '0x0', 15:27:06 INFO - 'XPC_SERVICE_NAME': '0', 15:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:06 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 15:27:06 INFO - Cleaning up... 15:27:06 INFO - Return code: 0 15:27:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:27:06 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')]} 15:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:06 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')]} 15:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:06 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:06 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 15:27:06 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 15:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:06 INFO - 'HOME': '/Users/cltbld', 15:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:06 INFO - 'LOGNAME': 'cltbld', 15:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:06 INFO - 'MOZ_NO_REMOTE': '1', 15:27:06 INFO - 'NO_EM_RESTART': '1', 15:27:06 INFO - 'PAGER': '/bin/cat', 15:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:06 INFO - 'PWD': '/builds/slave/test', 15:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:06 INFO - 'SHELL': '/bin/bash', 15:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:06 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:06 INFO - 'USER': 'cltbld', 15:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:06 INFO - 'XPC_FLAGS': '0x0', 15:27:06 INFO - 'XPC_SERVICE_NAME': '0', 15:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:06 INFO - Downloading/unpacking psutil>=0.7.1 15:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:09 INFO - Installing collected packages: psutil 15:27:09 INFO - Running setup.py install for psutil 15:27:09 INFO - building 'psutil._psutil_osx' extension 15:27:09 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 15:27:10 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 15:27:10 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 15:27:10 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 15:27:10 INFO - building 'psutil._psutil_posix' extension 15:27:10 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 15:27:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:27:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:27:10 INFO - ^ 15:27:10 INFO - 1 warning generated. 15:27:10 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 15:27:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:10 INFO - Successfully installed psutil 15:27:10 INFO - Cleaning up... 15:27:10 INFO - Return code: 0 15:27:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:27:10 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')]} 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:10 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')]} 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:10 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:10 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 15:27:10 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 15:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:10 INFO - 'HOME': '/Users/cltbld', 15:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:10 INFO - 'LOGNAME': 'cltbld', 15:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:10 INFO - 'MOZ_NO_REMOTE': '1', 15:27:10 INFO - 'NO_EM_RESTART': '1', 15:27:10 INFO - 'PAGER': '/bin/cat', 15:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:10 INFO - 'PWD': '/builds/slave/test', 15:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:10 INFO - 'SHELL': '/bin/bash', 15:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:10 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:10 INFO - 'USER': 'cltbld', 15:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:10 INFO - 'XPC_FLAGS': '0x0', 15:27:10 INFO - 'XPC_SERVICE_NAME': '0', 15:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:27:13 INFO - Installing collected packages: mozsystemmonitor 15:27:13 INFO - Running setup.py install for mozsystemmonitor 15:27:13 INFO - Successfully installed mozsystemmonitor 15:27:13 INFO - Cleaning up... 15:27:13 INFO - Return code: 0 15:27:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:13 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:13 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 15:27:13 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 15:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:13 INFO - 'HOME': '/Users/cltbld', 15:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:13 INFO - 'LOGNAME': 'cltbld', 15:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:13 INFO - 'MOZ_NO_REMOTE': '1', 15:27:13 INFO - 'NO_EM_RESTART': '1', 15:27:13 INFO - 'PAGER': '/bin/cat', 15:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:13 INFO - 'PWD': '/builds/slave/test', 15:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:13 INFO - 'SHELL': '/bin/bash', 15:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:13 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:13 INFO - 'USER': 'cltbld', 15:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:13 INFO - 'XPC_FLAGS': '0x0', 15:27:13 INFO - 'XPC_SERVICE_NAME': '0', 15:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:13 INFO - Downloading/unpacking blobuploader==1.2.4 15:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:16 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 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 15:27:16 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 15:27:17 INFO - Downloading docopt-0.6.1.tar.gz 15:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:17 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:17 INFO - Running setup.py install for blobuploader 15:27:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:17 INFO - Running setup.py install for requests 15:27:17 INFO - Running setup.py install for docopt 15:27:18 INFO - Successfully installed blobuploader requests docopt 15:27:18 INFO - Cleaning up... 15:27:18 INFO - Return code: 0 15:27:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:18 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:18 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 15:27:18 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 15:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:18 INFO - 'HOME': '/Users/cltbld', 15:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:18 INFO - 'LOGNAME': 'cltbld', 15:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:18 INFO - 'MOZ_NO_REMOTE': '1', 15:27:18 INFO - 'NO_EM_RESTART': '1', 15:27:18 INFO - 'PAGER': '/bin/cat', 15:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:18 INFO - 'PWD': '/builds/slave/test', 15:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:18 INFO - 'SHELL': '/bin/bash', 15:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:18 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:18 INFO - 'USER': 'cltbld', 15:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:18 INFO - 'XPC_FLAGS': '0x0', 15:27:18 INFO - 'XPC_SERVICE_NAME': '0', 15:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:18 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-rrEpY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:18 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-NET_Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:18 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-gFFpWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:18 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-8sgEMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:18 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-RPDg2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:18 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-ULiAIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-sLNJOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-6PEn9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-LmwLgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-JA9mKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-78pP5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-f6EBzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-ADPrTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-nHyvrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:19 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-4Ct4bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-gdzVeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:20 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-M_X18T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:20 INFO - Running setup.py install for manifestparser 15:27:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:20 INFO - Running setup.py install for mozcrash 15:27:20 INFO - Running setup.py install for mozdebug 15:27:20 INFO - Running setup.py install for mozdevice 15:27:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:20 INFO - Running setup.py install for mozfile 15:27:21 INFO - Running setup.py install for mozhttpd 15:27:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Running setup.py install for mozinfo 15:27:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Running setup.py install for mozInstall 15:27:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Running setup.py install for mozleak 15:27:21 INFO - Running setup.py install for mozlog 15:27:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Running setup.py install for moznetwork 15:27:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:21 INFO - Running setup.py install for mozprocess 15:27:22 INFO - Running setup.py install for mozprofile 15:27:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:22 INFO - Running setup.py install for mozrunner 15:27:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:22 INFO - Running setup.py install for mozscreenshot 15:27:22 INFO - Running setup.py install for moztest 15:27:22 INFO - Running setup.py install for mozversion 15:27:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:22 INFO - Cleaning up... 15:27:22 INFO - Return code: 0 15:27:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:22 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:22 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 15:27:22 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 15:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:22 INFO - 'HOME': '/Users/cltbld', 15:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:22 INFO - 'LOGNAME': 'cltbld', 15:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:22 INFO - 'MOZ_NO_REMOTE': '1', 15:27:22 INFO - 'NO_EM_RESTART': '1', 15:27:22 INFO - 'PAGER': '/bin/cat', 15:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:22 INFO - 'PWD': '/builds/slave/test', 15:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:22 INFO - 'SHELL': '/bin/bash', 15:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:22 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:22 INFO - 'USER': 'cltbld', 15:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:22 INFO - 'XPC_FLAGS': '0x0', 15:27:22 INFO - 'XPC_SERVICE_NAME': '0', 15:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-fWWY4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-ZulJ9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-cbzVVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-HLHXL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-k1aZlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-yyQEvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-fYc548-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-gZO8aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:23 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)) 15:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:23 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-hsA5Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Pc7e53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-eCGvDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-yn6RWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-p5JH0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-vSzwLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-rxlRVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-rq6XOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:24 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)) 15:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:24 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-lkTnhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:24 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)) 15:27:24 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)) 15:27:24 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)) 15:27:24 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)) 15:27:24 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)) 15:27:24 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)) 15:27:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:24 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 15:27:24 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 15:27:24 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 15:27:24 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 15:27:24 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 15:27:24 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 15:27:27 INFO - Downloading blessings-1.6.tar.gz 15:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:27 INFO - Installing collected packages: blessings 15:27:27 INFO - Running setup.py install for blessings 15:27:27 INFO - Successfully installed blessings 15:27:27 INFO - Cleaning up... 15:27:27 INFO - Return code: 0 15:27:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:27 INFO - Reading from file tmpfile_stdout 15:27:27 INFO - Current package versions: 15:27:27 INFO - blessings == 1.6 15:27:27 INFO - blobuploader == 1.2.4 15:27:27 INFO - docopt == 0.6.1 15:27:27 INFO - manifestparser == 1.1 15:27:27 INFO - mozInstall == 1.12 15:27:27 INFO - mozcrash == 0.16 15:27:27 INFO - mozdebug == 0.1 15:27:27 INFO - mozdevice == 0.48 15:27:27 INFO - mozfile == 1.2 15:27:27 INFO - mozhttpd == 0.7 15:27:27 INFO - mozinfo == 0.9 15:27:27 INFO - mozleak == 0.1 15:27:27 INFO - mozlog == 3.1 15:27:27 INFO - moznetwork == 0.27 15:27:27 INFO - mozprocess == 0.22 15:27:27 INFO - mozprofile == 0.28 15:27:27 INFO - mozrunner == 6.11 15:27:27 INFO - mozscreenshot == 0.1 15:27:27 INFO - mozsystemmonitor == 0.0 15:27:27 INFO - moztest == 0.7 15:27:27 INFO - mozversion == 1.4 15:27:27 INFO - psutil == 3.1.1 15:27:27 INFO - requests == 1.2.3 15:27:27 INFO - wsgiref == 0.1.2 15:27:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:27 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')]} 15:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:27 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')]} 15:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:27 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:27 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 15:27:27 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 15:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:27 INFO - 'HOME': '/Users/cltbld', 15:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:27 INFO - 'LOGNAME': 'cltbld', 15:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:27 INFO - 'MOZ_NO_REMOTE': '1', 15:27:27 INFO - 'NO_EM_RESTART': '1', 15:27:27 INFO - 'PAGER': '/bin/cat', 15:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:27 INFO - 'PWD': '/builds/slave/test', 15:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:27 INFO - 'SHELL': '/bin/bash', 15:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:27 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:27 INFO - 'USER': 'cltbld', 15:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:27 INFO - 'XPC_FLAGS': '0x0', 15:27:27 INFO - 'XPC_SERVICE_NAME': '0', 15:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 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)) 15:27:28 INFO - Cleaning up... 15:27:28 INFO - Return code: 0 15:27:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:28 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')]} 15:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:28 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')]} 15:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:28 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:28 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 15:27:28 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 15:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:28 INFO - 'HOME': '/Users/cltbld', 15:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:28 INFO - 'LOGNAME': 'cltbld', 15:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:28 INFO - 'MOZ_NO_REMOTE': '1', 15:27:28 INFO - 'NO_EM_RESTART': '1', 15:27:28 INFO - 'PAGER': '/bin/cat', 15:27:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:28 INFO - 'PWD': '/builds/slave/test', 15:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:28 INFO - 'SHELL': '/bin/bash', 15:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:28 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:28 INFO - 'USER': 'cltbld', 15:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:28 INFO - 'XPC_FLAGS': '0x0', 15:27:28 INFO - 'XPC_SERVICE_NAME': '0', 15:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:28 INFO - Downloading/unpacking jsonschema 15:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:30 INFO - Downloading/unpacking functools32 (from jsonschema) 15:27:30 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 15:27:30 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 15:27:30 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 15:27:30 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 15:27:30 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 15:27:30 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 15:27:31 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:31 INFO - warning: no files found matching '*.txt' 15:27:31 INFO - no previously-included directories found matching 'build' 15:27:31 INFO - no previously-included directories found matching 'dist' 15:27:31 INFO - no previously-included directories found matching '.git*' 15:27:31 INFO - Installing collected packages: jsonschema, functools32 15:27:31 INFO - Running setup.py install for functools32 15:27:31 INFO - warning: no files found matching '*.txt' 15:27:31 INFO - no previously-included directories found matching 'build' 15:27:31 INFO - no previously-included directories found matching 'dist' 15:27:31 INFO - no previously-included directories found matching '.git*' 15:27:31 INFO - Successfully installed jsonschema functools32 15:27:31 INFO - Cleaning up... 15:27:31 INFO - Return code: 0 15:27:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:31 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 0x10ee98a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c2c889b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, '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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 15:27:31 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 15:27:31 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 15:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:31 INFO - 'HOME': '/Users/cltbld', 15:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:31 INFO - 'LOGNAME': 'cltbld', 15:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:31 INFO - 'MOZ_NO_REMOTE': '1', 15:27:31 INFO - 'NO_EM_RESTART': '1', 15:27:31 INFO - 'PAGER': '/bin/cat', 15:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:31 INFO - 'PWD': '/builds/slave/test', 15:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:31 INFO - 'SHELL': '/bin/bash', 15:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:27:31 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:31 INFO - 'USER': 'cltbld', 15:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:31 INFO - 'XPC_FLAGS': '0x0', 15:27:31 INFO - 'XPC_SERVICE_NAME': '0', 15:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:31 INFO - Downloading/unpacking flake8 15:27:31 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 15:27:31 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 15:27:31 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 15:27:31 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 15:27:31 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 15:27:31 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 15:27:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:35 INFO - no previously-included directories found matching 'docs/_build' 15:27:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:35 INFO - Running setup.py install for pep8 15:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:35 INFO - no previously-included directories found matching 'docs/_build' 15:27:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:35 INFO - Cleaning up... 15:27:35 INFO - Return code: 0 15:27:35 INFO - Running post-action listener: _resource_record_post_action 15:27:35 INFO - Running post-action listener: _start_resource_monitoring 15:27:35 INFO - Starting resource monitoring. 15:27:35 INFO - ##### 15:27:35 INFO - ##### Running install step. 15:27:35 INFO - ##### 15:27:35 INFO - Running pre-action listener: _resource_record_pre_action 15:27:35 INFO - Running main action method: install 15:27:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:35 INFO - Reading from file tmpfile_stdout 15:27:35 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:36 INFO - Reading from file tmpfile_stdout 15:27:36 INFO - Output received: 15:27:36 INFO - Usage: mozinstall [options] installer 15:27:36 INFO - Options: 15:27:36 INFO - -h, --help show this help message and exit 15:27:36 INFO - -d DEST, --destination=DEST 15:27:36 INFO - Directory to install application into. [default: 15:27:36 INFO - "/builds/slave/test"] 15:27:36 INFO - --app=APP Application being installed. [default: firefox] 15:27:36 INFO - mkdir: /builds/slave/test/build/application 15:27:36 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'] 15:27:36 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 15:28:10 INFO - Reading from file tmpfile_stdout 15:28:10 INFO - Output received: 15:28:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:28:10 INFO - Running post-action listener: _resource_record_post_action 15:28:10 INFO - ##### 15:28:10 INFO - ##### Running run-tests step. 15:28:10 INFO - ##### 15:28:10 INFO - Running pre-action listener: _resource_record_pre_action 15:28:10 INFO - Running main action method: run_tests 15:28:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:28:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:28:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:28:10 INFO - 2016-02-22 15:28:10.313 screenresolution[2535:29985] starting screenresolution argv=screenresolution get 15:28:10 INFO - 2016-02-22 15:28:10.315 screenresolution[2535:29985] Display 0: 1600x1200x32@60 15:28:10 INFO - 2016-02-22 15:28:10.321 screenresolution[2536:29988] starting screenresolution argv=screenresolution list 15:28:10 INFO - Available Modes on Display 0 15:28:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:28:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:28:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:28:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:28:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:28:10 INFO - Intel Iris: 15:28:10 INFO - Chipset Model: Intel Iris 15:28:10 INFO - Type: GPU 15:28:10 INFO - Bus: Built-In 15:28:10 INFO - VRAM (Dynamic, Max): 1536 MB 15:28:10 INFO - Vendor: Intel (0x8086) 15:28:10 INFO - Device ID: 0x0a2e 15:28:10 INFO - Revision ID: 0x0009 15:28:10 INFO - Displays: 15:28:10 INFO - Display: 15:28:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:28:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:28:10 INFO - Display Serial Number: 1600x1200 60 15:28:10 INFO - Main Display: Yes 15:28:10 INFO - Mirror: Off 15:28:10 INFO - Online: Yes 15:28:10 INFO - Rotation: Supported 15:28:10 INFO - Return code: 0 15:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:28:10 INFO - Python 2.7.3 15:28:10 INFO - Return code: 0 15:28:10 INFO - grabbing minidump binary from tooltool 15:28:10 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')]} 15:28:10 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 0x10ed3cd30>, '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 0x10eb60db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ed33b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:28:10 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 15:28:10 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 15:28:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:28:10 INFO - Return code: 0 15:28:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:28:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:28:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:28:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:28:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:28:11 INFO - Return code: 0 15:28:11 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/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--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 15:28:11 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/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0043 --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 15:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wlCVO6BVYb/Render', 15:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:11 INFO - 'HOME': '/Users/cltbld', 15:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:11 INFO - 'LOGNAME': 'cltbld', 15:28:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:28:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:11 INFO - 'MOZ_NO_REMOTE': '1', 15:28:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:28:11 INFO - 'NO_EM_RESTART': '1', 15:28:11 INFO - 'PAGER': '/bin/cat', 15:28:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:11 INFO - 'PWD': '/builds/slave/test', 15:28:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:11 INFO - 'SHELL': '/bin/bash', 15:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkOZhdIzKo/Listeners', 15:28:11 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 15:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:11 INFO - 'USER': 'cltbld', 15:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:11 INFO - 'XPC_FLAGS': '0x0', 15:28:11 INFO - 'XPC_SERVICE_NAME': '0', 15:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:11 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/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--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 15:28:12 INFO - mozversion application_buildid: 20160222142848 15:28:12 INFO - mozversion application_changeset: 061710a98fa4a8353f63076c34aa318565e59ec8 15:28:12 INFO - mozversion application_display_name: Nightly 15:28:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:28:12 INFO - mozversion application_name: Firefox 15:28:12 INFO - mozversion application_remotingname: firefox 15:28:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:28:12 INFO - mozversion application_vendor: Mozilla 15:28:12 INFO - mozversion application_version: 47.0a1 15:28:12 INFO - mozversion platform_buildid: 20160222142848 15:28:12 INFO - mozversion platform_changeset: 061710a98fa4a8353f63076c34aa318565e59ec8 15:28:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:28:12 INFO - mozversion platform_version: 47.0a1 15:28:12 INFO - using testdate: 1456183692 15:28:12 INFO - actual date: 1456183692 15:28:12 INFO - starting webserver on 'localhost:65165' 15:28:12 INFO - SUITE-START | Running 2 tests 15:28:12 INFO - TEST-START | dromaeo_css 15:28:12 INFO - operating with platform_type : mac_ 15:28:12 INFO - Initialising browser for dromaeo_css test... 15:28:12 INFO - TEST-INFO | started process 2554 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpKZFAmg/profile http://localhost:65165/getInfo.html) 15:28:14 INFO - PROCESS | 2554 | __metrics Screen width/height:1600/1200 15:28:14 INFO - PROCESS | 2554 | colorDepth:24 15:28:14 INFO - PROCESS | 2554 | Browser inner width/height: 1024/689 15:28:14 INFO - PROCESS | 2554 | __metrics 15:28:14 ERROR - PROCESS | 2554 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 15:28:15 INFO - TEST-INFO | 2554: exit 0 15:28:15 INFO - Browser initialized. 15:28:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:28:15 INFO - TEST-INFO | started process 2558 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpKZFAmg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:27 INFO - PROCESS | 2558 | RSS: Main: 255410176 15:28:27 INFO - PROCESS | 2558 | 15:29:17 INFO - PROCESS | 2558 | 1456183757335 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] 15:31:28 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:65165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:65165/tests/dromaeo/cssquery-ext.html) 15:31:30 INFO - PROCESS | 2558 | RSS: Main: 269586432 15:31:30 INFO - PROCESS | 2558 | 15:34:32 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:65165/tests/dromaeo/cssquery-ext.html (next: http://localhost:65165/tests/dromaeo/cssquery-jquery.html) 15:34:32 INFO - PROCESS | 2558 | RSS: Main: 281346048 15:34:32 INFO - PROCESS | 2558 | 15:37:34 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:65165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:65165/tests/dromaeo/cssquery-mootools.html) 15:37:35 INFO - PROCESS | 2558 | RSS: Main: 281919488 15:37:35 INFO - PROCESS | 2558 | 15:40:37 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:65165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:65165/tests/dromaeo/cssquery-prototype.html) 15:40:37 INFO - PROCESS | 2558 | RSS: Main: 283590656 15:40:37 INFO - PROCESS | 2558 | 15:43:40 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:65165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:65165/tests/dromaeo/cssquery-yui.html) 15:43:40 INFO - PROCESS | 2558 | RSS: Main: 287522816 15:43:40 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | Cycle 1(1): loaded http://localhost:65165/tests/dromaeo/cssquery-yui.html (next: http://localhost:65165/tests/dromaeo/cssquery-dojo.html) 15:46:43 INFO - PROCESS | 2558 | RSS: Main: 289251328 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | __start_tp_report 15:46:43 INFO - PROCESS | 2558 | _x_x_mozilla_page_load 15:46:43 INFO - PROCESS | 2558 | _x_x_mozilla_page_load_details 15:46:43 INFO - PROCESS | 2558 | |i|pagename|runs| 15:46:43 INFO - PROCESS | 2558 | |0;dojo.html;3487.128217945514;3494.8077855717925;3515.4726790981367;3551.20097977955;3556.2709644522865;5717.34250561185;5759.654420734759;5806.332271788746;5814.011618024935;5817.447342502455;5229.2156176573535;5632.042552766029;5743.10981797822;5809.186713860063;5876.147958546008;5119.897602047966;5128.256402821588;5184.2223666450145;5200.661956972804;5248.737563121847;5238.971964015749;5267.1045922193125;5292.206169074631;5298.4436634153435;5311.62818602698;3966.9289291891027;4597.517260687613;5148.227765835118;5196.376434827807;5203.531682148606;5164.896702065976;5175;5185.922211166836;5199.064168449678;5217.113090774577;5099.566536844372;5137.049645815536;5154.123798954187;5182.844514664566;5200.933808569234;4961.107000739866;5115.386153661547;5587.273654424939;5597.328320601513;5606.691631960241;6102.277183976801;6138.817583427401;6155.815325540241;6219.036049412348;6269.811905642838;6057.3336932937345;6189.6286222826775;6197.349278325801;6200.193974783295;6206.627602343829;5854.882902341929;5872.882542349172;5878.970605146947;5883.941160588425;5935.317438494585;6135.04893764628;6189.721462534197;6252.3122456529745;6267.059941008794;6282.937170628326;6165.722542485599;6181.81454556364;6185.783497577563;6188.504919606421;6248.656323902229;6091.9695401523595;6142.038385241494;6224.159738435344;6234.688265586702;6239.812805615838;6205.782797602063;6229.501639868799;6231.688415579293;6253.874922501524;6289.874202516015;6161.291451483047;6175.536834737323;6200.162977998003;6243.094751261042;6271.122042913996;4810.831620893252;4870.561649451566;4924.60603151747;4958.528939750718;4965.1807451770055;4395.912081758347;4404.867853964386;4414.84548040817;4456.509783923766;4470.575295347002;5470.53500452466;5861.501772349313;5863.384344643836;5886.323072846678;5887.970560147258;6176.197094377792;6216.316205217422;6231.158793562901;6251.843703907439;6259.593126446766;5818;5848.5321174305955;5852.385499522574;5864.06175011996;5893.5579831512805;5342.332208473941;5363.865903352369;5420.4850539198715;5437.646552974044;5511.448855114457;6198.876022479615;6298.338674439118;6328.398802113792;6332.271788744261;6336.778212762531;6176.567640265318;6196.132541444112;6201.751929922752;6204.658743769136;6222.719977601109;5272.736363181749;5818.563607729353;6096.950036952814;6369.522285828674;6384.361563843764;5599.132134519156;6158.384161583985;6162.22972128484;6184.536159788124;6189.597676151036;5555.749991250323;5732.4267573244015;6204.193454850841;6210.472109870531;6216.53375996793;5789.189513468202;6124.350421260821;6204.565680402328;6224.315325314303;6241.6879156041105;5957.225560677258;6129.693515324127;6131.509479241561;6151.323354431099;6164.4143806338325;4968.975155124202;5857.414258574108;5982.162497250475;6024.578279520391;6046.486048685735;5035.974820126023;6104.7926496150985;6131.6492349167875;6144.525313924537;6162.383761623802;5919.816036792573;5995.910061348996;6034.607750496204;6038.3357830637715;6051.4553690168095 15:46:43 INFO - PROCESS | 2558 | |1;ext.html;424.2681374628764;454.99999999999994;461.4485689600926;537.5081800152859;601.8164459839747;38509;39100.41349379761;39106.608933910655;39176;39215.21569568611;40349.39475907856;40616.39075413871;40685;40754.98112547188;40974.361025558945;9334.486603236819;9481.288903332277;9490.430574165537;9523.00008499108;9594.856077158849;7653.732119375823;9459.668911588096;9584.95207523965;9594.760130996747;9606.903930960705;9432.386894851812;9528.904710952906;9618.230541556659;9635.56639951204;9684.176844968186;9496.240300775922;9581.90418095817;9584.137427631511;9592.184664303542;9604.279679024066;9356.251499879992;9485.905140948571;9511.001344858829;9540.666076687283;9560.665376711851;37729.86810395665;38029.23941521154;38231;38271.61728382736;38459.615403845884;3169.9366012679616;3236.87052517899;3563.875264365735;3724.5344331958504;4040.8585699500377;27766.305842354104;29012.41975160506;29188.270293242625;29327.706722932926;29713.108606741833;2638.7625113739664;2721.5101281769275;2754.490419272441;2928.2093834664734;2945.8085224460556;507815;511314.9999999963;513633;514364;516432;44393.334099988526;44763.77618111954;44905.87735306643;61829.690851545456;62054.68972655108;35512.467312990324;37224.44163337552;39136.608633913864;42944.14111717748;43571.12857742827;14532.346044428026;15433.845661543466;15488.767668484981;15630.140342281056;15751.842481575266;12588.874111258954;12667.683307917376;12717.427715752814;12736.74526509483;12763.808542871864;12413.131080824436;13507.527236546674;13783.828374588073;14465.85534144666;14572.781408278885;4990.8253211137435;5925.911111333334;6393.520485963571;6396.648184349905;6408.51936104794;746.9701211951569;938.6949241496541;940.9858852117223;945.2060269373759;1021.8927012663712;24246.545207287618;26206;28013.859930700215;29585.816567337064;29687.85156074249;1063.9521221544894;1068.8129577323937;1092.5629748100664;1100.0869278498826;1201.825735268381;14090.929545352208;14323.498677546237;14697.338619762137;15774.211289435483;16551.6689666206;663155;672918;681556;682224;686718.2304973175;59757;59867;60326.69836650789;60710.4822379444;60759;1447.9565613031625;1466.218544468476;1484.747592909208;1491.5003473836387;1600.5838481994765;30332;30373.240668983453;30739.385212296078;30943.69056309498;31031.844840776554;41789.58210417857;49733;50290;50734.731631708026;50814.237786432495;425396;523306;525206;525555;526063;32643.510347345284;43024;43280.567194327654;44186.337204942596;44320.77839610782;41464.75605731833;42161.57838421576;42707.010509265296;42783.7860810694;43645.78177109221;36794.89615311545;37073.81463092775;37242;37631.811840941715;37850.43224351692;30345.544816827325;36946.8152659235;36980.26039479142;37139.44290835586;37306.44040339451;36567;37455.81272093622;37824;37835.81082094572;38393;30143.698563014088;31386.52920206153;32238.67761322357;32243.677563224068;32254.516182257754;19894.70157947603;24114.87942560346;24282.63576046396;24775.008999640533;24850.502989939738 15:46:43 INFO - PROCESS | 2558 | |2;jquery.html;343.3150864026268;368.95572531296233;374.4794735317907;374.51874341471216;380.6935416989322;15530.53408397747;19611.117499712513;19691.5077123072;19903;20399.898000510013;11745.236559623618;12155.392230388466;12166.27002379858;19273.325433609825;19507.122179501923;5246.422893481714;5414.3232095988005;5426.860359324546;5440.646357986719;5454.209139674745;4244.257254980382;5300.655457395276;5353.277307563488;5353.785848566053;5370.355557333126;5312.654677445973;5355.544778693816;5522.337319521663;5746.9712651436685;5769.16347129666;5633.014222511085;5669.007923613392;5674.3190817102;5723.713814309289;5964.373740757202;5635.915461268084;5643.407442218549;5644.153376993443;5662;5664.122061080539;13197;13301.201927884358;18982;24320.756792432203;24655.876720616463;2136.7115439415634;2138.0592539282666;2197.4726065744267;2211.7788221177916;2769.515334816419;9787.021297870227;10036.698899033041;12350.62948111558;13253.867461325457;14397.928010359987;1677.6057626457896;1749.5188823073756;1752.7283271093002;1819.6906525890631;1857.396346187481;106424.46787766012;106967.46516267446;109210;110408.4479577605;117369.41315293369;11019.559217631366;11284.774304514029;11411.48648310828;11424.257423267461;11440;12959.222446653232;13112.147710398793;13574.389152487964;13636.65908352299;13726.519571814939;6523;6599.1091202687985;8062;8605.225529702357;8641.697540586048;8754.693585724597;8812.471251724917;8817;8903.910960890438;8905.064968178249;3750.718696097749;4444.155610434072;4475.418195634612;4500.144972455223;4538.614217791524;1652.4629495413799;1877.54000269932;1932.6811076172555;1937.6415363157862;1986.2849374225268;806.6007326373366;829.9128591497927;833.7540425574471;999.1058003087196;1012.6607586458472;20455.8977205113;20930.581388372146;21060.05229764664;21227.78772212289;21518.892405538187;952.538019060755;969.1035791892472;969.8787651543557;979.4123525884555;1022.6931920423992;11173.888261117285;11313;11498.885011149949;11521.53913843437;11901.98833099179;241119;593444;594221;646401;655941.4405855975;76347;78126;78200.43599128099;122602;126866;932.1563984593953;984.158544444504;984.3601658921758;1039.9740006499746;1049.2707568240153;13277.070605057554;14984.325705343505;17836.554086147433;18314.542136446697;18463.16915738768;38517.80741096276;40900.79549602233;42280.88743335352;50547;50650.201234906795;73673.6316318415;74703;77550.6122469384;77871.61064194643;78506.6074669623;8026;8352.373571982003;8456.40805143634;8476.279516240942;8544.658213671384;7933.920660793318;13209.801852972405;13585.388657510239;13825.723485530434;14038.719225615634;10463.581456741646;10985.945070274598;11690.88309116898;11748.647540573797;11892.10809189297;11422.485988130387;11689.941550292195;11755.941220293844;11870.287782733063;11913.463894124958;10574.138791812282;11091.5563377464;11743.823842642538;11974.700632484257;11997.580084696994;8242.505449673039;8301.875471868048;8358.414910956419;8405.915940840514;8564.52895090751;9921.11937732635;11935;11950.282983021047;12047.518099276282;12047.578334758242 15:46:43 INFO - PROCESS | 2558 | |3;mootools.html;1561.6174037360847;1561.648629058462;1788.8658350623707;1883.1902282018734;1901.0399748127193;8040.396970227242;8655.523946182973;8824.117588241174;8893.733188004355;8982.416142950711;8654.350923680733;8680.392372533925;8758.781030474225;8768.473891566511;8795.516246606434;2118.6398312286947;2465.32203643998;2495;2495.700515938081;2499.912503062393;2467.2351571012955;2470.987645061781;2520.4707011527507;2520.6849143857016;2522.495500899818;2141.5395689926663;2414.4929564791414;2467.3584867934287;2476.0838489758817;2505.5865782145925;2418.3107814272935;2420.1287536486852;2447.669564608773;2452.7056753189554;2469.790067844235;2240.4286906838815;2410.6259432123697;2467.3091534370405;2471.036295844622;2472.9752702473106;8688.782780430476;8731.388802783807;8759.474431534129;8762.86855697165;8764.342674299389;5461.836144915659;5572.60991730579;5615.691136987464;5620.803271885506;5673.23411339468;3351.8659253629826;3756.267527832074;3767.2088861339153;3789.2042671039117;3802.448644946495;930.4882314726941;1059.6450189186633;1066.5627092891955;1101.7631209290041;1108.983365249522;11832.822507662391;11874.287542747463;11884.524619015228;11892.464839082262;11958.461869215906;4121.443605113332;4511.909761804745;4743.217369134123;4857.368542089505;4875.146849301429;9394.530273486298;9451.338406311492;9470.90529094714;9472.289578281656;9491.572879220452;5444.809431669952;5462.535684466865;5472.179173123984;5488.17677348401;5497.532709719719;4918.803247870045;5067.822626208065;5070.695758254443;5074.264231686385;5093.2105523643895;3736.308782875177;3738.738288319846;3743.981280093582;3777.8111094445167;3781.3382658034734;1116.4083035990939;1155.2779512804498;1158.9420528973517;1160.8548931383577;1162.1574358590124;929.8837645294338;990.5839547390113;1103.6964834670368;1128.8993231599125;1323.662466071165;7980.201979801974;8135.471194372347;8171.509709417335;8223.259906608433;8235.258826705625;633.7084940927133;644.3073695777058;653.545785678958;655.0894256982702;786.5123623353443;6203.596766210182;6223.906641400383;6266.717997690115;6307.4954003679595;6310.116583678288;9739.805203896025;10698.839517407245;10768.46157692128;11173.050290725218;11194.216404851744;10980.945095274472;11040.171987101;11120.388378639253;11127.499262533205;11133.888661113448;7292.270772922665;8093.312068474245;8408.285295749929;8487.830243395221;8629.611667475105;8043.115257321807;8051.476654017704;8075.5558444286125;8129.552874591955;8131.7560473185895;9541.379810312585;9628.71113866585;9893.455859927486;9939.204863611038;10008.549615267477;9426.764330891783;10154.984501549787;10161.237907157141;10208.285420020527;10249.9487502562;7070.823229419306;7128.144622645315;7129.2889706471115;7158.248383919614;7160.57036577807;8238.954573739888;8239.299659529008;8344.374171937008;8355.12271211514;8381.37139714536;6158.907616385668;6840.144981877265;7514.8872766909635;7640.847183056197;7704.961475192588;7212.386947109345;7321.816954576178;7324.450666199949;7400.296971787671;7427.517211381243;7675.846483070196;7714.997050383414;7741.148473668005;7755.991721076224;7765.92234077652;6895.55178913369;6914.481413894078;6943.201531823703;6992.1958974718555;7010.964945175241;7103.644817758988;7114.253003434772;7145.749898753519;7153.928460715326;7247.275272472711 15:46:43 INFO - PROCESS | 2558 | |4;prototype.html;328.86352163852;333.386568713567;334.403090483487;339.24517947566665;345.2594185472162;6056.969715151418;6805.047293378919;6884.552504087231;6916.550424222428;6929.792106236821;5071.644984851053;5566.443355664432;6803.217629972554;6925.92648139538;6931.306869313066;4193.51774545928;4952.826651067214;4999.800007999685;5049.2678561608545;5064.544191022807;4096.508418989711;5055.873603159932;5072.442031376546;5073.985202959404;5107.616928730342;5011.794810283482;5012.624053196007;5013.398392192942;5029.924551131736;5033.697978121306;4819.975900120512;4982.352294201767;5030.949690503085;5037.168867136918;5044.218146187329;4253.957460425387;4286.592773686495;4319.568043195687;4323.546027667113;4325.4593175853015;6594.439472644783;6601.900971485432;6631.275868274235;6646.202455705346;6649.833754156137;5966.522678185778;5981.461668449861;5984.551158663117;5999.040153575451;6004.8498787530225;7357.3746231570385;7402.518836275625;7405;7412.1476030256135;7425.183229844767;4694.57748802606;4712.034033023257;4848.127337079324;4851.296561998526;4859;5756.424357564252;6248.812725582125;7754.1470438251745;7806.4925779824125;7806.843863122705;4676.2985552166765;4926.261060840831;4935.161022626162;4937.5559098246595;4940.357753492023;5030.195168772979;5038.042771873405;5042.067217564689;5046.722430266297;5063.87340316495;5950.404959504015;5959;5970.731317090741;5974.984252677055;5978.671173085522;6509.511786615928;7075.186353569406;7346.375558077516;7456.142543607446;7480.401567874557;1440.5390275112072;1483.710676418088;1732.385003323827;1750;1753.6672129181914;1069.8341757027674;1138.2260063157132;1146.2320245435412;1155.9942200288945;1162.96511104667;6772.288909664414;6938.791836244921;6941.965290173618;6957.1215771741345;6979.755708550177;7804.024496937883;7820.648070836826;7835.451518393657;7846.764597062097;7861.606919653995;6904.930950690429;6913.1358580177475;6918.06606108179;6927.75752848658;6927.792166235021;3973.106051138471;4082.6529744971417;4126.938095928564;4135.069609337875;4167.270727622654;8083.949086618702;8172.182781721899;8196.508209507449;8199.303059240032;8232.547209903512;8069.798255043671;8083.019660183175;8099.838003239902;8119;8133.837323253501;8138.796530086677;8149.429539932148;8161.224683655162;8163.510189388656;8193.549354785544;7557.924420755722;7826.295633393022;7838.176991416048;7861.213878612093;7863.135055143815;7631.3513351365755;7674.386049116169;7692;7699.923000769921;7714.4599878008;8123.18768123183;8150.103488616366;8160.020797504338;8169.346452283922;8176;4068.3287257602165;4743.146233677971;4765.618750500021;4812.590929771009;4830.178869592248;7547.923921243232;7725.304722574995;7784.377249819888;7785.64964576584;7794.142644309008;7388.335049845325;7454.440916931143;7454.515456495311;7468.477206595486;7505;7446.367058799846;7471.6637751302405;7484.251574842472;7496.7376141834775;7503.9249607503225;6142.969285153546;6267.341929097562;7266.7093316266755;7285.417166626763;7288.526245794006;6300.369963003663;6621.172353455818;6873.381395674413;7329.9267007329245;7440.851182976418;6760.560563563353;7284.053073100463;7288.307610777179;7295.927040729524;7305.050343455317 15:46:43 INFO - PROCESS | 2558 | |5;yui.html;737.0712901743805;738.0810890441401;744.657457569518;744.843582847602;755.682613302413;14648.926755366221;14795;15022.549323520285;15023;15041.473548425794;12068.672446030929;13319.20084794913;15306.31121599528;15774.684506309866;15821.525354239391;705.6612825843598;869.6521391443425;876.6405773632812;881.6385282034367;884.5223579267188;864.511550973701;877.1404024056428;888.968886088987;892.5671049540967;897.0401670212875;919.8896132464114;938.7090002099337;938.9342746007782;942.3450701762278;942.9434233945951;919.0396036142214;931.7577429868215;932.6549176804592;932.799448118651;935.588341129904;676.7326905872153;688.9896651550231;689.162667359156;691.1257259566602;691.8270432391902;14850.925745371203;15025.173615451255;15061;15069.397224111022;15094.698106037818;12550.246985180918;12575.937120314431;12748.426320815586;12762.042846786528;13244.271565063918;10318;10502.369857808557;11384.037783702306;11415.714607134805;11463.31220126795;4035.313996620552;4044.1911617676287;4118.217538667644;4221.852235171785;4266.488021437447;80343;80833.59583202047;80950.59524702339;81037.56887293332;81400;9374;9513.429194248367;9514.238860891111;9543.809123817486;9627.855582166274;20189.49526261855;20398.57209995316;20412;20430.38708838737;20434.59130817405;6826.24911259761;7020.227774944752;7583.469157158946;7616.771496855104;7729.729459468892;3747.9505738393295;4042.4744783178;4118.073433477503;4177.895552611149;4201.705880588391;3539.8761043363875;3570.8036058016537;3615.1504396466808;3616.222512159898;3646.2707458508403;604.2688347100058;660.0561197487543;664.2560332427712;669.1167658690482;691.0636088100651;458.269060847947;523.2622002975786;559.4601209832531;619.9460916441976;620.7672122953892;8364.623591938378;8515.872261916076;8539.243466027334;8625.439346442461;8698.826023479622;499.9925001124986;585.8638015609808;601.2334273800851;604.9909251361233;632.9746810127543;3277.0332751838264;3966.9801650991562;4006.4991876015497;4043.030387233775;4045.662328578934;93661;93946;94063;94992;95112.52443737737;70544;71973.92039119417;84390;84529.88675283168;84571.57714211389;67641.66179169073;69775.65112174407;71934.64032679803;73124;73496.63251683814;8746.69386571467;8883.866741998745;8957.14907083826;9028.730480260907;9033.819323613623;40513;50292.99414011626;50964.23553646624;51283.487165129365;52766.68083297948;70183;70817.64591177012;71460;71787.28212717806;71923.92114118188;10018.048285413166;10921.718424446934;11045.944770276097;11135.220534562503;12121.393930303626;11845.822312665145;11883.524659013889;11976.089421995935;12522.37388130608;12789.744205116032;11658.12564057716;11682.746498105824;11774.293542387484;12014.085136604785;12198.573049943565;11739.589114380955;11953.22304050234;12003.195030834351;12048.277103373826;12244.632661020183;9686.51567421612;10626.628068017582;10973.615923442641;11457.770844583229;11962.401879906143;8623.137686231577;8659.826803464022;8740.257078148428;8803.163699448542;9507.334486585873;7871.645775939982;8284.258914150827;9348.298877584073;9848.852267215854;9983.750406239902 15:46:43 INFO - PROCESS | 2558 | __end_tp_report 15:46:43 INFO - PROCESS | 2558 | __start_cc_report 15:46:43 INFO - PROCESS | 2558 | _x_x_mozilla_cycle_collect,345 15:46:43 INFO - PROCESS | 2558 | __end_cc_report 15:46:43 INFO - PROCESS | 2558 | __startTimestamp1456184803388__endTimestamp 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | ------- Summary: start ------- 15:46:43 INFO - PROCESS | 2558 | Number of tests: 6 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | [#0] dojo.html Cycles:165 Average:5706.97 Median:5893.56 stddev:643.68 (10.9%) stddev-sans-first:621.65 15:46:43 INFO - PROCESS | 2558 | Values: 3487.1 3494.8 3515.5 3551.2 3556.3 5717.3 5759.7 5806.3 5814.0 5817.4 5229.2 5632.0 5743.1 5809.2 5876.1 5119.9 5128.3 5184.2 5200.7 5248.7 5239.0 5267.1 5292.2 5298.4 5311.6 3966.9 4597.5 5148.2 5196.4 5203.5 5164.9 5175.0 5185.9 5199.1 5217.1 5099.6 5137.0 5154.1 5182.8 5200.9 4961.1 5115.4 5587.3 5597.3 5606.7 6102.3 6138.8 6155.8 6219.0 6269.8 6057.3 6189.6 6197.3 6200.2 6206.6 5854.9 5872.9 5879.0 5883.9 5935.3 6135.0 6189.7 6252.3 6267.1 6282.9 6165.7 6181.8 6185.8 6188.5 6248.7 6092.0 6142.0 6224.2 6234.7 6239.8 6205.8 6229.5 6231.7 6253.9 6289.9 6161.3 6175.5 6200.2 6243.1 6271.1 4810.8 4870.6 4924.6 4958.5 4965.2 4395.9 4404.9 4414.8 4456.5 4470.6 5470.5 5861.5 5863.4 5886.3 5888.0 6176.2 6216.3 6231.2 6251.8 6259.6 5818.0 5848.5 5852.4 5864.1 5893.6 5342.3 5363.9 5420.5 5437.6 5511.4 6198.9 6298.3 6328.4 6332.3 6336.8 6176.6 6196.1 6201.8 6204.7 6222.7 5272.7 5818.6 6097.0 6369.5 6384.4 5599.1 6158.4 6162.2 6184.5 6189.6 5555.7 5732.4 6204.2 6210.5 6216.5 5789.2 6124.4 6204.6 6224.3 6241.7 5957.2 6129.7 6131.5 6151.3 6164.4 4969.0 5857.4 5982.2 6024.6 6046.5 5036.0 6104.8 6131.6 6144.5 6162.4 5919.8 5995.9 6034.6 6038.3 6051.5 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | [#1] ext.html Cycles:180 Average:68638.34 Median:39121.61 stddev:152892.77 (390.8%) stddev-sans-first:153235.89 15:46:43 INFO - PROCESS | 2558 | Values: 424.3 455.0 461.4 537.5 601.8 38509.0 39100.4 39106.6 39176.0 39215.2 40349.4 40616.4 40685.0 40755.0 40974.4 9334.5 9481.3 9490.4 9523.0 9594.9 7653.7 9459.7 9585.0 9594.8 9606.9 9432.4 9528.9 9618.2 9635.6 9684.2 9496.2 9581.9 9584.1 9592.2 9604.3 9356.3 9485.9 9511.0 9540.7 9560.7 37729.9 38029.2 38231.0 38271.6 38459.6 3169.9 3236.9 3563.9 3724.5 4040.9 27766.3 29012.4 29188.3 29327.7 29713.1 2638.8 2721.5 2754.5 2928.2 2945.8 507815.0 511315.0 513633.0 514364.0 516432.0 44393.3 44763.8 44905.9 61829.7 62054.7 35512.5 37224.4 39136.6 42944.1 43571.1 14532.3 15433.8 15488.8 15630.1 15751.8 12588.9 12667.7 12717.4 12736.7 12763.8 12413.1 13507.5 13783.8 14465.9 14572.8 4990.8 5925.9 6393.5 6396.6 6408.5 747.0 938.7 941.0 945.2 1021.9 24246.5 26206.0 28013.9 29585.8 29687.9 1064.0 1068.8 1092.6 1100.1 1201.8 14090.9 14323.5 14697.3 15774.2 16551.7 663155.0 672918.0 681556.0 682224.0 686718.2 59757.0 59867.0 60326.7 60710.5 60759.0 1448.0 1466.2 1484.7 1491.5 1600.6 30332.0 30373.2 30739.4 30943.7 31031.8 41789.6 49733.0 50290.0 50734.7 50814.2 425396.0 523306.0 525206.0 525555.0 526063.0 32643.5 43024.0 43280.6 44186.3 44320.8 41464.8 42161.6 42707.0 42783.8 43645.8 36794.9 37073.8 37242.0 37631.8 37850.4 30345.5 36946.8 36980.3 37139.4 37306.4 36567.0 37455.8 37824.0 37835.8 38393.0 30143.7 31386.5 32238.7 32243.7 32254.5 19894.7 24114.9 24282.6 24775.0 24850.5 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | [#2] jquery.html Cycles:180 Average:31814.92 Median:132719.88 stddev:94417.30 (71.1%) stddev-sans-first:94652.59 15:46:43 INFO - PROCESS | 2558 | Values: 343.3 369.0 374.5 374.5 380.7 15530.5 19611.1 19691.5 19903.0 20399.9 11745.2 12155.4 12166.3 19273.3 19507.1 5246.4 5414.3 5426.9 5440.6 5454.2 4244.3 5300.7 5353.3 5353.8 5370.4 5312.7 5355.5 5522.3 5747.0 5769.2 5633.0 5669.0 5674.3 5723.7 5964.4 5635.9 5643.4 5644.2 5662.0 5664.1 13197.0 13301.2 18982.0 24320.8 24655.9 2136.7 2138.1 2197.5 2211.8 2769.5 9787.0 10036.7 12350.6 13253.9 14397.9 1677.6 1749.5 1752.7 1819.7 1857.4 106424.5 106967.5 109210.0 110408.4 117369.4 11019.6 11284.8 11411.5 11424.3 11440.0 12959.2 13112.1 13574.4 13636.7 13726.5 6523.0 6599.1 8062.0 8605.2 8641.7 8754.7 8812.5 8817.0 8903.9 8905.1 3750.7 4444.2 4475.4 4500.1 4538.6 1652.5 1877.5 1932.7 1937.6 1986.3 806.6 829.9 833.8 999.1 1012.7 20455.9 20930.6 21060.1 21227.8 21518.9 952.5 969.1 969.9 979.4 1022.7 11173.9 11313.0 11498.9 11521.5 11902.0 241119.0 593444.0 594221.0 646401.0 655941.4 76347.0 78126.0 78200.4 122602.0 126866.0 932.2 984.2 984.4 1040.0 1049.3 13277.1 14984.3 17836.6 18314.5 18463.2 38517.8 40900.8 42280.9 50547.0 50650.2 73673.6 74703.0 77550.6 77871.6 78506.6 8026.0 8352.4 8456.4 8476.3 8544.7 7933.9 13209.8 13585.4 13825.7 14038.7 10463.6 10985.9 11690.9 11748.6 11892.1 11422.5 11689.9 11755.9 11870.3 11913.5 10574.1 11091.6 11743.8 11974.7 11997.6 8242.5 8301.9 8358.4 8405.9 8564.5 9921.1 11935.0 11950.3 12047.5 12047.6 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | [#3] mootools.html Cycles:180 Average:6046.17 Median:5916.07 stddev:3229.76 (54.6%) stddev-sans-first:3221.23 15:46:43 INFO - PROCESS | 2558 | Values: 1561.6 1561.6 1788.9 1883.2 1901.0 8040.4 8655.5 8824.1 8893.7 8982.4 8654.4 8680.4 8758.8 8768.5 8795.5 2118.6 2465.3 2495.0 2495.7 2499.9 2467.2 2471.0 2520.5 2520.7 2522.5 2141.5 2414.5 2467.4 2476.1 2505.6 2418.3 2420.1 2447.7 2452.7 2469.8 2240.4 2410.6 2467.3 2471.0 2473.0 8688.8 8731.4 8759.5 8762.9 8764.3 5461.8 5572.6 5615.7 5620.8 5673.2 3351.9 3756.3 3767.2 3789.2 3802.4 930.5 1059.6 1066.6 1101.8 1109.0 11832.8 11874.3 11884.5 11892.5 11958.5 4121.4 4511.9 4743.2 4857.4 4875.1 9394.5 9451.3 9470.9 9472.3 9491.6 5444.8 5462.5 5472.2 5488.2 5497.5 4918.8 5067.8 5070.7 5074.3 5093.2 3736.3 3738.7 3744.0 3777.8 3781.3 1116.4 1155.3 1158.9 1160.9 1162.2 929.9 990.6 1103.7 1128.9 1323.7 7980.2 8135.5 8171.5 8223.3 8235.3 633.7 644.3 653.5 655.1 786.5 6203.6 6223.9 6266.7 6307.5 6310.1 9739.8 10698.8 10768.5 11173.1 11194.2 10980.9 11040.2 11120.4 11127.5 11133.9 7292.3 8093.3 8408.3 8487.8 8629.6 8043.1 8051.5 8075.6 8129.6 8131.8 9541.4 9628.7 9893.5 9939.2 10008.5 9426.8 10155.0 10161.2 10208.3 10249.9 7070.8 7128.1 7129.3 7158.2 7160.6 8239.0 8239.3 8344.4 8355.1 8381.4 6158.9 6840.1 7514.9 7640.8 7705.0 7212.4 7321.8 7324.5 7400.3 7427.5 7675.8 7715.0 7741.1 7756.0 7765.9 6895.6 6914.5 6943.2 6992.2 7011.0 7103.6 7114.3 7145.7 7153.9 7247.3 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | [#4] prototype.html Cycles:180 Average:6032.15 Median:6766.42 stddev:1971.76 (29.1%) stddev-sans-first:1930.26 15:46:43 INFO - PROCESS | 2558 | Values: 328.9 333.4 334.4 339.2 345.3 6057.0 6805.0 6884.6 6916.6 6929.8 5071.6 5566.4 6803.2 6925.9 6931.3 4193.5 4952.8 4999.8 5049.3 5064.5 4096.5 5055.9 5072.4 5074.0 5107.6 5011.8 5012.6 5013.4 5029.9 5033.7 4820.0 4982.4 5030.9 5037.2 5044.2 4254.0 4286.6 4319.6 4323.5 4325.5 6594.4 6601.9 6631.3 6646.2 6649.8 5966.5 5981.5 5984.6 5999.0 6004.8 7357.4 7402.5 7405.0 7412.1 7425.2 4694.6 4712.0 4848.1 4851.3 4859.0 5756.4 6248.8 7754.1 7806.5 7806.8 4676.3 4926.3 4935.2 4937.6 4940.4 5030.2 5038.0 5042.1 5046.7 5063.9 5950.4 5959.0 5970.7 5975.0 5978.7 6509.5 7075.2 7346.4 7456.1 7480.4 1440.5 1483.7 1732.4 1750.0 1753.7 1069.8 1138.2 1146.2 1156.0 1163.0 6772.3 6938.8 6942.0 6957.1 6979.8 7804.0 7820.6 7835.5 7846.8 7861.6 6904.9 6913.1 6918.1 6927.8 6927.8 3973.1 4082.7 4126.9 4135.1 4167.3 8083.9 8172.2 8196.5 8199.3 8232.5 8069.8 8083.0 8099.8 8119.0 8133.8 8138.8 8149.4 8161.2 8163.5 8193.5 7557.9 7826.3 7838.2 7861.2 7863.1 7631.4 7674.4 7692.0 7699.9 7714.5 8123.2 8150.1 8160.0 8169.3 8176.0 4068.3 4743.1 4765.6 4812.6 4830.2 7547.9 7725.3 7784.4 7785.6 7794.1 7388.3 7454.4 7454.5 7468.5 7505.0 7446.4 7471.7 7484.3 7496.7 7503.9 6143.0 6267.3 7266.7 7285.4 7288.5 6300.4 6621.2 6873.4 7329.9 7440.9 6760.6 7284.1 7288.3 7295.9 7305.1 15:46:43 INFO - PROCESS | 2558 | 15:46:43 INFO - PROCESS | 2558 | [#5] yui.html Cycles:180 Average:18539.96 Median:662.16 stddev:26180.47 (3953.8%) stddev-sans-first:26219.79 15:46:43 INFO - PROCESS | 2558 | Values: 737.1 738.1 744.7 744.8 755.7 14648.9 14795.0 15022.5 15023.0 15041.5 12068.7 13319.2 15306.3 15774.7 15821.5 705.7 869.7 876.6 881.6 884.5 864.5 877.1 889.0 892.6 897.0 919.9 938.7 938.9 942.3 942.9 919.0 931.8 932.7 932.8 935.6 676.7 689.0 689.2 691.1 691.8 14850.9 15025.2 15061.0 15069.4 15094.7 12550.2 12575.9 12748.4 12762.0 13244.3 10318.0 10502.4 11384.0 11415.7 11463.3 4035.3 4044.2 4118.2 4221.9 4266.5 80343.0 80833.6 80950.6 81037.6 81400.0 9374.0 9513.4 9514.2 9543.8 9627.9 20189.5 20398.6 20412.0 20430.4 20434.6 6826.2 7020.2 7583.5 7616.8 7729.7 3748.0 4042.5 4118.1 4177.9 4201.7 3539.9 3570.8 3615.2 3616.2 3646.3 604.3 660.1 664.3 669.1 691.1 458.3 523.3 559.5 619.9 620.8 8364.6 8515.9 8539.2 8625.4 8698.8 500.0 585.9 601.2 605.0 633.0 3277.0 3967.0 4006.5 4043.0 4045.7 93661.0 93946.0 94063.0 94992.0 95112.5 70544.0 71973.9 84390.0 84529.9 84571.6 67641.7 69775.7 71934.6 73124.0 73496.6 8746.7 8883.9 8957.1 9028.7 9033.8 40513.0 50293.0 50964.2 51283.5 52766.7 70183.0 70817.6 71460.0 71787.3 71923.9 10018.0 10921.7 11045.9 11135.2 12121.4 11845.8 11883.5 11976.1 12522.4 12789.7 11658.1 11682.7 11774.3 12014.1 12198.6 11739.6 11953.2 12003.2 12048.3 12244.6 9686.5 10626.6 10973.6 11457.8 11962.4 8623.1 8659.8 8740.3 8803.2 9507.3 7871.6 8284.3 9348.3 9848.9 9983.8 15:46:43 INFO - PROCESS | 2558 | -------- Summary: end -------- 15:46:43 INFO - PROCESS | 2558 | 15:46:44 INFO - TEST-INFO | 2558: exit 0 15:46:44 INFO - TEST-OK | dromaeo_css | took 1111931ms 15:46:44 INFO - TEST-START | kraken 15:46:44 INFO - operating with platform_type : mac_ 15:46:44 INFO - Initialising browser for kraken test... 15:46:44 INFO - TEST-INFO | started process 2563 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpPeCs33/profile http://localhost:65165/getInfo.html) 15:46:46 INFO - PROCESS | 2563 | __metrics Screen width/height:1600/1200 15:46:46 INFO - PROCESS | 2563 | colorDepth:24 15:46:46 INFO - PROCESS | 2563 | Browser inner width/height: 1024/689 15:46:46 INFO - PROCESS | 2563 | __metrics 15:46:46 ERROR - PROCESS | 2563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 15:46:47 INFO - TEST-INFO | 2563: exit 0 15:46:47 INFO - Browser initialized. 15:46:47 INFO - Running cycle 1/1 for kraken test... 15:46:47 INFO - TEST-INFO | started process 2566 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpPeCs33/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:59 INFO - PROCESS | 2566 | RSS: Main: 255381504 15:46:59 INFO - PROCESS | 2566 | 15:47:01 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:65165/tests/kraken/driver.html?testName=audio-beat-detection) 15:47:02 INFO - PROCESS | 2566 | RSS: Main: 267272192 15:47:02 INFO - PROCESS | 2566 | 15:47:05 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:65165/tests/kraken/driver.html?testName=audio-dft) 15:47:05 INFO - PROCESS | 2566 | RSS: Main: 277991424 15:47:05 INFO - PROCESS | 2566 | 15:47:09 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:65165/tests/kraken/driver.html?testName=audio-fft) 15:47:09 INFO - PROCESS | 2566 | RSS: Main: 280281088 15:47:09 INFO - PROCESS | 2566 | 15:47:11 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:65165/tests/kraken/driver.html?testName=audio-oscillator) 15:47:12 INFO - PROCESS | 2566 | RSS: Main: 282804224 15:47:12 INFO - PROCESS | 2566 | 15:47:14 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:65165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:47:15 INFO - PROCESS | 2566 | RSS: Main: 282234880 15:47:15 INFO - PROCESS | 2566 | 15:47:18 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:65165/tests/kraken/driver.html?testName=imaging-darkroom) 15:47:18 INFO - PROCESS | 2566 | RSS: Main: 282517504 15:47:18 INFO - PROCESS | 2566 | 15:47:21 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:65165/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:22 INFO - PROCESS | 2566 | RSS: Main: 282419200 15:47:22 INFO - PROCESS | 2566 | 15:47:25 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:65165/tests/kraken/driver.html?testName=json-parse-financial) 15:47:25 INFO - PROCESS | 2566 | RSS: Main: 283160576 15:47:25 INFO - PROCESS | 2566 | 15:47:27 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:65165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:27 INFO - PROCESS | 2566 | RSS: Main: 282857472 15:47:27 INFO - PROCESS | 2566 | 15:47:29 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:30 INFO - PROCESS | 2566 | RSS: Main: 284037120 15:47:30 INFO - PROCESS | 2566 | 15:47:32 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:33 INFO - PROCESS | 2566 | RSS: Main: 283815936 15:47:33 INFO - PROCESS | 2566 | 15:47:35 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:36 INFO - PROCESS | 2566 | RSS: Main: 283754496 15:47:36 INFO - PROCESS | 2566 | 15:47:38 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:39 INFO - PROCESS | 2566 | RSS: Main: 283947008 15:47:39 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:65165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:65165/tests/kraken/driver.html?testName=ai-astar) 15:47:41 INFO - PROCESS | 2566 | RSS: Main: 285425664 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | __start_tp_report 15:47:41 INFO - PROCESS | 2566 | _x_x_mozilla_page_load 15:47:41 INFO - PROCESS | 2566 | _x_x_mozilla_page_load_details 15:47:41 INFO - PROCESS | 2566 | |i|pagename|runs| 15:47:41 INFO - PROCESS | 2566 | |0;ai-astar;117;111;116;115;115;126;120;114;114;113 15:47:41 INFO - PROCESS | 2566 | |1;audio-beat-detection;155;129;181;182;118;146;138;126;160;126 15:47:41 INFO - PROCESS | 2566 | |2;audio-dft;201;197;199;201;208;216;206;198;234;285 15:47:41 INFO - PROCESS | 2566 | |3;audio-fft;79;107;103;111;70;79;81;59;128;52 15:47:41 INFO - PROCESS | 2566 | |4;audio-oscillator;82;81;116;82;82;82;117;80;79;116 15:47:41 INFO - PROCESS | 2566 | |5;imaging-gaussian-blur;86;94;76;88;133;113;86;109;132;93 15:47:41 INFO - PROCESS | 2566 | |6;imaging-darkroom;95;96;116;95;96;96;95;96;95;104 15:47:41 INFO - PROCESS | 2566 | |7;imaging-desaturate;94;93;90;88;86;142;82;148;146;106 15:47:41 INFO - PROCESS | 2566 | |8;json-parse-financial;56;58;58;55;57;55;57;66;54;58 15:47:41 INFO - PROCESS | 2566 | |9;json-stringify-tinderbox;64;68;64;73;75;70;66;66;67;71 15:47:41 INFO - PROCESS | 2566 | |10;stanford-crypto-aes;88;85;85;86;85;114;111;111;87;84 15:47:41 INFO - PROCESS | 2566 | |11;stanford-crypto-ccm;119;144;119;136;133;128;141;127;128;126 15:47:41 INFO - PROCESS | 2566 | |12;stanford-crypto-pbkdf2;131;145;143;149;169;182;178;143;148;146 15:47:41 INFO - PROCESS | 2566 | |13;stanford-crypto-sha256-iterative;68;68;73;79;104;77;67;69;68;93 15:47:41 INFO - PROCESS | 2566 | __end_tp_report 15:47:41 INFO - PROCESS | 2566 | __start_cc_report 15:47:41 INFO - PROCESS | 2566 | _x_x_mozilla_cycle_collect,900 15:47:41 INFO - PROCESS | 2566 | __end_cc_report 15:47:41 INFO - PROCESS | 2566 | __startTimestamp1456184861493__endTimestamp 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | ------- Summary: start ------- 15:47:41 INFO - PROCESS | 2566 | Number of tests: 14 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#0] ai-astar Cycles:10 Average:116.10 Median:115.50 stddev:4.23 (3.7%) stddev-sans-first:4.47 15:47:41 INFO - PROCESS | 2566 | Values: 117.0 111.0 116.0 115.0 115.0 126.0 120.0 114.0 114.0 113.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:150.50 stddev:22.94 (15.2%) stddev-sans-first:24.10 15:47:41 INFO - PROCESS | 2566 | Values: 155.0 129.0 181.0 182.0 118.0 146.0 138.0 126.0 160.0 126.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#2] audio-dft Cycles:10 Average:214.50 Median:207.00 stddev:27.18 (13.1%) stddev-sans-first:28.39 15:47:41 INFO - PROCESS | 2566 | Values: 201.0 197.0 199.0 201.0 208.0 216.0 206.0 198.0 234.0 285.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#3] audio-fft Cycles:10 Average:86.90 Median:64.50 stddev:24.44 (37.9%) stddev-sans-first:25.75 15:47:41 INFO - PROCESS | 2566 | Values: 79.0 107.0 103.0 111.0 70.0 79.0 81.0 59.0 128.0 52.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:81.50 stddev:17.03 (20.9%) stddev-sans-first:17.70 15:47:41 INFO - PROCESS | 2566 | Values: 82.0 81.0 116.0 82.0 82.0 82.0 117.0 80.0 79.0 116.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:86.00 stddev:19.86 (23.1%) stddev-sans-first:20.31 15:47:41 INFO - PROCESS | 2566 | Values: 86.0 94.0 76.0 88.0 133.0 113.0 86.0 109.0 132.0 93.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:95.50 stddev:6.75 (7.1%) stddev-sans-first:7.05 15:47:41 INFO - PROCESS | 2566 | Values: 95.0 96.0 116.0 95.0 96.0 96.0 95.0 96.0 95.0 104.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#7] imaging-desaturate Cycles:10 Average:107.50 Median:87.00 stddev:26.89 (30.9%) stddev-sans-first:28.07 15:47:41 INFO - PROCESS | 2566 | Values: 94.0 93.0 90.0 88.0 86.0 142.0 82.0 148.0 146.0 106.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:3.34 (5.8%) stddev-sans-first:3.50 15:47:41 INFO - PROCESS | 2566 | Values: 56.0 58.0 58.0 55.0 57.0 55.0 57.0 66.0 54.0 58.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:3.75 (5.4%) stddev-sans-first:3.62 15:47:41 INFO - PROCESS | 2566 | Values: 64.0 68.0 64.0 73.0 75.0 70.0 66.0 66.0 67.0 71.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:85.00 stddev:12.77 (15.0%) stddev-sans-first:13.39 15:47:41 INFO - PROCESS | 2566 | Values: 88.0 85.0 85.0 86.0 85.0 114.0 111.0 111.0 87.0 84.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:130.50 stddev:8.41 (6.4%) stddev-sans-first:7.91 15:47:41 INFO - PROCESS | 2566 | Values: 119.0 144.0 119.0 136.0 133.0 128.0 141.0 127.0 128.0 126.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:148.50 stddev:16.86 (11.4%) stddev-sans-first:15.81 15:47:41 INFO - PROCESS | 2566 | Values: 131.0 145.0 143.0 149.0 169.0 182.0 178.0 143.0 148.0 146.0 15:47:41 INFO - PROCESS | 2566 | 15:47:41 INFO - PROCESS | 2566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:71.00 stddev:12.52 (17.6%) stddev-sans-first:12.89 15:47:41 INFO - PROCESS | 2566 | Values: 68.0 68.0 73.0 79.0 104.0 77.0 67.0 69.0 68.0 93.0 15:47:41 INFO - PROCESS | 2566 | -------- Summary: end -------- 15:47:41 INFO - PROCESS | 2566 | 15:47:42 INFO - TEST-INFO | 2566: exit 0 15:47:42 INFO - TEST-OK | kraken | took 58225ms 15:47:42 INFO - SUITE-END | took 1170s 15:47:42 INFO - Completed test suite (00:19:30) 15:47:42 INFO - Working with test: dromaeo_css 15:47:42 INFO - Generating results file: dromaeo_css 15:47:42 INFO - Working with test: kraken 15:47:42 INFO - Generating results file: kraken 15:47:42 INFO - javascript benchmark 15:47:42 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:47:43 INFO - process_Request line: dromaeo_css 7515.18 graph.html#tests=[[72,64,61]] 15:47:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:43 INFO - process_Request line: kraken 1541.70 graph.html#tests=[[232,64,61]] 15:47:43 INFO - RETURN: dromaeo_css: 7515.18 15:47:43 INFO - RETURN: kraken: 1541.70 15:47:43 INFO - javascript benchmark 15:47:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3487.128217945514, 3494.8077855717925, 3515.4726790981367, 3551.20097977955, 3556.2709644522865, 5717.34250561185, 5759.654420734759, 5806.332271788746, 5814.011618024935, 5817.447342502455, 5229.2156176573535, 5632.042552766029, 5743.10981797822, 5809.186713860063, 5876.147958546008, 5119.897602047966, 5128.256402821588, 5184.2223666450145, 5200.661956972804, 5248.737563121847, 5238.971964015749, 5267.1045922193125, 5292.206169074631, 5298.4436634153435, 5311.62818602698, 3966.9289291891027, 4597.517260687613, 5148.227765835118, 5196.376434827807, 5203.531682148606, 5164.896702065976, 5175.0, 5185.922211166836, 5199.064168449678, 5217.113090774577, 5099.566536844372, 5137.049645815536, 5154.123798954187, 5182.844514664566, 5200.933808569234, 4961.107000739866, 5115.386153661547, 5587.273654424939, 5597.328320601513, 5606.691631960241, 6102.277183976801, 6138.817583427401, 6155.815325540241, 6219.036049412348, 6269.811905642838, 6057.3336932937345, 6189.6286222826775, 6197.349278325801, 6200.193974783295, 6206.627602343829, 5854.882902341929, 5872.882542349172, 5878.970605146947, 5883.941160588425, 5935.317438494585, 6135.04893764628, 6189.721462534197, 6252.3122456529745, 6267.059941008794, 6282.937170628326, 6165.722542485599, 6181.81454556364, 6185.783497577563, 6188.504919606421, 6248.656323902229, 6091.9695401523595, 6142.038385241494, 6224.159738435344, 6234.688265586702, 6239.812805615838, 6205.782797602063, 6229.501639868799, 6231.688415579293, 6253.874922501524, 6289.874202516015, 6161.291451483047, 6175.536834737323, 6200.162977998003, 6243.094751261042, 6271.122042913996, 4810.831620893252, 4870.561649451566, 4924.60603151747, 4958.528939750718, 4965.1807451770055, 4395.912081758347, 4404.867853964386, 4414.84548040817, 4456.509783923766, 4470.575295347002, 5470.53500452466, 5861.501772349313, 5863.384344643836, 5886.323072846678, 5887.970560147258, 6176.197094377792, 6216.316205217422, 6231.158793562901, 6251.843703907439, 6259.593126446766, 5818.0, 5848.5321174305955, 5852.385499522574, 5864.06175011996, 5893.5579831512805, 5342.332208473941, 5363.865903352369, 5420.4850539198715, 5437.646552974044, 5511.448855114457, 6198.876022479615, 6298.338674439118, 6328.398802113792, 6332.271788744261, 6336.778212762531, 6176.567640265318, 6196.132541444112, 6201.751929922752, 6204.658743769136, 6222.719977601109, 5272.736363181749, 5818.563607729353, 6096.950036952814, 6369.522285828674, 6384.361563843764, 5599.132134519156, 6158.384161583985, 6162.22972128484, 6184.536159788124, 6189.597676151036, 5555.749991250323, 5732.4267573244015, 6204.193454850841, 6210.472109870531, 6216.53375996793, 5789.189513468202, 6124.350421260821, 6204.565680402328, 6224.315325314303, 6241.6879156041105, 5957.225560677258, 6129.693515324127, 6131.509479241561, 6151.323354431099, 6164.4143806338325, 4968.975155124202, 5857.414258574108, 5982.162497250475, 6024.578279520391, 6046.486048685735, 5035.974820126023, 6104.7926496150985, 6131.6492349167875, 6144.525313924537, 6162.383761623802, 5919.816036792573, 5995.910061348996, 6034.607750496204, 6038.3357830637715, 6051.4553690168095], "unit": "score", "name": "dojo.html", "value": 5668.496253416736}, {"lowerIsBetter": false, "replicates": [424.2681374628764, 454.99999999999994, 461.4485689600926, 537.5081800152859, 601.8164459839747, 38509.0, 39100.41349379761, 39106.608933910655, 39176.0, 39215.21569568611, 40349.39475907856, 40616.39075413871, 40685.0, 40754.98112547188, 40974.361025558945, 9334.486603236819, 9481.288903332277, 9490.430574165537, 9523.00008499108, 9594.856077158849, 7653.732119375823, 9459.668911588096, 9584.95207523965, 9594.760130996747, 9606.903930960705, 9432.386894851812, 9528.904710952906, 9618.230541556659, 9635.56639951204, 9684.176844968186, 9496.240300775922, 9581.90418095817, 9584.137427631511, 9592.184664303542, 9604.279679024066, 9356.251499879992, 9485.905140948571, 9511.001344858829, 9540.666076687283, 9560.665376711851, 37729.86810395665, 38029.23941521154, 38231.0, 38271.61728382736, 38459.615403845884, 3169.9366012679616, 3236.87052517899, 3563.875264365735, 3724.5344331958504, 4040.8585699500377, 27766.305842354104, 29012.41975160506, 29188.270293242625, 29327.706722932926, 29713.108606741833, 2638.7625113739664, 2721.5101281769275, 2754.490419272441, 2928.2093834664734, 2945.8085224460556, 507815.0, 511314.9999999963, 513633.0, 514364.0, 516432.0, 44393.334099988526, 44763.77618111954, 44905.87735306643, 61829.690851545456, 62054.68972655108, 35512.467312990324, 37224.44163337552, 39136.608633913864, 42944.14111717748, 43571.12857742827, 14532.346044428026, 15433.845661543466, 15488.767668484981, 15630.140342281056, 15751.842481575266, 12588.874111258954, 12667.683307917376, 12717.427715752814, 12736.74526509483, 12763.808542871864, 12413.131080824436, 13507.527236546674, 13783.828374588073, 14465.85534144666, 14572.781408278885, 4990.8253211137435, 5925.911111333334, 6393.520485963571, 6396.648184349905, 6408.51936104794, 746.9701211951569, 938.6949241496541, 940.9858852117223, 945.2060269373759, 1021.8927012663712, 24246.545207287618, 26206.0, 28013.859930700215, 29585.816567337064, 29687.85156074249, 1063.9521221544894, 1068.8129577323937, 1092.5629748100664, 1100.0869278498826, 1201.825735268381, 14090.929545352208, 14323.498677546237, 14697.338619762137, 15774.211289435483, 16551.6689666206, 663155.0, 672918.0, 681556.0, 682224.0, 686718.2304973175, 59757.0, 59867.0, 60326.69836650789, 60710.4822379444, 60759.0, 1447.9565613031625, 1466.218544468476, 1484.747592909208, 1491.5003473836387, 1600.5838481994765, 30332.0, 30373.240668983453, 30739.385212296078, 30943.69056309498, 31031.844840776554, 41789.58210417857, 49733.0, 50290.0, 50734.731631708026, 50814.237786432495, 425396.0, 523306.0, 525206.0, 525555.0, 526063.0, 32643.510347345284, 43024.0, 43280.567194327654, 44186.337204942596, 44320.77839610782, 41464.75605731833, 42161.57838421576, 42707.010509265296, 42783.7860810694, 43645.78177109221, 36794.89615311545, 37073.81463092775, 37242.0, 37631.811840941715, 37850.43224351692, 30345.544816827325, 36946.8152659235, 36980.26039479142, 37139.44290835586, 37306.44040339451, 36567.0, 37455.81272093622, 37824.0, 37835.81082094572, 38393.0, 30143.698563014088, 31386.52920206153, 32238.67761322357, 32243.677563224068, 32254.516182257754, 19894.70157947603, 24114.87942560346, 24282.63576046396, 24775.008999640533, 24850.502989939738], "unit": "score", "name": "ext.html", "value": 19149.413253838735}, {"lowerIsBetter": false, "replicates": [343.3150864026268, 368.95572531296233, 374.4794735317907, 374.51874341471216, 380.6935416989322, 15530.53408397747, 19611.117499712513, 19691.5077123072, 19903.0, 20399.898000510013, 11745.236559623618, 12155.392230388466, 12166.27002379858, 19273.325433609825, 19507.122179501923, 5246.422893481714, 5414.3232095988005, 5426.860359324546, 5440.646357986719, 5454.209139674745, 4244.257254980382, 5300.655457395276, 5353.277307563488, 5353.785848566053, 5370.355557333126, 5312.654677445973, 5355.544778693816, 5522.337319521663, 5746.9712651436685, 5769.16347129666, 5633.014222511085, 5669.007923613392, 5674.3190817102, 5723.713814309289, 5964.373740757202, 5635.915461268084, 5643.407442218549, 5644.153376993443, 5662.0, 5664.122061080539, 13197.0, 13301.201927884358, 18982.0, 24320.756792432203, 24655.876720616463, 2136.7115439415634, 2138.0592539282666, 2197.4726065744267, 2211.7788221177916, 2769.515334816419, 9787.021297870227, 10036.698899033041, 12350.62948111558, 13253.867461325457, 14397.928010359987, 1677.6057626457896, 1749.5188823073756, 1752.7283271093002, 1819.6906525890631, 1857.396346187481, 106424.46787766012, 106967.46516267446, 109210.0, 110408.4479577605, 117369.41315293369, 11019.559217631366, 11284.774304514029, 11411.48648310828, 11424.257423267461, 11440.0, 12959.222446653232, 13112.147710398793, 13574.389152487964, 13636.65908352299, 13726.519571814939, 6523.0, 6599.1091202687985, 8062.0, 8605.225529702357, 8641.697540586048, 8754.693585724597, 8812.471251724917, 8817.0, 8903.910960890438, 8905.064968178249, 3750.718696097749, 4444.155610434072, 4475.418195634612, 4500.144972455223, 4538.614217791524, 1652.4629495413799, 1877.54000269932, 1932.6811076172555, 1937.6415363157862, 1986.2849374225268, 806.6007326373366, 829.9128591497927, 833.7540425574471, 999.1058003087196, 1012.6607586458472, 20455.8977205113, 20930.581388372146, 21060.05229764664, 21227.78772212289, 21518.892405538187, 952.538019060755, 969.1035791892472, 969.8787651543557, 979.4123525884555, 1022.6931920423992, 11173.888261117285, 11313.0, 11498.885011149949, 11521.53913843437, 11901.98833099179, 241119.0, 593444.0, 594221.0, 646401.0, 655941.4405855975, 76347.0, 78126.0, 78200.43599128099, 122602.0, 126866.0, 932.1563984593953, 984.158544444504, 984.3601658921758, 1039.9740006499746, 1049.2707568240153, 13277.070605057554, 14984.325705343505, 17836.554086147433, 18314.542136446697, 18463.16915738768, 38517.80741096276, 40900.79549602233, 42280.88743335352, 50547.0, 50650.201234906795, 73673.6316318415, 74703.0, 77550.6122469384, 77871.61064194643, 78506.6074669623, 8026.0, 8352.373571982003, 8456.40805143634, 8476.279516240942, 8544.658213671384, 7933.920660793318, 13209.801852972405, 13585.388657510239, 13825.723485530434, 14038.719225615634, 10463.581456741646, 10985.945070274598, 11690.88309116898, 11748.647540573797, 11892.10809189297, 11422.485988130387, 11689.941550292195, 11755.941220293844, 11870.287782733063, 11913.463894124958, 10574.138791812282, 11091.5563377464, 11743.823842642538, 11974.700632484257, 11997.580084696994, 8242.505449673039, 8301.875471868048, 8358.414910956419, 8405.915940840514, 8564.52895090751, 9921.11937732635, 11935.0, 11950.282983021047, 12047.518099276282, 12047.578334758242], "unit": "score", "name": "jquery.html", "value": 9165.72029046409}, {"lowerIsBetter": false, "replicates": [1561.6174037360847, 1561.648629058462, 1788.8658350623707, 1883.1902282018734, 1901.0399748127193, 8040.396970227242, 8655.523946182973, 8824.117588241174, 8893.733188004355, 8982.416142950711, 8654.350923680733, 8680.392372533925, 8758.781030474225, 8768.473891566511, 8795.516246606434, 2118.6398312286947, 2465.32203643998, 2495.0, 2495.700515938081, 2499.912503062393, 2467.2351571012955, 2470.987645061781, 2520.4707011527507, 2520.6849143857016, 2522.495500899818, 2141.5395689926663, 2414.4929564791414, 2467.3584867934287, 2476.0838489758817, 2505.5865782145925, 2418.3107814272935, 2420.1287536486852, 2447.669564608773, 2452.7056753189554, 2469.790067844235, 2240.4286906838815, 2410.6259432123697, 2467.3091534370405, 2471.036295844622, 2472.9752702473106, 8688.782780430476, 8731.388802783807, 8759.474431534129, 8762.86855697165, 8764.342674299389, 5461.836144915659, 5572.60991730579, 5615.691136987464, 5620.803271885506, 5673.23411339468, 3351.8659253629826, 3756.267527832074, 3767.2088861339153, 3789.2042671039117, 3802.448644946495, 930.4882314726941, 1059.6450189186633, 1066.5627092891955, 1101.7631209290041, 1108.983365249522, 11832.822507662391, 11874.287542747463, 11884.524619015228, 11892.464839082262, 11958.461869215906, 4121.443605113332, 4511.909761804745, 4743.217369134123, 4857.368542089505, 4875.146849301429, 9394.530273486298, 9451.338406311492, 9470.90529094714, 9472.289578281656, 9491.572879220452, 5444.809431669952, 5462.535684466865, 5472.179173123984, 5488.17677348401, 5497.532709719719, 4918.803247870045, 5067.822626208065, 5070.695758254443, 5074.264231686385, 5093.2105523643895, 3736.308782875177, 3738.738288319846, 3743.981280093582, 3777.8111094445167, 3781.3382658034734, 1116.4083035990939, 1155.2779512804498, 1158.9420528973517, 1160.8548931383577, 1162.1574358590124, 929.8837645294338, 990.5839547390113, 1103.6964834670368, 1128.8993231599125, 1323.662466071165, 7980.201979801974, 8135.471194372347, 8171.509709417335, 8223.259906608433, 8235.258826705625, 633.7084940927133, 644.3073695777058, 653.545785678958, 655.0894256982702, 786.5123623353443, 6203.596766210182, 6223.906641400383, 6266.717997690115, 6307.4954003679595, 6310.116583678288, 9739.805203896025, 10698.839517407245, 10768.46157692128, 11173.050290725218, 11194.216404851744, 10980.945095274472, 11040.171987101, 11120.388378639253, 11127.499262533205, 11133.888661113448, 7292.270772922665, 8093.312068474245, 8408.285295749929, 8487.830243395221, 8629.611667475105, 8043.115257321807, 8051.476654017704, 8075.5558444286125, 8129.552874591955, 8131.7560473185895, 9541.379810312585, 9628.71113866585, 9893.455859927486, 9939.204863611038, 10008.549615267477, 9426.764330891783, 10154.984501549787, 10161.237907157141, 10208.285420020527, 10249.9487502562, 7070.823229419306, 7128.144622645315, 7129.2889706471115, 7158.248383919614, 7160.57036577807, 8238.954573739888, 8239.299659529008, 8344.374171937008, 8355.12271211514, 8381.37139714536, 6158.907616385668, 6840.144981877265, 7514.8872766909635, 7640.847183056197, 7704.961475192588, 7212.386947109345, 7321.816954576178, 7324.450666199949, 7400.296971787671, 7427.517211381243, 7675.846483070196, 7714.997050383414, 7741.148473668005, 7755.991721076224, 7765.92234077652, 6895.55178913369, 6914.481413894078, 6943.201531823703, 6992.1958974718555, 7010.964945175241, 7103.644817758988, 7114.253003434772, 7145.749898753519, 7153.928460715326, 7247.275272472711], "unit": "score", "name": "mootools.html", "value": 4844.051716026222}, {"lowerIsBetter": false, "replicates": [328.86352163852, 333.386568713567, 334.403090483487, 339.24517947566665, 345.2594185472162, 6056.969715151418, 6805.047293378919, 6884.552504087231, 6916.550424222428, 6929.792106236821, 5071.644984851053, 5566.443355664432, 6803.217629972554, 6925.92648139538, 6931.306869313066, 4193.51774545928, 4952.826651067214, 4999.800007999685, 5049.2678561608545, 5064.544191022807, 4096.508418989711, 5055.873603159932, 5072.442031376546, 5073.985202959404, 5107.616928730342, 5011.794810283482, 5012.624053196007, 5013.398392192942, 5029.924551131736, 5033.697978121306, 4819.975900120512, 4982.352294201767, 5030.949690503085, 5037.168867136918, 5044.218146187329, 4253.957460425387, 4286.592773686495, 4319.568043195687, 4323.546027667113, 4325.4593175853015, 6594.439472644783, 6601.900971485432, 6631.275868274235, 6646.202455705346, 6649.833754156137, 5966.522678185778, 5981.461668449861, 5984.551158663117, 5999.040153575451, 6004.8498787530225, 7357.3746231570385, 7402.518836275625, 7405.0, 7412.1476030256135, 7425.183229844767, 4694.57748802606, 4712.034033023257, 4848.127337079324, 4851.296561998526, 4859.0, 5756.424357564252, 6248.812725582125, 7754.1470438251745, 7806.4925779824125, 7806.843863122705, 4676.2985552166765, 4926.261060840831, 4935.161022626162, 4937.5559098246595, 4940.357753492023, 5030.195168772979, 5038.042771873405, 5042.067217564689, 5046.722430266297, 5063.87340316495, 5950.404959504015, 5959.0, 5970.731317090741, 5974.984252677055, 5978.671173085522, 6509.511786615928, 7075.186353569406, 7346.375558077516, 7456.142543607446, 7480.401567874557, 1440.5390275112072, 1483.710676418088, 1732.385003323827, 1750.0, 1753.6672129181914, 1069.8341757027674, 1138.2260063157132, 1146.2320245435412, 1155.9942200288945, 1162.96511104667, 6772.288909664414, 6938.791836244921, 6941.965290173618, 6957.1215771741345, 6979.755708550177, 7804.024496937883, 7820.648070836826, 7835.451518393657, 7846.764597062097, 7861.606919653995, 6904.930950690429, 6913.1358580177475, 6918.06606108179, 6927.75752848658, 6927.792166235021, 3973.106051138471, 4082.6529744971417, 4126.938095928564, 4135.069609337875, 4167.270727622654, 8083.949086618702, 8172.182781721899, 8196.508209507449, 8199.303059240032, 8232.547209903512, 8069.798255043671, 8083.019660183175, 8099.838003239902, 8119.0, 8133.837323253501, 8138.796530086677, 8149.429539932148, 8161.224683655162, 8163.510189388656, 8193.549354785544, 7557.924420755722, 7826.295633393022, 7838.176991416048, 7861.213878612093, 7863.135055143815, 7631.3513351365755, 7674.386049116169, 7692.0, 7699.923000769921, 7714.4599878008, 8123.18768123183, 8150.103488616366, 8160.020797504338, 8169.346452283922, 8176.0, 4068.3287257602165, 4743.146233677971, 4765.618750500021, 4812.590929771009, 4830.178869592248, 7547.923921243232, 7725.304722574995, 7784.377249819888, 7785.64964576584, 7794.142644309008, 7388.335049845325, 7454.440916931143, 7454.515456495311, 7468.477206595486, 7505.0, 7446.367058799846, 7471.6637751302405, 7484.251574842472, 7496.7376141834775, 7503.9249607503225, 6142.969285153546, 6267.341929097562, 7266.7093316266755, 7285.417166626763, 7288.526245794006, 6300.369963003663, 6621.172353455818, 6873.381395674413, 7329.9267007329245, 7440.851182976418, 6760.560563563353, 7284.053073100463, 7288.307610777179, 7295.927040729524, 7305.050343455317], "unit": "score", "name": "prototype.html", "value": 5372.926535729611}, {"lowerIsBetter": false, "replicates": [737.0712901743805, 738.0810890441401, 744.657457569518, 744.843582847602, 755.682613302413, 14648.926755366221, 14795.0, 15022.549323520285, 15023.0, 15041.473548425794, 12068.672446030929, 13319.20084794913, 15306.31121599528, 15774.684506309866, 15821.525354239391, 705.6612825843598, 869.6521391443425, 876.6405773632812, 881.6385282034367, 884.5223579267188, 864.511550973701, 877.1404024056428, 888.968886088987, 892.5671049540967, 897.0401670212875, 919.8896132464114, 938.7090002099337, 938.9342746007782, 942.3450701762278, 942.9434233945951, 919.0396036142214, 931.7577429868215, 932.6549176804592, 932.799448118651, 935.588341129904, 676.7326905872153, 688.9896651550231, 689.162667359156, 691.1257259566602, 691.8270432391902, 14850.925745371203, 15025.173615451255, 15061.0, 15069.397224111022, 15094.698106037818, 12550.246985180918, 12575.937120314431, 12748.426320815586, 12762.042846786528, 13244.271565063918, 10318.0, 10502.369857808557, 11384.037783702306, 11415.714607134805, 11463.31220126795, 4035.313996620552, 4044.1911617676287, 4118.217538667644, 4221.852235171785, 4266.488021437447, 80343.0, 80833.59583202047, 80950.59524702339, 81037.56887293332, 81400.0, 9374.0, 9513.429194248367, 9514.238860891111, 9543.809123817486, 9627.855582166274, 20189.49526261855, 20398.57209995316, 20412.0, 20430.38708838737, 20434.59130817405, 6826.24911259761, 7020.227774944752, 7583.469157158946, 7616.771496855104, 7729.729459468892, 3747.9505738393295, 4042.4744783178, 4118.073433477503, 4177.895552611149, 4201.705880588391, 3539.8761043363875, 3570.8036058016537, 3615.1504396466808, 3616.222512159898, 3646.2707458508403, 604.2688347100058, 660.0561197487543, 664.2560332427712, 669.1167658690482, 691.0636088100651, 458.269060847947, 523.2622002975786, 559.4601209832531, 619.9460916441976, 620.7672122953892, 8364.623591938378, 8515.872261916076, 8539.243466027334, 8625.439346442461, 8698.826023479622, 499.9925001124986, 585.8638015609808, 601.2334273800851, 604.9909251361233, 632.9746810127543, 3277.0332751838264, 3966.9801650991562, 4006.4991876015497, 4043.030387233775, 4045.662328578934, 93661.0, 93946.0, 94063.0, 94992.0, 95112.52443737737, 70544.0, 71973.92039119417, 84390.0, 84529.88675283168, 84571.57714211389, 67641.66179169073, 69775.65112174407, 71934.64032679803, 73124.0, 73496.63251683814, 8746.69386571467, 8883.866741998745, 8957.14907083826, 9028.730480260907, 9033.819323613623, 40513.0, 50292.99414011626, 50964.23553646624, 51283.487165129365, 52766.68083297948, 70183.0, 70817.64591177012, 71460.0, 71787.28212717806, 71923.92114118188, 10018.048285413166, 10921.718424446934, 11045.944770276097, 11135.220534562503, 12121.393930303626, 11845.822312665145, 11883.524659013889, 11976.089421995935, 12522.37388130608, 12789.744205116032, 11658.12564057716, 11682.746498105824, 11774.293542387484, 12014.085136604785, 12198.573049943565, 11739.589114380955, 11953.22304050234, 12003.195030834351, 12048.277103373826, 12244.632661020183, 9686.51567421612, 10626.628068017582, 10973.615923442641, 11457.770844583229, 11962.401879906143, 8623.137686231577, 8659.826803464022, 8740.257078148428, 8803.163699448542, 9507.334486585873, 7871.645775939982, 8284.258914150827, 9348.298877584073, 9848.852267215854, 9983.750406239902], "unit": "score", "name": "yui.html", "value": 6956.569796413587}], "name": "dromaeo_css", "value": 7515.183701728587}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 116.0, 115.0, 115.0, 126.0, 120.0, 114.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 116.1}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 181.0, 182.0, 118.0, 146.0, 138.0, 126.0, 160.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [201.0, 197.0, 199.0, 201.0, 208.0, 216.0, 206.0, 198.0, 234.0, 285.0], "unit": "score", "name": "audio-dft", "value": 214.5}, {"lowerIsBetter": true, "replicates": [79.0, 107.0, 103.0, 111.0, 70.0, 79.0, 81.0, 59.0, 128.0, 52.0], "unit": "score", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 116.0, 82.0, 82.0, 82.0, 117.0, 80.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 91.7}, {"lowerIsBetter": true, "replicates": [86.0, 94.0, 76.0, 88.0, 133.0, 113.0, 86.0, 109.0, 132.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 116.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 104.0], "unit": "score", "name": "imaging-darkroom", "value": 98.4}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 90.0, 88.0, 86.0, 142.0, 82.0, 148.0, 146.0, 106.0], "unit": "score", "name": "imaging-desaturate", "value": 107.5}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 55.0, 57.0, 55.0, 57.0, 66.0, 54.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 64.0, 73.0, 75.0, 70.0, 66.0, 66.0, 67.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 85.0, 86.0, 85.0, 114.0, 111.0, 111.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [119.0, 144.0, 119.0, 136.0, 133.0, 128.0, 141.0, 127.0, 128.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [131.0, 145.0, 143.0, 149.0, 169.0, 182.0, 178.0, 143.0, 148.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 73.0, 79.0, 104.0, 77.0, 67.0, 69.0, 68.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.6}], "name": "kraken", "value": 1541.6999999999998}]} 15:47:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1541.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7515.18"}}} 15:47:43 INFO - Return code: 0 15:47:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:47:43 ERROR - # TBPL SUCCESS # 15:47:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:47:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:47:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:47:43 INFO - 2016-02-22 15:47:43.214 screenresolution[2571:32556] starting screenresolution argv=screenresolution get 15:47:43 INFO - 2016-02-22 15:47:43.216 screenresolution[2571:32556] Display 0: 1600x1200x32@60 15:47:43 INFO - 2016-02-22 15:47:43.222 screenresolution[2572:32559] starting screenresolution argv=screenresolution list 15:47:43 INFO - Available Modes on Display 0 15:47:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:47:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:47:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:47:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:47:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:47:43 INFO - Intel Iris: 15:47:43 INFO - Chipset Model: Intel Iris 15:47:43 INFO - Type: GPU 15:47:43 INFO - Bus: Built-In 15:47:43 INFO - VRAM (Dynamic, Max): 1536 MB 15:47:43 INFO - Vendor: Intel (0x8086) 15:47:43 INFO - Device ID: 0x0a2e 15:47:43 INFO - Revision ID: 0x0009 15:47:43 INFO - Displays: 15:47:43 INFO - Display: 15:47:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:47:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:47:43 INFO - Display Serial Number: 1600x1200 60 15:47:43 INFO - Main Display: Yes 15:47:43 INFO - Mirror: Off 15:47:43 INFO - Online: Yes 15:47:43 INFO - Rotation: Supported 15:47:43 INFO - Return code: 0 15:47:43 INFO - Running post-action listener: _resource_record_post_action 15:47:43 INFO - Running post-run listener: _resource_record_post_run 15:47:44 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 90112; Write bytes: 710502400; Read time: 2; Write time: 1996 15:47:44 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395053568; Write bytes: 389212160; Read time: 29946; Write time: 722 15:47:44 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 90112; Write bytes: 303439872; Read time: 2; Write time: 1229 15:47:44 INFO - Running post-run listener: _upload_blobber_files 15:47:44 INFO - Blob upload gear active. 15:47:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:44 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 15:47:44 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'] 15:47:44 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 15:47:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:46 INFO - (blobuploader) - INFO - Done attempting. 15:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:47 INFO - (blobuploader) - INFO - Done attempting. 15:47:47 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:47 INFO - Return code: 0 15:47:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/268f83447e61ecce494dec5ef901f378751b8cafc48382a812789e3072a4cc6c1287da9282ac0805b203b81dc0e4c5146c1a92ebbb914965ee26cf976436ab03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59e2182f1b0fea946e766f70553470e5fceb0f467d00e71e5e50189efb9efd2b0662b02feeee62f9f9055533d03369bc7b1f8f63e6dcc9a0be6d89d4cd7c6f0"} 15:47:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:47 INFO - Contents: 15:47:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/268f83447e61ecce494dec5ef901f378751b8cafc48382a812789e3072a4cc6c1287da9282ac0805b203b81dc0e4c5146c1a92ebbb914965ee26cf976436ab03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59e2182f1b0fea946e766f70553470e5fceb0f467d00e71e5e50189efb9efd2b0662b02feeee62f9f9055533d03369bc7b1f8f63e6dcc9a0be6d89d4cd7c6f0"} 15:47:47 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:47 INFO - Copying logs to upload dir... 15:47:47 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.737792 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-22 15:47:47.725700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:47.729267) ========= 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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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/268f83447e61ecce494dec5ef901f378751b8cafc48382a812789e3072a4cc6c1287da9282ac0805b203b81dc0e4c5146c1a92ebbb914965ee26cf976436ab03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59e2182f1b0fea946e766f70553470e5fceb0f467d00e71e5e50189efb9efd2b0662b02feeee62f9f9055533d03369bc7b1f8f63e6dcc9a0be6d89d4cd7c6f0"} build_url:https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/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/268f83447e61ecce494dec5ef901f378751b8cafc48382a812789e3072a4cc6c1287da9282ac0805b203b81dc0e4c5146c1a92ebbb914965ee26cf976436ab03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f59e2182f1b0fea946e766f70553470e5fceb0f467d00e71e5e50189efb9efd2b0662b02feeee62f9f9055533d03369bc7b1f8f63e6dcc9a0be6d89d4cd7c6f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:47.757199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:47.757556) ========= 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.wlCVO6BVYb/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.QkOZhdIzKo/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.005297 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:47.807083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 15:47:47.807428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 15:47:47.807889) ========= ========= Total master_lag: 0.27 =========