builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0055 starttime: 1457492827.31 results: success (0) buildid: 20160308171512 builduid: 4edbd102844244558a186232ec92a954 revision: a5c5f12698e05859a4ceac9163ee7aef9191c749 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.313938) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.314477) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.314792) ========= 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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.005826 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.363764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.364101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.461579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.461998) ========= 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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.005562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.514358) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.514631) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:07.514980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-08 19:07:07.515252) ========= 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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-08 19:07:07-- 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% 9.55M=0.001s 2016-03-08 19:07:08 (9.55 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.499904 ========= master_lag: 2.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-08 19:07:10.640986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-08 19:07:10.641311) ========= 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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.027051 ========= master_lag: 3.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-08 19:07:13.964148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-08 19:07:13.964489) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5c5f12698e05859a4ceac9163ee7aef9191c749 --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 a5c5f12698e05859a4ceac9163ee7aef9191c749 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-08 19:07:14,125 truncating revision to first 12 chars 2016-03-08 19:07:14,125 Setting DEBUG logging. 2016-03-08 19:07:14,125 attempt 1/10 2016-03-08 19:07:14,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5c5f12698e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 19:07:14,750 unpacking tar archive at: fx-team-a5c5f12698e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867691 ========= master_lag: 1.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-08 19:07:15.970181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:15.970487) ========= echo a5c5f12698e05859a4ceac9163ee7aef9191c749 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a5c5f12698e05859a4ceac9163ee7aef9191c749'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 a5c5f12698e05859a4ceac9163ee7aef9191c749 program finished with exit code 0 elapsedTime=0.005153 script_repo_revision: 'a5c5f12698e05859a4ceac9163ee7aef9191c749' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 19:07:16.040881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 mins, 39 secs) (at 2016-03-08 19:07:16.041163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 mins, 39 secs) (at 2016-03-08 19:08:55.692610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-08 19:08:55.692906) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:08:55 INFO - MultiFileLogger online at 20160308 19:08:55 in /builds/slave/test 19:08:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:55 INFO - {'append_to_log': False, 19:08:55 INFO - 'base_work_dir': '/builds/slave/test', 19:08:55 INFO - 'blob_upload_branch': 'Fx-Team', 19:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:55 INFO - 'branch': 'Fx-Team', 19:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:55 INFO - 'config_files': ('talos/mac_config.py',), 19:08:55 INFO - 'default_actions': ('clobber', 19:08:55 INFO - 'read-buildbot-config', 19:08:55 INFO - 'download-and-extract', 19:08:55 INFO - 'populate-webroot', 19:08:55 INFO - 'create-virtualenv', 19:08:55 INFO - 'install', 19:08:55 INFO - 'run-tests'), 19:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:55 INFO - 'download_minidump_stackwalk': True, 19:08:55 INFO - 'download_symbols': 'ondemand', 19:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:55 INFO - 'installer_path': 'installer.exe', 19:08:55 INFO - 'log_level': 'info', 19:08:55 INFO - 'log_name': 'talos', 19:08:55 INFO - 'log_to_console': True, 19:08:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:08:55 INFO - 'opt_config_files': (), 19:08:55 INFO - 'pip_index': False, 19:08:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:08:55 INFO - 'cmd': ('bash', 19:08:55 INFO - '-c', 19:08:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:08:55 INFO - 'enabled': True, 19:08:55 INFO - 'halt_on_failure': False, 19:08:55 INFO - 'name': 'check_screen_resolution'},), 19:08:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:08:55 INFO - 'cmd': ('bash', 19:08:55 INFO - '-c', 19:08:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:08:55 INFO - 'enabled': True, 19:08:55 INFO - 'halt_on_failure': False, 19:08:55 INFO - 'name': 'check_screen_resolution'},), 19:08:55 INFO - 'run_cmd_checks_enabled': True, 19:08:55 INFO - 'sps_profile': False, 19:08:55 INFO - 'sps_profile_interval': 0, 19:08:55 INFO - 'suite': 'dromaeojs', 19:08:55 INFO - 'system_bits': '32', 19:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:55 INFO - 'title': 't-yosemite-r7-0055', 19:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:55 INFO - 'use_talos_json': True, 19:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:55 INFO - 'work_dir': 'build'} 19:08:55 INFO - ##### 19:08:55 INFO - ##### Running clobber step. 19:08:55 INFO - ##### 19:08:55 INFO - Running pre-action listener: _resource_record_pre_action 19:08:55 INFO - Running main action method: clobber 19:08:55 INFO - rmtree: /builds/slave/test/build 19:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:57 INFO - Running post-action listener: _resource_record_post_action 19:08:57 INFO - ##### 19:08:57 INFO - ##### Running read-buildbot-config step. 19:08:57 INFO - ##### 19:08:57 INFO - Running pre-action listener: _resource_record_pre_action 19:08:57 INFO - Running main action method: read_buildbot_config 19:08:57 INFO - Using buildbot properties: 19:08:57 INFO - { 19:08:57 INFO - "project": "", 19:08:57 INFO - "product": "firefox", 19:08:57 INFO - "script_repo_revision": "production", 19:08:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:08:57 INFO - "repository": "", 19:08:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:08:57 INFO - "buildid": "20160308171512", 19:08:57 INFO - "pgo_build": "False", 19:08:57 INFO - "basedir": "/builds/slave/test", 19:08:57 INFO - "buildnumber": 470, 19:08:57 INFO - "slavename": "t-yosemite-r7-0055", 19:08:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:08:57 INFO - "platform": "yosemite_r7", 19:08:57 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:08:57 INFO - "branch": "fx-team", 19:08:57 INFO - "repo_path": "integration/fx-team", 19:08:57 INFO - "revision": "a5c5f12698e05859a4ceac9163ee7aef9191c749", 19:08:57 INFO - "stage_platform": "macosx64", 19:08:57 INFO - "builduid": "4edbd102844244558a186232ec92a954", 19:08:57 INFO - "slavebuilddir": "test" 19:08:57 INFO - } 19:08:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 19:08:57 INFO - Running post-action listener: _resource_record_post_action 19:08:57 INFO - ##### 19:08:57 INFO - ##### Running download-and-extract step. 19:08:57 INFO - ##### 19:08:57 INFO - Running pre-action listener: _resource_record_pre_action 19:08:57 INFO - Running main action method: download_and_extract 19:08:57 INFO - mkdir: /builds/slave/test/build/tests 19:08: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')]} 19:08:57 INFO - https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 19:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 19:08:59 INFO - Downloaded 1199 bytes. 19:08:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 19:08:59 INFO - Using the following test package requirements: 19:08:59 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:08:59 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 19:08:59 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 19:08:59 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'jsshell-mac.zip'], 19:08:59 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 19:08:59 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 19:08:59 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 19:08:59 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 19:08:59 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 19:08:59 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 19:08:59 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 19:08:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:59 INFO - https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:09:00 INFO - Downloaded 17867307 bytes. 19:09:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:09:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:09:03 INFO - Return code: 0 19:09:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:03 INFO - https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 19:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:09:04 INFO - Downloaded 17867307 bytes. 19:09:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:09:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:09:07 INFO - Return code: 0 19:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:07 INFO - https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 19:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:09:08 INFO - Downloaded 10845161 bytes. 19:09:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:09:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:09:08 INFO - Return code: 0 19:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:08 INFO - https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 19:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 19:09:12 INFO - Downloaded 110757344 bytes. 19:09:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:09:12 INFO - mkdir: /builds/slave/test/properties 19:09:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:12 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:12 INFO - Contents: 19:09:12 INFO - build_url:https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 19:09:13 INFO - Running post-action listener: _resource_record_post_action 19:09:13 INFO - Running post-action listener: set_extra_try_arguments 19:09:13 INFO - ##### 19:09:13 INFO - ##### Running populate-webroot step. 19:09:13 INFO - ##### 19:09:13 INFO - Running pre-action listener: _resource_record_pre_action 19:09:13 INFO - Running main action method: populate_webroot 19:09:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:13 INFO - '--tppagecycles', 19:09:13 INFO - '7'], 19:09:13 INFO - 'tests': ['tsvgm']}}, 19:09:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:09:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:09:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:09:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'tests': ['damp', 'tps']}, 19:09:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['damp', 'tps']}, 19:09:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:09:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:13 INFO - 'other': {'tests': ['a11yr', 19:09:13 INFO - 'ts_paint', 19:09:13 INFO - 'tpaint', 19:09:13 INFO - 'sessionrestore', 19:09:13 INFO - 'sessionrestore_no_auto_restore', 19:09:13 INFO - 'tabpaint']}, 19:09:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['a11yr', 19:09:13 INFO - 'ts_paint', 19:09:13 INFO - 'tpaint', 19:09:13 INFO - 'sessionrestore', 19:09:13 INFO - 'sessionrestore_no_auto_restore', 19:09:13 INFO - 'tabpaint']}, 19:09:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['a11yr', 19:09:13 INFO - 'ts_paint', 19:09:13 INFO - 'tpaint', 19:09:13 INFO - 'sessionrestore', 19:09:13 INFO - 'sessionrestore_no_auto_restore', 19:09:13 INFO - 'tabpaint']}, 19:09:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['a11yr', 19:09:13 INFO - 'ts_paint', 19:09:13 INFO - 'tpaint', 19:09:13 INFO - 'sessionrestore', 19:09:13 INFO - 'sessionrestore_no_auto_restore', 19:09:13 INFO - 'tabpaint']}, 19:09:13 INFO - 'other_l64': {'tests': ['a11yr', 19:09:13 INFO - 'ts_paint', 19:09:13 INFO - 'tpaint', 19:09:13 INFO - 'sessionrestore', 19:09:13 INFO - 'sessionrestore_no_auto_restore', 19:09:13 INFO - 'tabpaint']}, 19:09:13 INFO - 'other_nol64': {'tests': ['a11yr', 19:09:13 INFO - 'ts_paint', 19:09:13 INFO - 'tpaint', 19:09:13 INFO - 'sessionrestore', 19:09:13 INFO - 'sessionrestore_no_auto_restore', 19:09:13 INFO - 'tabpaint']}, 19:09:13 INFO - 'svgr': {'tests': ['tsvgx', 19:09:13 INFO - 'tsvgr_opacity', 19:09:13 INFO - 'tart', 19:09:13 INFO - 'tscrollx', 19:09:13 INFO - 'cart']}, 19:09:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['tsvgx', 19:09:13 INFO - 'tsvgr_opacity', 19:09:13 INFO - 'tart', 19:09:13 INFO - 'tscrollx', 19:09:13 INFO - 'cart']}, 19:09:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'tests': ['tp5o']}, 19:09:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'talos_options': ['--e10s'], 19:09:13 INFO - 'tests': ['tp5o']}, 19:09:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'talos_options': ['--xperf_path', 19:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:13 INFO - 'tests': ['tp5n']}, 19:09:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:13 INFO - 'talos_options': ['--e10s', 19:09:13 INFO - '--xperf_path', 19:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:13 INFO - 'tests': ['tp5n']}}, 19:09:13 INFO - 'talos.zip': {'path': '', 19:09:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:13 INFO - Running post-action listener: _resource_record_post_action 19:09:13 INFO - ##### 19:09:13 INFO - ##### Running create-virtualenv step. 19:09:13 INFO - ##### 19:09:13 INFO - Running pre-action listener: _resource_record_pre_action 19:09:13 INFO - Running main action method: create_virtualenv 19:09:13 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:13 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 19:09:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:13 INFO - Using real prefix '/tools/python27' 19:09:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:14 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:16 INFO - Installing pip.................done. 19:09:16 INFO - Return code: 0 19:09:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:16 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')]} 19:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:16 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')]} 19:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:16 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:16 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 19:09:16 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 19:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:16 INFO - 'HOME': '/Users/cltbld', 19:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:16 INFO - 'LOGNAME': 'cltbld', 19:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:16 INFO - 'MOZ_NO_REMOTE': '1', 19:09:16 INFO - 'NO_EM_RESTART': '1', 19:09:16 INFO - 'PAGER': '/bin/cat', 19:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:16 INFO - 'PWD': '/builds/slave/test', 19:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:16 INFO - 'SHELL': '/bin/bash', 19:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:16 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:16 INFO - 'USER': 'cltbld', 19:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:16 INFO - 'XPC_FLAGS': '0x0', 19:09:16 INFO - 'XPC_SERVICE_NAME': '0', 19:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:17 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 19:09:17 INFO - Cleaning up... 19:09:17 INFO - Return code: 0 19:09:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:17 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:17 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 19:09:17 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 19:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:17 INFO - 'HOME': '/Users/cltbld', 19:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:17 INFO - 'LOGNAME': 'cltbld', 19:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:17 INFO - 'MOZ_NO_REMOTE': '1', 19:09:17 INFO - 'NO_EM_RESTART': '1', 19:09:17 INFO - 'PAGER': '/bin/cat', 19:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:17 INFO - 'PWD': '/builds/slave/test', 19:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:17 INFO - 'SHELL': '/bin/bash', 19:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:17 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:17 INFO - 'USER': 'cltbld', 19:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:17 INFO - 'XPC_FLAGS': '0x0', 19:09:17 INFO - 'XPC_SERVICE_NAME': '0', 19:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:17 INFO - Downloading/unpacking psutil>=0.7.1 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:17 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 19:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:20 INFO - Installing collected packages: psutil 19:09:20 INFO - Running setup.py install for psutil 19:09:20 INFO - building 'psutil._psutil_osx' extension 19:09:20 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 19:09:21 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 19:09:21 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 19:09:21 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 19:09:21 INFO - building 'psutil._psutil_posix' extension 19:09:21 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 19:09:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:09:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:09:21 INFO - ^ 19:09:21 INFO - 1 warning generated. 19:09:21 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 19:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:21 INFO - Successfully installed psutil 19:09:21 INFO - Cleaning up... 19:09:21 INFO - Return code: 0 19:09:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:21 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:21 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 19:09:21 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 19:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:21 INFO - 'HOME': '/Users/cltbld', 19:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:21 INFO - 'LOGNAME': 'cltbld', 19:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:21 INFO - 'MOZ_NO_REMOTE': '1', 19:09:21 INFO - 'NO_EM_RESTART': '1', 19:09:21 INFO - 'PAGER': '/bin/cat', 19:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:21 INFO - 'PWD': '/builds/slave/test', 19:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:21 INFO - 'SHELL': '/bin/bash', 19:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:21 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:21 INFO - 'USER': 'cltbld', 19:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:21 INFO - 'XPC_FLAGS': '0x0', 19:09:21 INFO - 'XPC_SERVICE_NAME': '0', 19:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:09:21 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 19:09:21 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 19:09:21 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 19:09:21 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 19:09:21 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 19:09:21 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 19:09:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:09:24 INFO - Installing collected packages: mozsystemmonitor 19:09:24 INFO - Running setup.py install for mozsystemmonitor 19:09:24 INFO - Successfully installed mozsystemmonitor 19:09:24 INFO - Cleaning up... 19:09:24 INFO - Return code: 0 19:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:24 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:24 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 19:09:24 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 19:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:24 INFO - 'HOME': '/Users/cltbld', 19:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:24 INFO - 'LOGNAME': 'cltbld', 19:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:24 INFO - 'MOZ_NO_REMOTE': '1', 19:09:24 INFO - 'NO_EM_RESTART': '1', 19:09:24 INFO - 'PAGER': '/bin/cat', 19:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:24 INFO - 'PWD': '/builds/slave/test', 19:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:24 INFO - 'SHELL': '/bin/bash', 19:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:24 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:24 INFO - 'USER': 'cltbld', 19:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:24 INFO - 'XPC_FLAGS': '0x0', 19:09:24 INFO - 'XPC_SERVICE_NAME': '0', 19:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:27 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 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 19:09:27 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 19:09:28 INFO - Downloading docopt-0.6.1.tar.gz 19:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:28 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:28 INFO - Running setup.py install for blobuploader 19:09:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:28 INFO - Running setup.py install for requests 19:09:29 INFO - Running setup.py install for docopt 19:09:29 INFO - Successfully installed blobuploader requests docopt 19:09:29 INFO - Cleaning up... 19:09:29 INFO - Return code: 0 19:09:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:29 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:29 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 19:09:29 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 19:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:29 INFO - 'HOME': '/Users/cltbld', 19:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:29 INFO - 'LOGNAME': 'cltbld', 19:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:29 INFO - 'MOZ_NO_REMOTE': '1', 19:09:29 INFO - 'NO_EM_RESTART': '1', 19:09:29 INFO - 'PAGER': '/bin/cat', 19:09:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:29 INFO - 'PWD': '/builds/slave/test', 19:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:29 INFO - 'SHELL': '/bin/bash', 19:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:29 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:29 INFO - 'USER': 'cltbld', 19:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:29 INFO - 'XPC_FLAGS': '0x0', 19:09:29 INFO - 'XPC_SERVICE_NAME': '0', 19:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:29 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-xE6ng9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:29 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-P99uMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:29 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-gKYTC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:29 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-4J1Gjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:29 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-8J9rhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-4w1Kv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-L4lDKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-JepR3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Qy6QAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-7KDutM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-a_wsyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-I4knPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-QppXLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:30 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-L6q44S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:31 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-eDYDst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:31 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-ebp6Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:31 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-suRnjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:31 INFO - Running setup.py install for manifestparser 19:09:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:31 INFO - Running setup.py install for mozcrash 19:09:31 INFO - Running setup.py install for mozdebug 19:09:31 INFO - Running setup.py install for mozdevice 19:09:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:31 INFO - Running setup.py install for mozfile 19:09:32 INFO - Running setup.py install for mozhttpd 19:09:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Running setup.py install for mozinfo 19:09:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Running setup.py install for mozInstall 19:09:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Running setup.py install for mozleak 19:09:32 INFO - Running setup.py install for mozlog 19:09:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:32 INFO - Running setup.py install for moznetwork 19:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:33 INFO - Running setup.py install for mozprocess 19:09:33 INFO - Running setup.py install for mozprofile 19:09:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:33 INFO - Running setup.py install for mozrunner 19:09:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:33 INFO - Running setup.py install for mozscreenshot 19:09:33 INFO - Running setup.py install for moztest 19:09:33 INFO - Running setup.py install for mozversion 19:09:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:33 INFO - Cleaning up... 19:09:33 INFO - Return code: 0 19:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:33 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:33 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 19:09:33 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 19:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:33 INFO - 'HOME': '/Users/cltbld', 19:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:33 INFO - 'LOGNAME': 'cltbld', 19:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:33 INFO - 'MOZ_NO_REMOTE': '1', 19:09:33 INFO - 'NO_EM_RESTART': '1', 19:09:33 INFO - 'PAGER': '/bin/cat', 19:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:33 INFO - 'PWD': '/builds/slave/test', 19:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:33 INFO - 'SHELL': '/bin/bash', 19:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:33 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:33 INFO - 'USER': 'cltbld', 19:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:33 INFO - 'XPC_FLAGS': '0x0', 19:09:33 INFO - 'XPC_SERVICE_NAME': '0', 19:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-Pz7XkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:34 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)) 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-ZezJO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-PWxChY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:34 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)) 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-2PLg25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:34 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)) 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-3dTHFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:34 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)) 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-PoXP6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:34 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)) 19:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:34 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-32FJHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-iZUkDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-u0ISrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-q3Ch23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-k0892C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-KiPMbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-tZlpxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-4ADAjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-McqNcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-nPdNIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:35 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)) 19:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:35 INFO - Running setup.py (path:/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/pip-ebL9AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:36 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)) 19:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:09:36 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)) 19:09:36 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)) 19:09:36 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)) 19:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:36 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 19:09:36 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 19:09:36 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 19:09:36 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 19:09:36 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 19:09:36 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 19:09:38 INFO - Downloading blessings-1.6.tar.gz 19:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:38 INFO - Installing collected packages: blessings 19:09:38 INFO - Running setup.py install for blessings 19:09:38 INFO - Successfully installed blessings 19:09:38 INFO - Cleaning up... 19:09:38 INFO - Return code: 0 19:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:39 INFO - Reading from file tmpfile_stdout 19:09:39 INFO - Current package versions: 19:09:39 INFO - blessings == 1.6 19:09:39 INFO - blobuploader == 1.2.4 19:09:39 INFO - docopt == 0.6.1 19:09:39 INFO - manifestparser == 1.1 19:09:39 INFO - mozInstall == 1.12 19:09:39 INFO - mozcrash == 0.17 19:09:39 INFO - mozdebug == 0.1 19:09:39 INFO - mozdevice == 0.48 19:09:39 INFO - mozfile == 1.2 19:09:39 INFO - mozhttpd == 0.7 19:09:39 INFO - mozinfo == 0.9 19:09:39 INFO - mozleak == 0.1 19:09:39 INFO - mozlog == 3.1 19:09:39 INFO - moznetwork == 0.27 19:09:39 INFO - mozprocess == 0.22 19:09:39 INFO - mozprofile == 0.28 19:09:39 INFO - mozrunner == 6.11 19:09:39 INFO - mozscreenshot == 0.1 19:09:39 INFO - mozsystemmonitor == 0.0 19:09:39 INFO - moztest == 0.7 19:09:39 INFO - mozversion == 1.4 19:09:39 INFO - psutil == 3.1.1 19:09:39 INFO - requests == 1.2.3 19:09:39 INFO - wsgiref == 0.1.2 19:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:39 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:39 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 19:09:39 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 19:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:39 INFO - 'HOME': '/Users/cltbld', 19:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:39 INFO - 'LOGNAME': 'cltbld', 19:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:39 INFO - 'MOZ_NO_REMOTE': '1', 19:09:39 INFO - 'NO_EM_RESTART': '1', 19:09:39 INFO - 'PAGER': '/bin/cat', 19:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:39 INFO - 'PWD': '/builds/slave/test', 19:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:39 INFO - 'SHELL': '/bin/bash', 19:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:39 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:39 INFO - 'USER': 'cltbld', 19:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:39 INFO - 'XPC_FLAGS': '0x0', 19:09:39 INFO - 'XPC_SERVICE_NAME': '0', 19:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 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)) 19:09:39 INFO - Cleaning up... 19:09:39 INFO - Return code: 0 19:09:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:39 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:39 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 19:09:39 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 19:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:39 INFO - 'HOME': '/Users/cltbld', 19:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:39 INFO - 'LOGNAME': 'cltbld', 19:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:39 INFO - 'MOZ_NO_REMOTE': '1', 19:09:39 INFO - 'NO_EM_RESTART': '1', 19:09:39 INFO - 'PAGER': '/bin/cat', 19:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:39 INFO - 'PWD': '/builds/slave/test', 19:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:39 INFO - 'SHELL': '/bin/bash', 19:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:39 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:39 INFO - 'USER': 'cltbld', 19:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:39 INFO - 'XPC_FLAGS': '0x0', 19:09:39 INFO - 'XPC_SERVICE_NAME': '0', 19:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:39 INFO - Downloading/unpacking jsonschema 19:09:39 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 19:09:39 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 19:09:39 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 19:09:39 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 19:09:39 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 19:09:39 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 19:09:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:41 INFO - Downloading/unpacking functools32 (from jsonschema) 19:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:42 INFO - warning: no files found matching '*.txt' 19:09:42 INFO - no previously-included directories found matching 'build' 19:09:42 INFO - no previously-included directories found matching 'dist' 19:09:42 INFO - no previously-included directories found matching '.git*' 19:09:42 INFO - Installing collected packages: jsonschema, functools32 19:09:42 INFO - Running setup.py install for functools32 19:09:42 INFO - warning: no files found matching '*.txt' 19:09:42 INFO - no previously-included directories found matching 'build' 19:09:42 INFO - no previously-included directories found matching 'dist' 19:09:42 INFO - no previously-included directories found matching '.git*' 19:09:42 INFO - Successfully installed jsonschema functools32 19:09:42 INFO - Cleaning up... 19:09:42 INFO - Return code: 0 19:09:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:09:42 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')]} 19:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:42 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')]} 19:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:42 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 0x108b1fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e924b5890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, '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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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 19:09:42 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 19:09:42 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 19:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:42 INFO - 'HOME': '/Users/cltbld', 19:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:42 INFO - 'LOGNAME': 'cltbld', 19:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:42 INFO - 'MOZ_NO_REMOTE': '1', 19:09:42 INFO - 'NO_EM_RESTART': '1', 19:09:42 INFO - 'PAGER': '/bin/cat', 19:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:42 INFO - 'PWD': '/builds/slave/test', 19:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:42 INFO - 'SHELL': '/bin/bash', 19:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:09:42 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:42 INFO - 'USER': 'cltbld', 19:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:42 INFO - 'XPC_FLAGS': '0x0', 19:09:42 INFO - 'XPC_SERVICE_NAME': '0', 19:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:42 INFO - Downloading/unpacking flake8 19:09:42 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 19:09:42 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 19:09:42 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 19:09:42 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 19:09:42 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 19:09:42 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 19:09:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:09:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:09:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:45 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 19:09:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:46 INFO - no previously-included directories found matching 'docs/_build' 19:09:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:09:46 INFO - Running setup.py install for pep8 19:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:46 INFO - no previously-included directories found matching 'docs/_build' 19:09:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:09:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:09:46 INFO - Cleaning up... 19:09:46 INFO - Return code: 0 19:09:46 INFO - Running post-action listener: _resource_record_post_action 19:09:46 INFO - Running post-action listener: _start_resource_monitoring 19:09:46 INFO - Starting resource monitoring. 19:09:46 INFO - ##### 19:09:46 INFO - ##### Running install step. 19:09:46 INFO - ##### 19:09:46 INFO - Running pre-action listener: _resource_record_pre_action 19:09:46 INFO - Running main action method: install 19:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:47 INFO - Reading from file tmpfile_stdout 19:09:47 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:47 INFO - Reading from file tmpfile_stdout 19:09:47 INFO - Output received: 19:09:47 INFO - Usage: mozinstall [options] installer 19:09:47 INFO - Options: 19:09:47 INFO - -h, --help show this help message and exit 19:09:47 INFO - -d DEST, --destination=DEST 19:09:47 INFO - Directory to install application into. [default: 19:09:47 INFO - "/builds/slave/test"] 19:09:47 INFO - --app=APP Application being installed. [default: firefox] 19:09:47 INFO - mkdir: /builds/slave/test/build/application 19:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:10:21 INFO - Reading from file tmpfile_stdout 19:10:21 INFO - Output received: 19:10:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:10:21 INFO - Running post-action listener: _resource_record_post_action 19:10:21 INFO - ##### 19:10:21 INFO - ##### Running run-tests step. 19:10:21 INFO - ##### 19:10:21 INFO - Running pre-action listener: _resource_record_pre_action 19:10:21 INFO - Running main action method: run_tests 19:10:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:21 INFO - 2016-03-08 19:10:21.736 screenresolution[1648:8229] starting screenresolution argv=screenresolution get 19:10:21 INFO - 2016-03-08 19:10:21.739 screenresolution[1648:8229] Display 0: 1600x1200x32@60 19:10:21 INFO - 2016-03-08 19:10:21.744 screenresolution[1649:8231] starting screenresolution argv=screenresolution list 19:10:21 INFO - Available Modes on Display 0 19:10:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:10:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:10:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:10:21 INFO - Intel Iris: 19:10:21 INFO - Chipset Model: Intel Iris 19:10:21 INFO - Type: GPU 19:10:21 INFO - Bus: Built-In 19:10:21 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:21 INFO - Vendor: Intel (0x8086) 19:10:21 INFO - Device ID: 0x0a2e 19:10:21 INFO - Revision ID: 0x0009 19:10:21 INFO - Displays: 19:10:21 INFO - Display: 19:10:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:10:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:21 INFO - Display Serial Number: 1600x1200 60 19:10:21 INFO - Main Display: Yes 19:10:21 INFO - Mirror: Off 19:10:21 INFO - Online: Yes 19:10:21 INFO - Rotation: Supported 19:10:21 INFO - Return code: 0 19:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:21 INFO - Python 2.7.3 19:10:21 INFO - Return code: 0 19:10:21 INFO - grabbing minidump binary from tooltool 19:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:21 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 0x1089c3d30>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089bab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:21 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 19:10:21 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 19:10:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:22 INFO - Return code: 0 19:10:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:10:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:10:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:10:23 INFO - Return code: 0 19:10:23 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:10:23 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KBDWILLP1n/Render', 19:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:23 INFO - 'HOME': '/Users/cltbld', 19:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:23 INFO - 'LOGNAME': 'cltbld', 19:10:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:23 INFO - 'MOZ_NO_REMOTE': '1', 19:10:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:23 INFO - 'NO_EM_RESTART': '1', 19:10:23 INFO - 'PAGER': '/bin/cat', 19:10:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:23 INFO - 'PWD': '/builds/slave/test', 19:10:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:23 INFO - 'SHELL': '/bin/bash', 19:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G0ihs7KlqQ/Listeners', 19:10:23 INFO - 'TMPDIR': '/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/', 19:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:23 INFO - 'USER': 'cltbld', 19:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:23 INFO - 'XPC_FLAGS': '0x0', 19:10:23 INFO - 'XPC_SERVICE_NAME': '0', 19:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:10:23 INFO - mozversion application_buildid: 20160308171512 19:10:23 INFO - mozversion application_changeset: a5c5f12698e05859a4ceac9163ee7aef9191c749 19:10:23 INFO - mozversion application_display_name: Nightly 19:10:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:23 INFO - mozversion application_name: Firefox 19:10:23 INFO - mozversion application_remotingname: firefox 19:10:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:10:23 INFO - mozversion application_vendor: Mozilla 19:10:23 INFO - mozversion application_version: 48.0a1 19:10:23 INFO - mozversion platform_buildid: 20160308171512 19:10:23 INFO - mozversion platform_changeset: a5c5f12698e05859a4ceac9163ee7aef9191c749 19:10:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:10:23 INFO - mozversion platform_version: 48.0a1 19:10:23 INFO - using testdate: 1457493023 19:10:23 INFO - actual date: 1457493023 19:10:23 INFO - starting webserver on 'localhost:49279' 19:10:23 INFO - SUITE-START | Running 2 tests 19:10:23 INFO - TEST-START | dromaeo_css 19:10:23 INFO - operating with platform_type : mac_ 19:10:23 INFO - Initialising browser for dromaeo_css test... 19:10:23 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmprU_pX_/profile http://localhost:49279/getInfo.html) 19:10:25 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 19:10:25 INFO - PROCESS | 1667 | colorDepth:24 19:10:25 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 19:10:25 INFO - PROCESS | 1667 | __metrics 19:10:26 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:10:26 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:10:26 INFO - TEST-INFO | 1667: exit 0 19:10:26 INFO - Browser initialized. 19:10:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:26 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmprU_pX_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:38 INFO - PROCESS | 1670 | RSS: Main: 242765824 19:10:38 INFO - PROCESS | 1670 | 19:11:29 INFO - PROCESS | 1670 | 1457493089375 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] 19:13:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 19:13:41 INFO - PROCESS | 1670 | RSS: Main: 424521728 19:13:41 INFO - PROCESS | 1670 | 19:16:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 19:16:44 INFO - PROCESS | 1670 | RSS: Main: 372940800 19:16:44 INFO - PROCESS | 1670 | 19:19:46 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 19:19:47 INFO - PROCESS | 1670 | RSS: Main: 375779328 19:19:47 INFO - PROCESS | 1670 | 19:22:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 19:22:49 INFO - PROCESS | 1670 | RSS: Main: 329355264 19:22:49 INFO - PROCESS | 1670 | 19:25:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 19:25:53 INFO - PROCESS | 1670 | RSS: Main: 331759616 19:25:53 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 19:28:56 INFO - PROCESS | 1670 | RSS: Main: 405704704 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | __start_tp_report 19:28:56 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 19:28:56 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 19:28:56 INFO - PROCESS | 1670 | |i|pagename|runs| 19:28:56 INFO - PROCESS | 1670 | |0;dojo.html;3393.5079413485046;3405.5062016007664;3460.9307813843707;3462.4460086386175;3499.1602015516282;5466.125419932811;5491.093969495028;5526.917096243559;5536.778528858846;5550.472705093015;4701.50634183411;5531.197976293435;5561.193626924093;5575.163725441186;5690.374058853523;4993.300937868701;5025.849224523252;5028.396592408916;5029.245613158019;5186.273921650953;5119.667221630601;5160.767765450545;5161.819336323229;5166.199239117943;5234.188700751371;5020.548150666457;5044.319016932704;5069.721165335905;5083.830718934629;5118.897622047557;5047.268146118829;5063.8480845574695;5071.188609822448;5072.923906141411;5181.637285390024;5007.799688012475;5039.143345631252;5042.294078828967;5069.214271787879;5103.055934652101;5351.518363347317;5438.945610543883;5440.211169380417;5446.210299506589;5450.4549545045575;6121.143039974407;6128.662923539204;6133.355997620275;6147.139400483891;6156.56904016719;6090.5736598438125;6124.755009799603;6128;6142.232220972379;6168.722407491674;5589.385167631557;5605.887882242332;5629.774809007635;5636.718164091779;5637.408072152406;6114.3277820888225;6158.829822333742;6180.938190618126;6195.876082478325;6203.2556093269095;5958.672273025025;5978.990051580701;6014.248218972629;6025.6083354581815;6047.365026672224;6104.4505994460715;6139.584134579375;6154.907676384858;6165.691715414211;6172.938270617326;6033.758649653964;6091.634501929899;6115.027386288435;6115.909724157157;6140;6075.149479072933;6075.908861367083;6093.817185484442;6100.816975490742;6113.388661133851;4278.828846846091;4683.906321873544;4751.144793937125;4795.448523419782;4805.9759701201965;4245.066085461193;4296.183725092223;4334.5882141196535;4376.671749618791;4394.934075988863;5491.121420572689;5493.670379777226;5519.972400137974;5521.558275337963;5535.7785688572;5379.515843574019;5872.649290663086;6197.907031394533;6202.56582039262;6204.286507051656;5512.310961129859;5527.751251193706;5530.225768392428;5565.38780734127;5583.190437386637;5240.9213861792105;5254.684718916801;5263.526282634582;5263.6578622389425;5263.973680131651;6152.415520525543;6221.097940798559;6233.096201050822;6234.0337247726675;6244;6100.30868792748;6146.5390095742105;6165.075238714228;6179.721912513858;6180.81457556274;6175.536834737323;6207.875842483035;6216.595921265103;6228.813135605939;6245.125682404558;5048.293238946477;5959.135925290895;6034.456898878946;6076.605020673642;6076.787312444043;6133.120447061136;6177.042558403455;6194.535409844189;6194.659293738888;6195.318514963441;5792.768289268382;5795.985702501961;5814.331351894586;5833.416658334133;5870.823875283578;5780.710964451845;5808.709564521672;5809.041508151107;5830.358660547252;5875.618084824473;5835.67903765297;5847.590668653153;5874.441928016831;5881.647101173943;5899.439553242435;5796.76812927495;5960.737656157015;5974.970125149346;6023.698815059141;6027.819165425044;5893.263342082239;5898.94101058984;5927.110933360031;5935.940640593712;5941.287045554388 19:28:56 INFO - PROCESS | 1670 | |1;ext.html;485.2963203355136;565.2933832709114;576.9826905192846;631.7536160897251;634.9269833969093;33148;39876.60123398769;39905.800470997674;39929.401058984105;39942.201155976865;35679.64320356795;42962.355564666475;43757.78121109398;43775.56224437755;43905.78047109768;8418.452800567975;9611.231101511863;9843;9846.556904939294;9853.310268281222;9656.5171741413;9755.41467511948;9837;9838.06538378853;9845.55694993727;9904;9999.150072243869;10011.24915631327;10021.949890250538;10025.849612255823;9875.802483950316;9963.601455941754;9980.80038399228;9986.001399860028;10011.949940250252;9791.559379827924;9909;9935.552900119512;9944.850827237597;9964.153046991014;42866.14267714628;43274.134517309474;43294.70115896496;43373.56626433727;43532.56467435317;3302.3230237801195;3347.0126312737802;3396.201892555272;3507.824608769551;3835.616438356142;29095.70904290951;29740.66167022489;30435.543466848016;30608;30670.079897603107;2702.6891907430504;2720.91837244883;2741.575055866344;2801.7338352856445;2829.4906916754976;493830;500917;501582;501617;502306;45525.54474455279;46038.539614604095;46090;54476;69525.65237173781;46011.53988460072;46103.30845037327;46127.308090378;46295;46347.07305853932;15472;15604.531864044096;15633.765493517607;15669.451569195024;15699.68600627981;12535;12566.874331256571;12585.37073146339;12586.874131258754;12603.18079324841;15003.624909377353;15107.018043827336;15146.848531514544;15158.621034474007;15360.923195383952;6371.23545174582;6503.4146926775875;6527.608343499405;6529.836754081186;6534.477241820643;948.9430634161972;968.9903100969041;983.4443539400216;987.1905037868878;1081.7457897394106;25236.87381563117;29568;29652.110436686933;30131.548026779616;30219.69780302169;1062.7024433158729;1101.1136035491347;1113.6158025481195;1169.7543515861594;1187.1749134351542;14963.177025263498;15014.699706005818;15034.323455444532;15397.307121179574;15588.376464941275;523776;527878;532701;534908;536051;60483.395166047776;62233.68883155646;62346;62360;62732;1307.1111644081925;1350.1763924006348;1445.6674964758165;1450.2531196433845;1481.1483397046525;28643.427131457673;28716.851325947562;29481.968131115307;29717.70282297236;30134;50337.49662503474;51215;51590;51617.48382516127;51745;334293;376261;376744.11627941683;376989;377998.1100094482;28666.713332866406;33234.16914577155;33775.15562110967;34293.48559771555;34312.14219644529;42609.78695106505;42794;43083.78458107689;43093.569064310206;43186.56813431951;35166.12084697903;35400.64599354076;35430;36196.914092577266;36287.092822679646;35562.28875422529;36401.635983639826;36505.26989460249;36876.446853296686;37553.81223093867;34080;36141;37094.25811483809;37172.62827371692;37255.627443725214;32063.47301796847;32952;33057;33099.338013240085;33268.833655831564;21121.577568448236;22837;24418.389540260923;24563.631545526474;24885.626715599643 19:28:56 INFO - PROCESS | 1670 | |2;jquery.html;310.4706475459342;337.87667501362;361.9124530784991;363.63454727998374;372.80055170483797;19978;19990.50023749407;21179.47051323718;21239.04424300908;21350;19824.504387390323;20885.955702214906;20972.79785622507;21285.787142128574;21320.680189797127;5731.742071606777;5899.144624029514;5943.762249510014;5950.79172228972;5961.165436838846;4126.793660316987;4444.177827101997;5863.2670916135485;6471.061696054069;6506.967465162667;6252.406021427957;6432.388923052303;6442.613443193423;6468.611883286994;6492.318306577812;6197.349278325801;6269.874602507947;6405.19935008124;6464.676766161697;6469.997150441713;5512.173174023928;5536.640118392332;5544.805931792408;5551.444855514456;5563.833085007415;25718.357041074123;26339.604905926426;26365.604515932275;26497.470050599073;26756.331091722666;2039.225094464109;2123.3629911026783;2198.659207822774;2267.30847091637;2302.2517681753498;7584.772456826304;7760.805979850493;14343.21112338821;14630.561083167522;14694.706105877929;1505.2473763118442;1568.643123697993;1660.9169541522876;1720.346268417993;1723.8448539631493;99298.50350748272;103771;104295.99999999924;104920;107207.46396268047;10383.273170877967;10628.946855265674;10887.618933337295;10906.5092070857;11030.393328366856;13129.60611181666;13187.93406032983;13190.076694631283;13209.40557674907;13227.338633068308;8621.698240561676;8754.21212090915;8780.868286975701;8842.557872106368;8875.112488751203;9009.054049324857;9039.367244292836;9050.637974481078;9146.771330716785;9149.35954483193;5402.756875940592;6245.188125543741;6355.809325720235;6359.554831161867;6366.331535188831;1766.3023105873108;1806.7380229866596;1810.5564136786572;1813.0934532733634;1854.8145185481615;886.9645214191489;908.3232991421302;1005.1054561440324;1013.6097602422973;1084.5878566144816;20169.781324054344;20416.489587760425;20459;20811.479713007295;21245.46886327823;960.6541645007792;994.4431118573622;995.4226548601794;995.6963126246419;1057.143713591993;11298.410008473375;11417.543298267976;11476.024537914203;11495.54017839277;11532.192746507664;594931;597314;604293;624714;641831;63128.36871631317;74585.25414745783;82606.58696706478;99674;99886;1030.6083688198437;1032.9225308101772;1059.8569193158978;1088.9945550272198;1090.3457925244948;19010.334638288146;19079.618407632046;19101.808981910002;19125.90437047806;19196.61606767829;43496.130077398906;48184.27723584219;48517.75741121272;49097.50902491072;50304;66005;66718.33204169935;66979;67138.99291510729;69281.96077058949;7897.368210543028;7943.4042446817875;8022;8023.077346105272;8081.272685458337;12678;12858.549950752053;13378;13440;13715;11395;11408.600698975495;11522.884771152516;11628.767424651629;11831.526738930346;11254.662360129209;11305.491252893804;11413.372264525531;11632.651020469399;11687.123465739933;11494.252873563191;11623.476943537393;11857.940710296394;11859.644210673694;11887.346195959306;6675.833104172434;7791.688332466638;7874.606269686607;7887.526748395115;8191.918080819116;11502.712432189262;11554.884451155382;11800.940995294968;11816.231944923553;11817.172797904408 19:28:56 INFO - PROCESS | 1670 | |3;mootools.html;1418.588609303302;1573.1269145624178;1595.0668858717654;1890.092755477371;2042.8570000099999;8082.555459449728;8764.8685269721;8959.686410975617;8966.506842123681;8971.775705607362;8272.917270827289;8496.192861678146;8497.660093596263;8502.744917652464;8524.318054555637;2148.5058436559602;2433.051110067075;2435.0625009371342;2463.4457247119344;2503.812214083942;2495.8752062396898;2508.1973768394123;2508.586083296254;2510.623406489023;2518.1438310974263;2379.4051487128218;2471.122751423246;2491.202815099169;2492.3519884829893;2493.5760920643443;2452.4359397338535;2485.962710559343;2514.170323793162;2516.9748302516923;2517.2196619048154;2456.2262887190477;2498.4253621667117;2513.0324824942345;2517.1944977607172;2519.231634351522;9008.099190080939;9106.180443760093;9108.134727200906;9114.726558203265;9139.588718507683;5511.255980442629;5641.830745077655;5657.321121465409;5662.348829884533;5673.149027645845;3242.951355729666;3571.7678350907368;3741.1769410729594;3741.6071312512067;3762.3415902217275;1033.5762337441613;1043.7495001199657;1051.3586712105687;1058.3755584205355;1066.9306495077794;12290.938545307215;12343.382830858422;12348.938255308756;12367.505299787998;12370.62888113358;4952.504749525091;4979.3526841510375;5064.569511591556;5099.286099946011;5099.980003999215;10418.374897506023;10428.739281517872;10429.634962776267;10461.738456538647;10473.581056757645;5624.6625202487985;5658.783361577281;5662.207290979266;5664.631798933056;5665.49010589049;4451.955480445219;4543.863684089482;4864.489228630943;5018.3476148101245;5094.465081166498;3960.20795840833;4060.4112403701297;4066.4916885389325;4076.510818701775;4131.648809851136;1128;1318.5253308808822;1327.0975736499274;1331.0682522234474;1333.646583655332;891.5809569502323;912.0150237743221;915.2449229385651;1151.4645689754304;1170.1925671286785;8233.053198882086;8381.748547543584;8391.496510209407;8431.74704758846;8460.661573537112;505.6031015652695;516.767454645411;519.966202196856;521.2780299285516;526.431454029647;6311.116443697886;6336.714847831859;6348;6357.237131544151;6384.201974753156;10633.893661063445;11008.119350451945;11049.834252486218;11086.057685096857;11104.056155226895;10455.895441045492;10822.458877056273;10846.94576527128;10848.186386020921;10983;8434.198751118634;8498.277646400002;8530.445521041112;8583.742487725378;8597.52713600758;6860.828479288058;7543.7736867894055;8076;8130.75607731769;8137.186281371815;9535;9744.951275243578;9792.902070979198;9806.411615303105;9986.60053597848;9918.20654347636;10133.543990520297;10184.287099903231;10195;10281;6371.808845734636;6659.467242620482;7592.088949326117;7706.267904549059;7728.729494467667;8367.246947774729;8383.706570270011;8439.915600843913;8453.154684531497;8458.746237612635;7385.8153546161775;7399.852002960019;7424.740134095281;7564.432667550066;7614.657340419805;6860.279670634512;6876.277990810893;7331.340179383881;7439.107307123179;7453.888191677021;7848.7645370638975;7849.646765895434;7901.288884000468;7908.4464087513325;7920.366370690215;7072.3634872861685;7107.715691372494;7142.5000249982;7155.4633402496065;7161.641917904188;7255.984162217399;7305.269473052652;7324.926750732425;7356.742514011984;7389.334959853639 19:28:56 INFO - PROCESS | 1670 | |4;prototype.html;317.9634342050664;321.3572854291417;327.42805264646216;327.96064472263316;331.06804345766665;6677.966610166948;6680.532362734611;6690.96654516728;6698.196216454026;6744.055832183498;6548.934510654892;6677.599344039361;6682.29835867233;6682.331766823315;6686.732530698766;4720.858374248761;4800.855974320759;4810;4830.806767729287;4970.956099219159;4926.605871530269;4966.230234313687;4970.204767237243;4976.850694479153;4986.077575648516;4883.609311255091;4909.705417674933;4929.975350123263;4931.704097754128;4932.876678083041;4668.253079507263;4768.070226305872;4770.0698363819065;4901.362822833027;4917.877053073666;4062.3094074007195;4083.9387409188885;4146.963259185204;4160.771157586331;4177.665786737084;6373.8406539836415;6423.454006409461;6427.8393040173905;6433.228012638513;6462.741490340381;5809.2447981762525;5814.680192589406;5818.41815818419;5822.214001109838;5822.883542329129;5737.627054241461;7063.788086357417;7074.893876591856;7077.823054423629;7094.609796461193;4339.696221264513;4536.410266665345;4536.637069034469;4539.886502837422;4653.441587009546;7429.442791790637;7457.291557302047;7505.549667020051;7519.172890981988;7538.434617403716;4632.467266264355;4635.281531362577;4635.907281854412;4641.791119399635;4650.744209068466;4699.506551812079;4706.3175839503765;4706.411698537683;4717.740524271129;4718.292256161603;5616.606837521416;5623.606347555714;5641.12562552805;5641.80253691127;5649.4633009864;5982.923073846662;6678.1318428604945;7082.468814838805;7128.144622645212;7129.394001509826;1610.846969537892;1619.2470501216756;1637.4760076775317;1637.8607818335336;1649.1012398242985;1031.4327120083924;1035.9119474844572;1056.8414737789394;1063.4895250279753;1064.084886997182;6470.288268290485;6642.7342906284175;6649.335066493312;6655.201375834931;6666.733330666719;7301.160366557808;7353.374963128087;7446.292602202782;7462.253774622494;7479.925200748032;6698.162729658793;6699.464042876558;6701.597904125768;6703.061571380011;6707.5975441473665;3918.431827385013;3946.7039972002217;3953.486046813953;3964.0288129408477;3969.940450893239;7522.247775222434;7777.338926191337;7778.844423111506;7812.140664526897;7824.452288339761;6239.812805615748;7650.923490765133;7683.846323073507;7694.038245219348;7703.345215656732;6360.236771587347;7732.536047837148;7778.49439786412;7792.454528182972;7799.571023593757;6061.333253342217;7351.301626345488;7420.369268612229;7421.740239091606;7436.702531898663;7069.187043490065;7304;7323.157836848831;7326.633668316456;7354.117505899112;7715.228477152465;7762.611869406394;7798.688052477837;7800.570968596781;7804.453688241769;4648.883777905579;4655.487896331333;4657.48767635553;4672.719636821802;4683.836065737819;7386.372158366599;7387.482876198829;7392.741254056083;7397.630118494161;7404.555726656418;6867.725290988305;7100.964495177491;7131.42948564124;7143.214246432992;7168.749093781693;7065.364117229474;7110.964445177741;7121.893171602326;7143.928560714534;7144.785656430316;5715.514181294637;5775.509081727932;6971.965140174267;6983.476239282176;6998.580085194904;6087.8128764890425;6389.680515974275;6834.589924604539;6902.171739391305;7119.857602848017;6724.697388617622;6945.062416573698;6959.130108736408;6977.3720365165345;7012.964935175291 19:28:56 INFO - PROCESS | 1670 | |5;yui.html;748.3003391828637;758.1698040645495;760.0840986611131;772.6445834915938;818.067403160397;14931.402743890232;14998.325075371607;15177.772333414994;15191;15300.693986120272;14196.503122390719;14222.004459687825;14246.287685615704;14259.92870035651;14271.286435678201;754.3814072460584;766.0577489687687;916.5463095767604;924.6763632728558;947.0718695678239;936.6955739384694;938.9014153513851;939.821433927555;940.3605548227202;941.8022215334788;987.1313244344966;994.5872462927877;996.3772642098688;997.0976266478848;1001.694483182629;782.3623746646465;791.0902462168494;794.0749027383092;989.3865803202025;989.6239429016963;582.1762206477829;712.7576623947882;722.7542635503954;724.807925899637;726.259215600085;13930.651733706738;13940.790888136686;13952.2326272055;13970.860291397159;14008.929955350159;12890.291033993126;12945.482180712761;13126.803097953538;13226.140300880412;13400.731985360238;9964.20286377088;10118.797624047551;10338.793224135476;10497.9475102624;10933.961273678988;3550.431930891045;3553.1117220694828;3593.8562457501666;3658.993776711399;3707.1757709229314;81402.59298703528;81802.59098704527;81928.18071819325;82114.76827847587;82133;9435;9681.225501959827;9786.1192492676;9979.850302245472;10426.635067772591;22406.663900041513;22587.983540740704;22613.88693056524;22771.772282276965;22808.20171293997;7489.85020299591;7513.962430187923;7614.314711675976;7623.656935437919;7693.49992250502;4041.7170798043853;4096.283150448659;4099.467069281034;4099.508059032875;4152.626263636287;3663.816809159585;3726.7391282610497;3727.3849814780256;3728.3102626014274;3741.4013757799166;621.0559948877681;632.250782822357;637.3021541412146;639.1180171363488;644.9161608990895;575.6315957787019;578.3435800366531;612.5038718637918;620.7423919073534;626.0921663587816;7763.262490063435;8252.381071419668;8277.917220827836;8303.543305118155;8397.244248017585;479.14472666290504;495.02727141167776;569.0269638917498;588.5027152056506;593.2732402806528;3692.2430901665093;3810.237952409529;3818.579956204815;3820.140468394589;4052.5339585947404;90122.09877901268;91243;91711.54144229236;94567.05432945583;95346.52326738322;79062;79124.20875791284;80303.59848200722;81096.59451702704;81151.59424202959;67716.3070923221;69612;70088.64955675189;70121.29878701249;70158.59682806315;7654.502457340478;7797.752359622433;7838.3337416320255;7920.366370690215;7933;51023;51353;51374;51720.448386548465;51829.7408512955;66634.33365666281;68244.31755682579;68379.31620683729;69166;69166.96249556361;10412.895871041193;10426.791464170827;10457.477126143815;10639.734006649585;10741;10592.470376480991;10784.784304314027;10928;11152;11711;10171.135453486537;10551.841722374016;10565.418901960466;10638.202134840072;10675.252732308663;9960.203183745138;10112.544935478069;10504.842427363443;10575.048245657928;10603.94698026505;9956.452395118338;10422.947885260524;10427.739306517095;10506.579736810441;10516.211284153565;8756.25571826402;8762.02725766153;8822.25010874083;8851.867221991804;9009.189172974464;8075.717349892726;8713.085126061926;8851.336149788664;8864.822703546022;8984.371094023356 19:28:56 INFO - PROCESS | 1670 | __end_tp_report 19:28:56 INFO - PROCESS | 1670 | __start_cc_report 19:28:56 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1780 19:28:56 INFO - PROCESS | 1670 | __end_cc_report 19:28:56 INFO - PROCESS | 1670 | __startTimestamp1457494136764__endTimestamp 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | ------- Summary: start ------- 19:28:56 INFO - PROCESS | 1670 | Number of tests: 6 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5602.86 Median:5809.04 stddev:629.20 (10.8%) stddev-sans-first:606.79 19:28:56 INFO - PROCESS | 1670 | Values: 3393.5 3405.5 3460.9 3462.4 3499.2 5466.1 5491.1 5526.9 5536.8 5550.5 4701.5 5531.2 5561.2 5575.2 5690.4 4993.3 5025.8 5028.4 5029.2 5186.3 5119.7 5160.8 5161.8 5166.2 5234.2 5020.5 5044.3 5069.7 5083.8 5118.9 5047.3 5063.8 5071.2 5072.9 5181.6 5007.8 5039.1 5042.3 5069.2 5103.1 5351.5 5438.9 5440.2 5446.2 5450.5 6121.1 6128.7 6133.4 6147.1 6156.6 6090.6 6124.8 6128.0 6142.2 6168.7 5589.4 5605.9 5629.8 5636.7 5637.4 6114.3 6158.8 6180.9 6195.9 6203.3 5958.7 5979.0 6014.2 6025.6 6047.4 6104.5 6139.6 6154.9 6165.7 6172.9 6033.8 6091.6 6115.0 6115.9 6140.0 6075.1 6075.9 6093.8 6100.8 6113.4 4278.8 4683.9 4751.1 4795.4 4806.0 4245.1 4296.2 4334.6 4376.7 4394.9 5491.1 5493.7 5520.0 5521.6 5535.8 5379.5 5872.6 6197.9 6202.6 6204.3 5512.3 5527.8 5530.2 5565.4 5583.2 5240.9 5254.7 5263.5 5263.7 5264.0 6152.4 6221.1 6233.1 6234.0 6244.0 6100.3 6146.5 6165.1 6179.7 6180.8 6175.5 6207.9 6216.6 6228.8 6245.1 5048.3 5959.1 6034.5 6076.6 6076.8 6133.1 6177.0 6194.5 6194.7 6195.3 5792.8 5796.0 5814.3 5833.4 5870.8 5780.7 5808.7 5809.0 5830.4 5875.6 5835.7 5847.6 5874.4 5881.6 5899.4 5796.8 5960.7 5975.0 6023.7 6027.8 5893.3 5898.9 5927.1 5935.9 5941.3 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:60808.42 Median:37404.72 stddev:125532.58 (335.6%) stddev-sans-first:125803.03 19:28:56 INFO - PROCESS | 1670 | Values: 485.3 565.3 577.0 631.8 634.9 33148.0 39876.6 39905.8 39929.4 39942.2 35679.6 42962.4 43757.8 43775.6 43905.8 8418.5 9611.2 9843.0 9846.6 9853.3 9656.5 9755.4 9837.0 9838.1 9845.6 9904.0 9999.2 10011.2 10021.9 10025.8 9875.8 9963.6 9980.8 9986.0 10011.9 9791.6 9909.0 9935.6 9944.9 9964.2 42866.1 43274.1 43294.7 43373.6 43532.6 3302.3 3347.0 3396.2 3507.8 3835.6 29095.7 29740.7 30435.5 30608.0 30670.1 2702.7 2720.9 2741.6 2801.7 2829.5 493830.0 500917.0 501582.0 501617.0 502306.0 45525.5 46038.5 46090.0 54476.0 69525.7 46011.5 46103.3 46127.3 46295.0 46347.1 15472.0 15604.5 15633.8 15669.5 15699.7 12535.0 12566.9 12585.4 12586.9 12603.2 15003.6 15107.0 15146.8 15158.6 15360.9 6371.2 6503.4 6527.6 6529.8 6534.5 948.9 969.0 983.4 987.2 1081.7 25236.9 29568.0 29652.1 30131.5 30219.7 1062.7 1101.1 1113.6 1169.8 1187.2 14963.2 15014.7 15034.3 15397.3 15588.4 523776.0 527878.0 532701.0 534908.0 536051.0 60483.4 62233.7 62346.0 62360.0 62732.0 1307.1 1350.2 1445.7 1450.3 1481.1 28643.4 28716.9 29482.0 29717.7 30134.0 50337.5 51215.0 51590.0 51617.5 51745.0 334293.0 376261.0 376744.1 376989.0 377998.1 28666.7 33234.2 33775.2 34293.5 34312.1 42609.8 42794.0 43083.8 43093.6 43186.6 35166.1 35400.6 35430.0 36196.9 36287.1 35562.3 36401.6 36505.3 36876.4 37553.8 34080.0 36141.0 37094.3 37172.6 37255.6 32063.5 32952.0 33057.0 33099.3 33268.8 21121.6 22837.0 24418.4 24563.6 24885.6 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33571.57 Median:14010.30 stddev:100845.32 (719.8%) stddev-sans-first:101097.29 19:28:56 INFO - PROCESS | 1670 | Values: 310.5 337.9 361.9 363.6 372.8 19978.0 19990.5 21179.5 21239.0 21350.0 19824.5 20886.0 20972.8 21285.8 21320.7 5731.7 5899.1 5943.8 5950.8 5961.2 4126.8 4444.2 5863.3 6471.1 6507.0 6252.4 6432.4 6442.6 6468.6 6492.3 6197.3 6269.9 6405.2 6464.7 6470.0 5512.2 5536.6 5544.8 5551.4 5563.8 25718.4 26339.6 26365.6 26497.5 26756.3 2039.2 2123.4 2198.7 2267.3 2302.3 7584.8 7760.8 14343.2 14630.6 14694.7 1505.2 1568.6 1660.9 1720.3 1723.8 99298.5 103771.0 104296.0 104920.0 107207.5 10383.3 10628.9 10887.6 10906.5 11030.4 13129.6 13187.9 13190.1 13209.4 13227.3 8621.7 8754.2 8780.9 8842.6 8875.1 9009.1 9039.4 9050.6 9146.8 9149.4 5402.8 6245.2 6355.8 6359.6 6366.3 1766.3 1806.7 1810.6 1813.1 1854.8 887.0 908.3 1005.1 1013.6 1084.6 20169.8 20416.5 20459.0 20811.5 21245.5 960.7 994.4 995.4 995.7 1057.1 11298.4 11417.5 11476.0 11495.5 11532.2 594931.0 597314.0 604293.0 624714.0 641831.0 63128.4 74585.3 82606.6 99674.0 99886.0 1030.6 1032.9 1059.9 1089.0 1090.3 19010.3 19079.6 19101.8 19125.9 19196.6 43496.1 48184.3 48517.8 49097.5 50304.0 66005.0 66718.3 66979.0 67139.0 69282.0 7897.4 7943.4 8022.0 8023.1 8081.3 12678.0 12858.5 13378.0 13440.0 13715.0 11395.0 11408.6 11522.9 11628.8 11831.5 11254.7 11305.5 11413.4 11632.7 11687.1 11494.3 11623.5 11857.9 11859.6 11887.3 6675.8 7791.7 7874.6 7887.5 8191.9 11502.7 11554.9 11800.9 11816.2 11817.2 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6142.99 Median:3018.84 stddev:3299.88 (109.3%) stddev-sans-first:3290.03 19:28:56 INFO - PROCESS | 1670 | Values: 1418.6 1573.1 1595.1 1890.1 2042.9 8082.6 8764.9 8959.7 8966.5 8971.8 8272.9 8496.2 8497.7 8502.7 8524.3 2148.5 2433.1 2435.1 2463.4 2503.8 2495.9 2508.2 2508.6 2510.6 2518.1 2379.4 2471.1 2491.2 2492.4 2493.6 2452.4 2486.0 2514.2 2517.0 2517.2 2456.2 2498.4 2513.0 2517.2 2519.2 9008.1 9106.2 9108.1 9114.7 9139.6 5511.3 5641.8 5657.3 5662.3 5673.1 3243.0 3571.8 3741.2 3741.6 3762.3 1033.6 1043.7 1051.4 1058.4 1066.9 12290.9 12343.4 12348.9 12367.5 12370.6 4952.5 4979.4 5064.6 5099.3 5100.0 10418.4 10428.7 10429.6 10461.7 10473.6 5624.7 5658.8 5662.2 5664.6 5665.5 4452.0 4543.9 4864.5 5018.3 5094.5 3960.2 4060.4 4066.5 4076.5 4131.6 1128.0 1318.5 1327.1 1331.1 1333.6 891.6 912.0 915.2 1151.5 1170.2 8233.1 8381.7 8391.5 8431.7 8460.7 505.6 516.8 520.0 521.3 526.4 6311.1 6336.7 6348.0 6357.2 6384.2 10633.9 11008.1 11049.8 11086.1 11104.1 10455.9 10822.5 10846.9 10848.2 10983.0 8434.2 8498.3 8530.4 8583.7 8597.5 6860.8 7543.8 8076.0 8130.8 8137.2 9535.0 9745.0 9792.9 9806.4 9986.6 9918.2 10133.5 10184.3 10195.0 10281.0 6371.8 6659.5 7592.1 7706.3 7728.7 8367.2 8383.7 8439.9 8453.2 8458.7 7385.8 7399.9 7424.7 7564.4 7614.7 6860.3 6876.3 7331.3 7439.1 7453.9 7848.8 7849.6 7901.3 7908.4 7920.4 7072.4 7107.7 7142.5 7155.5 7161.6 7256.0 7305.3 7324.9 7356.7 7389.3 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5796.74 Median:6595.83 stddev:1856.66 (28.1%) stddev-sans-first:1815.75 19:28:56 INFO - PROCESS | 1670 | Values: 318.0 321.4 327.4 328.0 331.1 6678.0 6680.5 6691.0 6698.2 6744.1 6548.9 6677.6 6682.3 6682.3 6686.7 4720.9 4800.9 4810.0 4830.8 4971.0 4926.6 4966.2 4970.2 4976.9 4986.1 4883.6 4909.7 4930.0 4931.7 4932.9 4668.3 4768.1 4770.1 4901.4 4917.9 4062.3 4083.9 4147.0 4160.8 4177.7 6373.8 6423.5 6427.8 6433.2 6462.7 5809.2 5814.7 5818.4 5822.2 5822.9 5737.6 7063.8 7074.9 7077.8 7094.6 4339.7 4536.4 4536.6 4539.9 4653.4 7429.4 7457.3 7505.5 7519.2 7538.4 4632.5 4635.3 4635.9 4641.8 4650.7 4699.5 4706.3 4706.4 4717.7 4718.3 5616.6 5623.6 5641.1 5641.8 5649.5 5982.9 6678.1 7082.5 7128.1 7129.4 1610.8 1619.2 1637.5 1637.9 1649.1 1031.4 1035.9 1056.8 1063.5 1064.1 6470.3 6642.7 6649.3 6655.2 6666.7 7301.2 7353.4 7446.3 7462.3 7479.9 6698.2 6699.5 6701.6 6703.1 6707.6 3918.4 3946.7 3953.5 3964.0 3969.9 7522.2 7777.3 7778.8 7812.1 7824.5 6239.8 7650.9 7683.8 7694.0 7703.3 6360.2 7732.5 7778.5 7792.5 7799.6 6061.3 7351.3 7420.4 7421.7 7436.7 7069.2 7304.0 7323.2 7326.6 7354.1 7715.2 7762.6 7798.7 7800.6 7804.5 4648.9 4655.5 4657.5 4672.7 4683.8 7386.4 7387.5 7392.7 7397.6 7404.6 6867.7 7101.0 7131.4 7143.2 7168.7 7065.4 7111.0 7121.9 7143.9 7144.8 5715.5 5775.5 6972.0 6983.5 6998.6 6087.8 6389.7 6834.6 6902.2 7119.9 6724.7 6945.1 6959.1 6977.4 7013.0 19:28:56 INFO - PROCESS | 1670 | 19:28:56 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18316.33 Median:629.17 stddev:26032.01 (4137.5%) stddev-sans-first:26071.62 19:28:56 INFO - PROCESS | 1670 | Values: 748.3 758.2 760.1 772.6 818.1 14931.4 14998.3 15177.8 15191.0 15300.7 14196.5 14222.0 14246.3 14259.9 14271.3 754.4 766.1 916.5 924.7 947.1 936.7 938.9 939.8 940.4 941.8 987.1 994.6 996.4 997.1 1001.7 782.4 791.1 794.1 989.4 989.6 582.2 712.8 722.8 724.8 726.3 13930.7 13940.8 13952.2 13970.9 14008.9 12890.3 12945.5 13126.8 13226.1 13400.7 9964.2 10118.8 10338.8 10497.9 10934.0 3550.4 3553.1 3593.9 3659.0 3707.2 81402.6 81802.6 81928.2 82114.8 82133.0 9435.0 9681.2 9786.1 9979.9 10426.6 22406.7 22588.0 22613.9 22771.8 22808.2 7489.9 7514.0 7614.3 7623.7 7693.5 4041.7 4096.3 4099.5 4099.5 4152.6 3663.8 3726.7 3727.4 3728.3 3741.4 621.1 632.3 637.3 639.1 644.9 575.6 578.3 612.5 620.7 626.1 7763.3 8252.4 8277.9 8303.5 8397.2 479.1 495.0 569.0 588.5 593.3 3692.2 3810.2 3818.6 3820.1 4052.5 90122.1 91243.0 91711.5 94567.1 95346.5 79062.0 79124.2 80303.6 81096.6 81151.6 67716.3 69612.0 70088.6 70121.3 70158.6 7654.5 7797.8 7838.3 7920.4 7933.0 51023.0 51353.0 51374.0 51720.4 51829.7 66634.3 68244.3 68379.3 69166.0 69167.0 10412.9 10426.8 10457.5 10639.7 10741.0 10592.5 10784.8 10928.0 11152.0 11711.0 10171.1 10551.8 10565.4 10638.2 10675.3 9960.2 10112.5 10504.8 10575.0 10603.9 9956.5 10422.9 10427.7 10506.6 10516.2 8756.3 8762.0 8822.3 8851.9 9009.2 8075.7 8713.1 8851.3 8864.8 8984.4 19:28:56 INFO - PROCESS | 1670 | -------- Summary: end -------- 19:28:56 INFO - PROCESS | 1670 | 19:28:57 INFO - TEST-INFO | 1670: exit 0 19:28:57 INFO - TEST-OK | dromaeo_css | took 1113874ms 19:28:57 INFO - TEST-START | kraken 19:28:57 INFO - operating with platform_type : mac_ 19:28:57 INFO - Initialising browser for kraken test... 19:28:57 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmp9VyN4z/profile http://localhost:49279/getInfo.html) 19:28:59 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 19:28:59 INFO - PROCESS | 1675 | colorDepth:24 19:28:59 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 19:28:59 INFO - PROCESS | 1675 | __metrics 19:28:59 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:28:59 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:29:00 INFO - TEST-INFO | 1675: exit 0 19:29:00 INFO - Browser initialized. 19:29:00 INFO - Running cycle 1/1 for kraken test... 19:29:00 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/T/tmp9VyN4z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:12 INFO - PROCESS | 1677 | RSS: Main: 243122176 19:29:12 INFO - PROCESS | 1677 | 19:29:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:15 INFO - PROCESS | 1677 | RSS: Main: 288350208 19:29:15 INFO - PROCESS | 1677 | 19:29:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 19:29:18 INFO - PROCESS | 1677 | RSS: Main: 300101632 19:29:18 INFO - PROCESS | 1677 | 19:29:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 19:29:22 INFO - PROCESS | 1677 | RSS: Main: 286875648 19:29:22 INFO - PROCESS | 1677 | 19:29:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 19:29:25 INFO - PROCESS | 1677 | RSS: Main: 289243136 19:29:25 INFO - PROCESS | 1677 | 19:29:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:27 INFO - PROCESS | 1677 | RSS: Main: 290603008 19:29:27 INFO - PROCESS | 1677 | 19:29:30 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:31 INFO - PROCESS | 1677 | RSS: Main: 290881536 19:29:31 INFO - PROCESS | 1677 | 19:29:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:34 INFO - PROCESS | 1677 | RSS: Main: 289091584 19:29:34 INFO - PROCESS | 1677 | 19:29:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 19:29:37 INFO - PROCESS | 1677 | RSS: Main: 292319232 19:29:37 INFO - PROCESS | 1677 | 19:29:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:40 INFO - PROCESS | 1677 | RSS: Main: 323932160 19:29:40 INFO - PROCESS | 1677 | 19:29:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:29:42 INFO - PROCESS | 1677 | RSS: Main: 326402048 19:29:42 INFO - PROCESS | 1677 | 19:29:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:29:45 INFO - PROCESS | 1677 | RSS: Main: 331902976 19:29:45 INFO - PROCESS | 1677 | 19:29:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:29:48 INFO - PROCESS | 1677 | RSS: Main: 332587008 19:29:48 INFO - PROCESS | 1677 | 19:29:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:29:51 INFO - PROCESS | 1677 | RSS: Main: 333082624 19:29:51 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 19:29:53 INFO - PROCESS | 1677 | RSS: Main: 392769536 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | __start_tp_report 19:29:53 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 19:29:53 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 19:29:53 INFO - PROCESS | 1677 | |i|pagename|runs| 19:29:53 INFO - PROCESS | 1677 | |0;ai-astar;113;108;113;113;110;112;115;112;113;112 19:29:53 INFO - PROCESS | 1677 | |1;audio-beat-detection;159;121;155;155;119;148;140;106;191;149 19:29:53 INFO - PROCESS | 1677 | |2;audio-dft;188;184;184;187;187;183;188;187;182;186 19:29:53 INFO - PROCESS | 1677 | |3;audio-fft;72;78;88;77;56;58;57;81;78;55 19:29:53 INFO - PROCESS | 1677 | |4;audio-oscillator;94;99;129;116;116;116;116;77;78;113 19:29:53 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;92;88;91;88;90;88;92;89;91;87 19:29:53 INFO - PROCESS | 1677 | |6;imaging-darkroom;95;96;99;96;95;95;96;100;120;96 19:29:53 INFO - PROCESS | 1677 | |7;imaging-desaturate;87;88;85;85;84;87;85;85;85;87 19:29:53 INFO - PROCESS | 1677 | |8;json-parse-financial;57;56;57;55;55;53;55;65;55;73 19:29:53 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;61;72;77;71;70;67;72;67;63;65 19:29:53 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;83;81;82;83;83;82;95;97;108;109 19:29:53 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;133;119;118;123;130;120;133;114;127;128 19:29:53 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;126;127;140;138;138;125;131;137;134;137 19:29:53 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;66;67;67;67;89;94;94;66;66;66 19:29:53 INFO - PROCESS | 1677 | __end_tp_report 19:29:53 INFO - PROCESS | 1677 | __start_cc_report 19:29:53 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1294 19:29:53 INFO - PROCESS | 1677 | __end_cc_report 19:29:53 INFO - PROCESS | 1677 | __startTimestamp1457494193612__endTimestamp 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | ------- Summary: start ------- 19:29:53 INFO - PROCESS | 1677 | Number of tests: 14 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 19:29:53 INFO - PROCESS | 1677 | Values: 113.0 108.0 113.0 113.0 110.0 112.0 115.0 112.0 113.0 112.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:152.00 stddev:24.34 (16.0%) stddev-sans-first:25.22 19:29:53 INFO - PROCESS | 1677 | Values: 159.0 121.0 155.0 155.0 119.0 148.0 140.0 106.0 191.0 149.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:185.60 Median:187.00 stddev:2.17 (1.2%) stddev-sans-first:2.12 19:29:53 INFO - PROCESS | 1677 | Values: 188.0 184.0 184.0 187.0 187.0 183.0 188.0 187.0 182.0 186.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:70.00 Median:77.50 stddev:12.29 (15.9%) stddev-sans-first:13.02 19:29:53 INFO - PROCESS | 1677 | Values: 72.0 78.0 88.0 77.0 56.0 58.0 57.0 81.0 78.0 55.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:103.00 stddev:17.61 (17.1%) stddev-sans-first:18.19 19:29:53 INFO - PROCESS | 1677 | Values: 94.0 99.0 129.0 116.0 116.0 116.0 116.0 77.0 78.0 113.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:90.50 stddev:1.84 (2.0%) stddev-sans-first:1.73 19:29:53 INFO - PROCESS | 1677 | Values: 92.0 88.0 91.0 88.0 90.0 88.0 92.0 89.0 91.0 87.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:96.00 stddev:7.64 (8.0%) stddev-sans-first:7.98 19:29:53 INFO - PROCESS | 1677 | Values: 95.0 96.0 99.0 96.0 95.0 95.0 96.0 100.0 120.0 96.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 19:29:53 INFO - PROCESS | 1677 | Values: 87.0 88.0 85.0 85.0 84.0 87.0 85.0 85.0 85.0 87.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:56.50 stddev:6.15 (10.9%) stddev-sans-first:6.51 19:29:53 INFO - PROCESS | 1677 | Values: 57.0 56.0 57.0 55.0 55.0 53.0 55.0 65.0 55.0 73.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:70.50 stddev:4.81 (6.8%) stddev-sans-first:4.27 19:29:53 INFO - PROCESS | 1677 | Values: 61.0 72.0 77.0 71.0 70.0 67.0 72.0 67.0 63.0 65.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:83.00 stddev:11.13 (13.4%) stddev-sans-first:11.48 19:29:53 INFO - PROCESS | 1677 | Values: 83.0 81.0 82.0 83.0 83.0 82.0 95.0 97.0 108.0 109.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:127.50 stddev:6.65 (5.2%) stddev-sans-first:6.31 19:29:53 INFO - PROCESS | 1677 | Values: 133.0 119.0 118.0 123.0 130.0 120.0 133.0 114.0 127.0 128.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.30 Median:137.00 stddev:5.62 (4.1%) stddev-sans-first:5.30 19:29:53 INFO - PROCESS | 1677 | Values: 126.0 127.0 140.0 138.0 138.0 125.0 131.0 137.0 134.0 137.0 19:29:53 INFO - PROCESS | 1677 | 19:29:53 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:67.00 stddev:12.59 (18.8%) stddev-sans-first:13.00 19:29:53 INFO - PROCESS | 1677 | Values: 66.0 67.0 67.0 67.0 89.0 94.0 94.0 66.0 66.0 66.0 19:29:53 INFO - PROCESS | 1677 | -------- Summary: end -------- 19:29:53 INFO - PROCESS | 1677 | 19:29:54 INFO - TEST-INFO | 1677: exit 0 19:29:54 INFO - TEST-OK | kraken | took 57049ms 19:29:54 INFO - SUITE-END | took 1170s 19:29:54 INFO - Completed test suite (00:19:31) 19:29:54 INFO - javascript benchmark 19:29:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3393.5079413485046, 3405.5062016007664, 3460.9307813843707, 3462.4460086386175, 3499.1602015516282, 5466.125419932811, 5491.093969495028, 5526.917096243559, 5536.778528858846, 5550.472705093015, 4701.50634183411, 5531.197976293435, 5561.193626924093, 5575.163725441186, 5690.374058853523, 4993.300937868701, 5025.849224523252, 5028.396592408916, 5029.245613158019, 5186.273921650953, 5119.667221630601, 5160.767765450545, 5161.819336323229, 5166.199239117943, 5234.188700751371, 5020.548150666457, 5044.319016932704, 5069.721165335905, 5083.830718934629, 5118.897622047557, 5047.268146118829, 5063.8480845574695, 5071.188609822448, 5072.923906141411, 5181.637285390024, 5007.799688012475, 5039.143345631252, 5042.294078828967, 5069.214271787879, 5103.055934652101, 5351.518363347317, 5438.945610543883, 5440.211169380417, 5446.210299506589, 5450.4549545045575, 6121.143039974407, 6128.662923539204, 6133.355997620275, 6147.139400483891, 6156.56904016719, 6090.5736598438125, 6124.755009799603, 6128.0, 6142.232220972379, 6168.722407491674, 5589.385167631557, 5605.887882242332, 5629.774809007635, 5636.718164091779, 5637.408072152406, 6114.3277820888225, 6158.829822333742, 6180.938190618126, 6195.876082478325, 6203.2556093269095, 5958.672273025025, 5978.990051580701, 6014.248218972629, 6025.6083354581815, 6047.365026672224, 6104.4505994460715, 6139.584134579375, 6154.907676384858, 6165.691715414211, 6172.938270617326, 6033.758649653964, 6091.634501929899, 6115.027386288435, 6115.909724157157, 6140.0, 6075.149479072933, 6075.908861367083, 6093.817185484442, 6100.816975490742, 6113.388661133851, 4278.828846846091, 4683.906321873544, 4751.144793937125, 4795.448523419782, 4805.9759701201965, 4245.066085461193, 4296.183725092223, 4334.5882141196535, 4376.671749618791, 4394.934075988863, 5491.121420572689, 5493.670379777226, 5519.972400137974, 5521.558275337963, 5535.7785688572, 5379.515843574019, 5872.649290663086, 6197.907031394533, 6202.56582039262, 6204.286507051656, 5512.310961129859, 5527.751251193706, 5530.225768392428, 5565.38780734127, 5583.190437386637, 5240.9213861792105, 5254.684718916801, 5263.526282634582, 5263.6578622389425, 5263.973680131651, 6152.415520525543, 6221.097940798559, 6233.096201050822, 6234.0337247726675, 6244.0, 6100.30868792748, 6146.5390095742105, 6165.075238714228, 6179.721912513858, 6180.81457556274, 6175.536834737323, 6207.875842483035, 6216.595921265103, 6228.813135605939, 6245.125682404558, 5048.293238946477, 5959.135925290895, 6034.456898878946, 6076.605020673642, 6076.787312444043, 6133.120447061136, 6177.042558403455, 6194.535409844189, 6194.659293738888, 6195.318514963441, 5792.768289268382, 5795.985702501961, 5814.331351894586, 5833.416658334133, 5870.823875283578, 5780.710964451845, 5808.709564521672, 5809.041508151107, 5830.358660547252, 5875.618084824473, 5835.67903765297, 5847.590668653153, 5874.441928016831, 5881.647101173943, 5899.439553242435, 5796.76812927495, 5960.737656157015, 5974.970125149346, 6023.698815059141, 6027.819165425044, 5893.263342082239, 5898.94101058984, 5927.110933360031, 5935.940640593712, 5941.287045554388], "unit": "score", "name": "dojo.html", "value": 5563.766665722296}, {"lowerIsBetter": false, "replicates": [485.2963203355136, 565.2933832709114, 576.9826905192846, 631.7536160897251, 634.9269833969093, 33148.0, 39876.60123398769, 39905.800470997674, 39929.401058984105, 39942.201155976865, 35679.64320356795, 42962.355564666475, 43757.78121109398, 43775.56224437755, 43905.78047109768, 8418.452800567975, 9611.231101511863, 9843.0, 9846.556904939294, 9853.310268281222, 9656.5171741413, 9755.41467511948, 9837.0, 9838.06538378853, 9845.55694993727, 9904.0, 9999.150072243869, 10011.24915631327, 10021.949890250538, 10025.849612255823, 9875.802483950316, 9963.601455941754, 9980.80038399228, 9986.001399860028, 10011.949940250252, 9791.559379827924, 9909.0, 9935.552900119512, 9944.850827237597, 9964.153046991014, 42866.14267714628, 43274.134517309474, 43294.70115896496, 43373.56626433727, 43532.56467435317, 3302.3230237801195, 3347.0126312737802, 3396.201892555272, 3507.824608769551, 3835.616438356142, 29095.70904290951, 29740.66167022489, 30435.543466848016, 30608.0, 30670.079897603107, 2702.6891907430504, 2720.91837244883, 2741.575055866344, 2801.7338352856445, 2829.4906916754976, 493830.0, 500917.0, 501582.0, 501617.0, 502306.0, 45525.54474455279, 46038.539614604095, 46090.0, 54476.0, 69525.65237173781, 46011.53988460072, 46103.30845037327, 46127.308090378, 46295.0, 46347.07305853932, 15472.0, 15604.531864044096, 15633.765493517607, 15669.451569195024, 15699.68600627981, 12535.0, 12566.874331256571, 12585.37073146339, 12586.874131258754, 12603.18079324841, 15003.624909377353, 15107.018043827336, 15146.848531514544, 15158.621034474007, 15360.923195383952, 6371.23545174582, 6503.4146926775875, 6527.608343499405, 6529.836754081186, 6534.477241820643, 948.9430634161972, 968.9903100969041, 983.4443539400216, 987.1905037868878, 1081.7457897394106, 25236.87381563117, 29568.0, 29652.110436686933, 30131.548026779616, 30219.69780302169, 1062.7024433158729, 1101.1136035491347, 1113.6158025481195, 1169.7543515861594, 1187.1749134351542, 14963.177025263498, 15014.699706005818, 15034.323455444532, 15397.307121179574, 15588.376464941275, 523776.0, 527878.0, 532701.0, 534908.0, 536051.0, 60483.395166047776, 62233.68883155646, 62346.0, 62360.0, 62732.0, 1307.1111644081925, 1350.1763924006348, 1445.6674964758165, 1450.2531196433845, 1481.1483397046525, 28643.427131457673, 28716.851325947562, 29481.968131115307, 29717.70282297236, 30134.0, 50337.49662503474, 51215.0, 51590.0, 51617.48382516127, 51745.0, 334293.0, 376261.0, 376744.11627941683, 376989.0, 377998.1100094482, 28666.713332866406, 33234.16914577155, 33775.15562110967, 34293.48559771555, 34312.14219644529, 42609.78695106505, 42794.0, 43083.78458107689, 43093.569064310206, 43186.56813431951, 35166.12084697903, 35400.64599354076, 35430.0, 36196.914092577266, 36287.092822679646, 35562.28875422529, 36401.635983639826, 36505.26989460249, 36876.446853296686, 37553.81223093867, 34080.0, 36141.0, 37094.25811483809, 37172.62827371692, 37255.627443725214, 32063.47301796847, 32952.0, 33057.0, 33099.338013240085, 33268.833655831564, 21121.577568448236, 22837.0, 24418.389540260923, 24563.631545526474, 24885.626715599643], "unit": "score", "name": "ext.html", "value": 19226.871799396074}, {"lowerIsBetter": false, "replicates": [310.4706475459342, 337.87667501362, 361.9124530784991, 363.63454727998374, 372.80055170483797, 19978.0, 19990.50023749407, 21179.47051323718, 21239.04424300908, 21350.0, 19824.504387390323, 20885.955702214906, 20972.79785622507, 21285.787142128574, 21320.680189797127, 5731.742071606777, 5899.144624029514, 5943.762249510014, 5950.79172228972, 5961.165436838846, 4126.793660316987, 4444.177827101997, 5863.2670916135485, 6471.061696054069, 6506.967465162667, 6252.406021427957, 6432.388923052303, 6442.613443193423, 6468.611883286994, 6492.318306577812, 6197.349278325801, 6269.874602507947, 6405.19935008124, 6464.676766161697, 6469.997150441713, 5512.173174023928, 5536.640118392332, 5544.805931792408, 5551.444855514456, 5563.833085007415, 25718.357041074123, 26339.604905926426, 26365.604515932275, 26497.470050599073, 26756.331091722666, 2039.225094464109, 2123.3629911026783, 2198.659207822774, 2267.30847091637, 2302.2517681753498, 7584.772456826304, 7760.805979850493, 14343.21112338821, 14630.561083167522, 14694.706105877929, 1505.2473763118442, 1568.643123697993, 1660.9169541522876, 1720.346268417993, 1723.8448539631493, 99298.50350748272, 103771.0, 104295.99999999924, 104920.0, 107207.46396268047, 10383.273170877967, 10628.946855265674, 10887.618933337295, 10906.5092070857, 11030.393328366856, 13129.60611181666, 13187.93406032983, 13190.076694631283, 13209.40557674907, 13227.338633068308, 8621.698240561676, 8754.21212090915, 8780.868286975701, 8842.557872106368, 8875.112488751203, 9009.054049324857, 9039.367244292836, 9050.637974481078, 9146.771330716785, 9149.35954483193, 5402.756875940592, 6245.188125543741, 6355.809325720235, 6359.554831161867, 6366.331535188831, 1766.3023105873108, 1806.7380229866596, 1810.5564136786572, 1813.0934532733634, 1854.8145185481615, 886.9645214191489, 908.3232991421302, 1005.1054561440324, 1013.6097602422973, 1084.5878566144816, 20169.781324054344, 20416.489587760425, 20459.0, 20811.479713007295, 21245.46886327823, 960.6541645007792, 994.4431118573622, 995.4226548601794, 995.6963126246419, 1057.143713591993, 11298.410008473375, 11417.543298267976, 11476.024537914203, 11495.54017839277, 11532.192746507664, 594931.0, 597314.0, 604293.0, 624714.0, 641831.0, 63128.36871631317, 74585.25414745783, 82606.58696706478, 99674.0, 99886.0, 1030.6083688198437, 1032.9225308101772, 1059.8569193158978, 1088.9945550272198, 1090.3457925244948, 19010.334638288146, 19079.618407632046, 19101.808981910002, 19125.90437047806, 19196.61606767829, 43496.130077398906, 48184.27723584219, 48517.75741121272, 49097.50902491072, 50304.0, 66005.0, 66718.33204169935, 66979.0, 67138.99291510729, 69281.96077058949, 7897.368210543028, 7943.4042446817875, 8022.0, 8023.077346105272, 8081.272685458337, 12678.0, 12858.549950752053, 13378.0, 13440.0, 13715.0, 11395.0, 11408.600698975495, 11522.884771152516, 11628.767424651629, 11831.526738930346, 11254.662360129209, 11305.491252893804, 11413.372264525531, 11632.651020469399, 11687.123465739933, 11494.252873563191, 11623.476943537393, 11857.940710296394, 11859.644210673694, 11887.346195959306, 6675.833104172434, 7791.688332466638, 7874.606269686607, 7887.526748395115, 8191.918080819116, 11502.712432189262, 11554.884451155382, 11800.940995294968, 11816.231944923553, 11817.172797904408], "unit": "score", "name": "jquery.html", "value": 9542.89254583944}, {"lowerIsBetter": false, "replicates": [1418.588609303302, 1573.1269145624178, 1595.0668858717654, 1890.092755477371, 2042.8570000099999, 8082.555459449728, 8764.8685269721, 8959.686410975617, 8966.506842123681, 8971.775705607362, 8272.917270827289, 8496.192861678146, 8497.660093596263, 8502.744917652464, 8524.318054555637, 2148.5058436559602, 2433.051110067075, 2435.0625009371342, 2463.4457247119344, 2503.812214083942, 2495.8752062396898, 2508.1973768394123, 2508.586083296254, 2510.623406489023, 2518.1438310974263, 2379.4051487128218, 2471.122751423246, 2491.202815099169, 2492.3519884829893, 2493.5760920643443, 2452.4359397338535, 2485.962710559343, 2514.170323793162, 2516.9748302516923, 2517.2196619048154, 2456.2262887190477, 2498.4253621667117, 2513.0324824942345, 2517.1944977607172, 2519.231634351522, 9008.099190080939, 9106.180443760093, 9108.134727200906, 9114.726558203265, 9139.588718507683, 5511.255980442629, 5641.830745077655, 5657.321121465409, 5662.348829884533, 5673.149027645845, 3242.951355729666, 3571.7678350907368, 3741.1769410729594, 3741.6071312512067, 3762.3415902217275, 1033.5762337441613, 1043.7495001199657, 1051.3586712105687, 1058.3755584205355, 1066.9306495077794, 12290.938545307215, 12343.382830858422, 12348.938255308756, 12367.505299787998, 12370.62888113358, 4952.504749525091, 4979.3526841510375, 5064.569511591556, 5099.286099946011, 5099.980003999215, 10418.374897506023, 10428.739281517872, 10429.634962776267, 10461.738456538647, 10473.581056757645, 5624.6625202487985, 5658.783361577281, 5662.207290979266, 5664.631798933056, 5665.49010589049, 4451.955480445219, 4543.863684089482, 4864.489228630943, 5018.3476148101245, 5094.465081166498, 3960.20795840833, 4060.4112403701297, 4066.4916885389325, 4076.510818701775, 4131.648809851136, 1128.0, 1318.5253308808822, 1327.0975736499274, 1331.0682522234474, 1333.646583655332, 891.5809569502323, 912.0150237743221, 915.2449229385651, 1151.4645689754304, 1170.1925671286785, 8233.053198882086, 8381.748547543584, 8391.496510209407, 8431.74704758846, 8460.661573537112, 505.6031015652695, 516.767454645411, 519.966202196856, 521.2780299285516, 526.431454029647, 6311.116443697886, 6336.714847831859, 6348.0, 6357.237131544151, 6384.201974753156, 10633.893661063445, 11008.119350451945, 11049.834252486218, 11086.057685096857, 11104.056155226895, 10455.895441045492, 10822.458877056273, 10846.94576527128, 10848.186386020921, 10983.0, 8434.198751118634, 8498.277646400002, 8530.445521041112, 8583.742487725378, 8597.52713600758, 6860.828479288058, 7543.7736867894055, 8076.0, 8130.75607731769, 8137.186281371815, 9535.0, 9744.951275243578, 9792.902070979198, 9806.411615303105, 9986.60053597848, 9918.20654347636, 10133.543990520297, 10184.287099903231, 10195.0, 10281.0, 6371.808845734636, 6659.467242620482, 7592.088949326117, 7706.267904549059, 7728.729494467667, 8367.246947774729, 8383.706570270011, 8439.915600843913, 8453.154684531497, 8458.746237612635, 7385.8153546161775, 7399.852002960019, 7424.740134095281, 7564.432667550066, 7614.657340419805, 6860.279670634512, 6876.277990810893, 7331.340179383881, 7439.107307123179, 7453.888191677021, 7848.7645370638975, 7849.646765895434, 7901.288884000468, 7908.4464087513325, 7920.366370690215, 7072.3634872861685, 7107.715691372494, 7142.5000249982, 7155.4633402496065, 7161.641917904188, 7255.984162217399, 7305.269473052652, 7324.926750732425, 7356.742514011984, 7389.334959853639], "unit": "score", "name": "mootools.html", "value": 4880.146528402746}, {"lowerIsBetter": false, "replicates": [317.9634342050664, 321.3572854291417, 327.42805264646216, 327.96064472263316, 331.06804345766665, 6677.966610166948, 6680.532362734611, 6690.96654516728, 6698.196216454026, 6744.055832183498, 6548.934510654892, 6677.599344039361, 6682.29835867233, 6682.331766823315, 6686.732530698766, 4720.858374248761, 4800.855974320759, 4810.0, 4830.806767729287, 4970.956099219159, 4926.605871530269, 4966.230234313687, 4970.204767237243, 4976.850694479153, 4986.077575648516, 4883.609311255091, 4909.705417674933, 4929.975350123263, 4931.704097754128, 4932.876678083041, 4668.253079507263, 4768.070226305872, 4770.0698363819065, 4901.362822833027, 4917.877053073666, 4062.3094074007195, 4083.9387409188885, 4146.963259185204, 4160.771157586331, 4177.665786737084, 6373.8406539836415, 6423.454006409461, 6427.8393040173905, 6433.228012638513, 6462.741490340381, 5809.2447981762525, 5814.680192589406, 5818.41815818419, 5822.214001109838, 5822.883542329129, 5737.627054241461, 7063.788086357417, 7074.893876591856, 7077.823054423629, 7094.609796461193, 4339.696221264513, 4536.410266665345, 4536.637069034469, 4539.886502837422, 4653.441587009546, 7429.442791790637, 7457.291557302047, 7505.549667020051, 7519.172890981988, 7538.434617403716, 4632.467266264355, 4635.281531362577, 4635.907281854412, 4641.791119399635, 4650.744209068466, 4699.506551812079, 4706.3175839503765, 4706.411698537683, 4717.740524271129, 4718.292256161603, 5616.606837521416, 5623.606347555714, 5641.12562552805, 5641.80253691127, 5649.4633009864, 5982.923073846662, 6678.1318428604945, 7082.468814838805, 7128.144622645212, 7129.394001509826, 1610.846969537892, 1619.2470501216756, 1637.4760076775317, 1637.8607818335336, 1649.1012398242985, 1031.4327120083924, 1035.9119474844572, 1056.8414737789394, 1063.4895250279753, 1064.084886997182, 6470.288268290485, 6642.7342906284175, 6649.335066493312, 6655.201375834931, 6666.733330666719, 7301.160366557808, 7353.374963128087, 7446.292602202782, 7462.253774622494, 7479.925200748032, 6698.162729658793, 6699.464042876558, 6701.597904125768, 6703.061571380011, 6707.5975441473665, 3918.431827385013, 3946.7039972002217, 3953.486046813953, 3964.0288129408477, 3969.940450893239, 7522.247775222434, 7777.338926191337, 7778.844423111506, 7812.140664526897, 7824.452288339761, 6239.812805615748, 7650.923490765133, 7683.846323073507, 7694.038245219348, 7703.345215656732, 6360.236771587347, 7732.536047837148, 7778.49439786412, 7792.454528182972, 7799.571023593757, 6061.333253342217, 7351.301626345488, 7420.369268612229, 7421.740239091606, 7436.702531898663, 7069.187043490065, 7304.0, 7323.157836848831, 7326.633668316456, 7354.117505899112, 7715.228477152465, 7762.611869406394, 7798.688052477837, 7800.570968596781, 7804.453688241769, 4648.883777905579, 4655.487896331333, 4657.48767635553, 4672.719636821802, 4683.836065737819, 7386.372158366599, 7387.482876198829, 7392.741254056083, 7397.630118494161, 7404.555726656418, 6867.725290988305, 7100.964495177491, 7131.42948564124, 7143.214246432992, 7168.749093781693, 7065.364117229474, 7110.964445177741, 7121.893171602326, 7143.928560714534, 7144.785656430316, 5715.514181294637, 5775.509081727932, 6971.965140174267, 6983.476239282176, 6998.580085194904, 6087.8128764890425, 6389.680515974275, 6834.589924604539, 6902.171739391305, 7119.857602848017, 6724.697388617622, 6945.062416573698, 6959.130108736408, 6977.3720365165345, 7012.964935175291], "unit": "score", "name": "prototype.html", "value": 5171.996935653051}, {"lowerIsBetter": false, "replicates": [748.3003391828637, 758.1698040645495, 760.0840986611131, 772.6445834915938, 818.067403160397, 14931.402743890232, 14998.325075371607, 15177.772333414994, 15191.0, 15300.693986120272, 14196.503122390719, 14222.004459687825, 14246.287685615704, 14259.92870035651, 14271.286435678201, 754.3814072460584, 766.0577489687687, 916.5463095767604, 924.6763632728558, 947.0718695678239, 936.6955739384694, 938.9014153513851, 939.821433927555, 940.3605548227202, 941.8022215334788, 987.1313244344966, 994.5872462927877, 996.3772642098688, 997.0976266478848, 1001.694483182629, 782.3623746646465, 791.0902462168494, 794.0749027383092, 989.3865803202025, 989.6239429016963, 582.1762206477829, 712.7576623947882, 722.7542635503954, 724.807925899637, 726.259215600085, 13930.651733706738, 13940.790888136686, 13952.2326272055, 13970.860291397159, 14008.929955350159, 12890.291033993126, 12945.482180712761, 13126.803097953538, 13226.140300880412, 13400.731985360238, 9964.20286377088, 10118.797624047551, 10338.793224135476, 10497.9475102624, 10933.961273678988, 3550.431930891045, 3553.1117220694828, 3593.8562457501666, 3658.993776711399, 3707.1757709229314, 81402.59298703528, 81802.59098704527, 81928.18071819325, 82114.76827847587, 82133.0, 9435.0, 9681.225501959827, 9786.1192492676, 9979.850302245472, 10426.635067772591, 22406.663900041513, 22587.983540740704, 22613.88693056524, 22771.772282276965, 22808.20171293997, 7489.85020299591, 7513.962430187923, 7614.314711675976, 7623.656935437919, 7693.49992250502, 4041.7170798043853, 4096.283150448659, 4099.467069281034, 4099.508059032875, 4152.626263636287, 3663.816809159585, 3726.7391282610497, 3727.3849814780256, 3728.3102626014274, 3741.4013757799166, 621.0559948877681, 632.250782822357, 637.3021541412146, 639.1180171363488, 644.9161608990895, 575.6315957787019, 578.3435800366531, 612.5038718637918, 620.7423919073534, 626.0921663587816, 7763.262490063435, 8252.381071419668, 8277.917220827836, 8303.543305118155, 8397.244248017585, 479.14472666290504, 495.02727141167776, 569.0269638917498, 588.5027152056506, 593.2732402806528, 3692.2430901665093, 3810.237952409529, 3818.579956204815, 3820.140468394589, 4052.5339585947404, 90122.09877901268, 91243.0, 91711.54144229236, 94567.05432945583, 95346.52326738322, 79062.0, 79124.20875791284, 80303.59848200722, 81096.59451702704, 81151.59424202959, 67716.3070923221, 69612.0, 70088.64955675189, 70121.29878701249, 70158.59682806315, 7654.502457340478, 7797.752359622433, 7838.3337416320255, 7920.366370690215, 7933.0, 51023.0, 51353.0, 51374.0, 51720.448386548465, 51829.7408512955, 66634.33365666281, 68244.31755682579, 68379.31620683729, 69166.0, 69166.96249556361, 10412.895871041193, 10426.791464170827, 10457.477126143815, 10639.734006649585, 10741.0, 10592.470376480991, 10784.784304314027, 10928.0, 11152.0, 11711.0, 10171.135453486537, 10551.841722374016, 10565.418901960466, 10638.202134840072, 10675.252732308663, 9960.203183745138, 10112.544935478069, 10504.842427363443, 10575.048245657928, 10603.94698026505, 9956.452395118338, 10422.947885260524, 10427.739306517095, 10506.579736810441, 10516.211284153565, 8756.25571826402, 8762.02725766153, 8822.25010874083, 8851.867221991804, 9009.189172974464, 8075.717349892726, 8713.085126061926, 8851.336149788664, 8864.822703546022, 8984.371094023356], "unit": "score", "name": "yui.html", "value": 6832.946749192385}], "name": "dromaeo_css", "value": 7486.5527617591015}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 113.0, 113.0, 110.0, 112.0, 115.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [159.0, 121.0, 155.0, 155.0, 119.0, 148.0, 140.0, 106.0, 191.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [188.0, 184.0, 184.0, 187.0, 187.0, 183.0, 188.0, 187.0, 182.0, 186.0], "unit": "score", "name": "audio-dft", "value": 185.6}, {"lowerIsBetter": true, "replicates": [72.0, 78.0, 88.0, 77.0, 56.0, 58.0, 57.0, 81.0, 78.0, 55.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [94.0, 99.0, 129.0, 116.0, 116.0, 116.0, 116.0, 77.0, 78.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [92.0, 88.0, 91.0, 88.0, 90.0, 88.0, 92.0, 89.0, 91.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 99.0, 96.0, 95.0, 95.0, 96.0, 100.0, 120.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 98.8}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 85.0, 85.0, 84.0, 87.0, 85.0, 85.0, 85.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 55.0, 55.0, 53.0, 55.0, 65.0, 55.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [61.0, 72.0, 77.0, 71.0, 70.0, 67.0, 72.0, 67.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 82.0, 83.0, 83.0, 82.0, 95.0, 97.0, 108.0, 109.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.3}, {"lowerIsBetter": true, "replicates": [133.0, 119.0, 118.0, 123.0, 130.0, 120.0, 133.0, 114.0, 127.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 140.0, 138.0, 138.0, 125.0, 131.0, 137.0, 134.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 89.0, 94.0, 94.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.2}], "name": "kraken", "value": 1440.5}]} 19:29:54 INFO - Return code: 0 19:29:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:29:54 ERROR - # TBPL SUCCESS # 19:29:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:29:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:29:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:29:54 INFO - 2016-03-08 19:29:54.934 screenresolution[1681:10375] starting screenresolution argv=screenresolution get 19:29:54 INFO - 2016-03-08 19:29:54.936 screenresolution[1681:10375] Display 0: 1600x1200x32@60 19:29:54 INFO - 2016-03-08 19:29:54.942 screenresolution[1682:10378] starting screenresolution argv=screenresolution list 19:29:54 INFO - Available Modes on Display 0 19:29:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:29:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:29:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:29:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:29:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:29:55 INFO - Intel Iris: 19:29:55 INFO - Chipset Model: Intel Iris 19:29:55 INFO - Type: GPU 19:29:55 INFO - Bus: Built-In 19:29:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:29:55 INFO - Vendor: Intel (0x8086) 19:29:55 INFO - Device ID: 0x0a2e 19:29:55 INFO - Revision ID: 0x0009 19:29:55 INFO - Displays: 19:29:55 INFO - Display: 19:29:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:29:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:29:55 INFO - Display Serial Number: 1600x1200 60 19:29:55 INFO - Main Display: Yes 19:29:55 INFO - Mirror: Off 19:29:55 INFO - Online: Yes 19:29:55 INFO - Rotation: Supported 19:29:55 INFO - Return code: 0 19:29:55 INFO - Running post-action listener: _resource_record_post_action 19:29:55 INFO - Running post-run listener: _resource_record_post_run 19:29:56 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34209280; Write bytes: 706004992; Read time: 352; Write time: 2001 19:29:56 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384565760; Write bytes: 378402304; Read time: 29665; Write time: 693 19:29:56 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33168896; Write bytes: 301464576; Read time: 337; Write time: 1181 19:29:56 INFO - Running post-run listener: _upload_blobber_files 19:29:56 INFO - Blob upload gear active. 19:29:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:29:56 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 19:29:56 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'] 19:29:56 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 19:29:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:57 INFO - (blobuploader) - INFO - Done attempting. 19:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:29:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:59 INFO - (blobuploader) - INFO - Done attempting. 19:29:59 INFO - (blobuploader) - INFO - Iteration through files over. 19:29:59 INFO - Return code: 0 19:29:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:29:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:29:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4038dc3cdcf47a1337feab1f1b6ba936d89b00fbb2105135c69a468b0091d386b17aaf9474f5536899cb560b145e51db8e93c6d4a52165b256e999fde3a85347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7853e44c28d6394c9015f49c895a426dc08cce6217fddddff58536b14bf63adfc5ac28611f0ee9961796d2f79b818e824f99e9222de9b87f3fb5d3d526d111"} 19:29:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:29:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:29:59 INFO - Contents: 19:29:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4038dc3cdcf47a1337feab1f1b6ba936d89b00fbb2105135c69a468b0091d386b17aaf9474f5536899cb560b145e51db8e93c6d4a52165b256e999fde3a85347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7853e44c28d6394c9015f49c895a426dc08cce6217fddddff58536b14bf63adfc5ac28611f0ee9961796d2f79b818e824f99e9222de9b87f3fb5d3d526d111"} 19:29:59 INFO - Running post-run listener: copy_logs_to_upload_dir 19:29:59 INFO - Copying logs to upload dir... 19:29:59 INFO - mkdir: /builds/slave/test/build/upload/logs 19:29:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.662188 ========= master_lag: 1.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-08 19:30:00.978424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 19:30:00.982220) ========= 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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4038dc3cdcf47a1337feab1f1b6ba936d89b00fbb2105135c69a468b0091d386b17aaf9474f5536899cb560b145e51db8e93c6d4a52165b256e999fde3a85347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7853e44c28d6394c9015f49c895a426dc08cce6217fddddff58536b14bf63adfc5ac28611f0ee9961796d2f79b818e824f99e9222de9b87f3fb5d3d526d111"} build_url:https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/AgzQgui-QxKjjL8vJZi4sw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4038dc3cdcf47a1337feab1f1b6ba936d89b00fbb2105135c69a468b0091d386b17aaf9474f5536899cb560b145e51db8e93c6d4a52165b256e999fde3a85347", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d7853e44c28d6394c9015f49c895a426dc08cce6217fddddff58536b14bf63adfc5ac28611f0ee9961796d2f79b818e824f99e9222de9b87f3fb5d3d526d111"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 19:30:01.016001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:30:01.016335) ========= 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.KBDWILLP1n/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.G0ihs7KlqQ/Listeners TMPDIR=/var/folders/2f/bd59dv5s1jjgys2lwzvcz7vm00000w/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.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 19:30:01.064631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 19:30:01.064942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 19:30:01.065297) ========= ========= Total master_lag: 8.90 =========