builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0085 starttime: 1458090292.52 results: success (0) buildid: 20160315161347 builduid: f5b023176f584401ad3f894e39184a23 revision: 0b6f231921d4a102e5258dd5bb4b03df7bea369a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.530165) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.530698) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.531043) ========= 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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005681 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.602961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.603278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.640042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.640383) ========= 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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005766 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.699836) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.700136) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.700504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:52.700833) ========= 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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-15 18:04:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2016-03-15 18:04:53 (14.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.531386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:53.255556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:53.255890) ========= 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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.026327 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:53.309547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 18:04:53.309906) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0b6f231921d4a102e5258dd5bb4b03df7bea369a --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 0b6f231921d4a102e5258dd5bb4b03df7bea369a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-15 18:04:53,380 truncating revision to first 12 chars 2016-03-15 18:04:53,381 Setting DEBUG logging. 2016-03-15 18:04:53,381 attempt 1/10 2016-03-15 18:04:53,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0b6f231921d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 18:04:54,402 unpacking tar archive at: fx-team-0b6f231921d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272444 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 18:04:54.612448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:54.613074) ========= echo 0b6f231921d4a102e5258dd5bb4b03df7bea369a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0b6f231921d4a102e5258dd5bb4b03df7bea369a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 0b6f231921d4a102e5258dd5bb4b03df7bea369a program finished with exit code 0 elapsedTime=0.005337 script_repo_revision: '0b6f231921d4a102e5258dd5bb4b03df7bea369a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:54.666958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:54.667274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 18:04:54.685333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2016-03-15 18:04:54.685854) ========= /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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:04:54 INFO - MultiFileLogger online at 20160315 18:04:54 in /builds/slave/test 18:04:54 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 18:04:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:54 INFO - {'append_to_log': False, 18:04:54 INFO - 'base_work_dir': '/builds/slave/test', 18:04:54 INFO - 'blob_upload_branch': 'Fx-Team', 18:04:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:54 INFO - 'branch': 'Fx-Team', 18:04:54 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:54 INFO - 'config_files': ('talos/mac_config.py',), 18:04:54 INFO - 'default_actions': ('clobber', 18:04:54 INFO - 'read-buildbot-config', 18:04:54 INFO - 'download-and-extract', 18:04:54 INFO - 'populate-webroot', 18:04:54 INFO - 'create-virtualenv', 18:04:54 INFO - 'install', 18:04:54 INFO - 'run-tests'), 18:04:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:54 INFO - 'download_minidump_stackwalk': True, 18:04:54 INFO - 'download_symbols': 'ondemand', 18:04:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:54 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:54 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:54 INFO - 'installer_path': 'installer.exe', 18:04:54 INFO - 'log_level': 'info', 18:04:54 INFO - 'log_name': 'talos', 18:04:54 INFO - 'log_to_console': True, 18:04:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:04:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:04:54 INFO - 'opt_config_files': (), 18:04:54 INFO - 'pip_index': False, 18:04:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:54 INFO - 'cmd': ('bash', 18:04:54 INFO - '-c', 18:04:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:54 INFO - 'enabled': True, 18:04:54 INFO - 'halt_on_failure': False, 18:04:54 INFO - 'name': 'check_screen_resolution'},), 18:04:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:54 INFO - 'cmd': ('bash', 18:04:54 INFO - '-c', 18:04:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:54 INFO - 'enabled': True, 18:04:54 INFO - 'halt_on_failure': False, 18:04:54 INFO - 'name': 'check_screen_resolution'},), 18:04:54 INFO - 'run_cmd_checks_enabled': True, 18:04:54 INFO - 'sps_profile': False, 18:04:54 INFO - 'sps_profile_interval': 0, 18:04:54 INFO - 'suite': 'dromaeojs', 18:04:54 INFO - 'system_bits': '32', 18:04:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:54 INFO - 'title': 't-yosemite-r7-0085', 18:04:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:54 INFO - 'use_talos_json': True, 18:04:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:54 INFO - 'work_dir': 'build'} 18:04:54 INFO - ##### 18:04:54 INFO - ##### Running clobber step. 18:04:54 INFO - ##### 18:04:54 INFO - Running pre-action listener: _resource_record_pre_action 18:04:54 INFO - Running main action method: clobber 18:04:54 INFO - rmtree: /builds/slave/test/build 18:04:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:56 INFO - Running post-action listener: _resource_record_post_action 18:04:56 INFO - ##### 18:04:56 INFO - ##### Running read-buildbot-config step. 18:04:56 INFO - ##### 18:04:56 INFO - Running pre-action listener: _resource_record_pre_action 18:04:56 INFO - Running main action method: read_buildbot_config 18:04:56 INFO - Using buildbot properties: 18:04:56 INFO - { 18:04:56 INFO - "project": "", 18:04:56 INFO - "product": "firefox", 18:04:56 INFO - "script_repo_revision": "production", 18:04:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:04:56 INFO - "repository": "", 18:04:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:04:56 INFO - "buildid": "20160315161347", 18:04:56 INFO - "pgo_build": "False", 18:04:56 INFO - "basedir": "/builds/slave/test", 18:04:56 INFO - "buildnumber": 535, 18:04:56 INFO - "slavename": "t-yosemite-r7-0085", 18:04:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:04:56 INFO - "platform": "yosemite_r7", 18:04:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:04:56 INFO - "branch": "fx-team", 18:04:56 INFO - "repo_path": "integration/fx-team", 18:04:56 INFO - "revision": "0b6f231921d4a102e5258dd5bb4b03df7bea369a", 18:04:56 INFO - "stage_platform": "macosx64", 18:04:56 INFO - "builduid": "f5b023176f584401ad3f894e39184a23", 18:04:56 INFO - "slavebuilddir": "test" 18:04:56 INFO - } 18:04:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:04:56 INFO - Running post-action listener: _resource_record_post_action 18:04:56 INFO - ##### 18:04:56 INFO - ##### Running download-and-extract step. 18:04:56 INFO - ##### 18:04:56 INFO - Running pre-action listener: _resource_record_pre_action 18:04:56 INFO - Running main action method: download_and_extract 18:04:56 INFO - mkdir: /builds/slave/test/build/tests 18:04:56 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')]} 18:04:56 INFO - https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:04:58 INFO - Downloaded 1199 bytes. 18:04:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:04:58 INFO - Using the following test package requirements: 18:04:58 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:04:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:04:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:04:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'jsshell-mac.zip'], 18:04:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:04:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:04:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:04:58 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:04:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:04:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:04:58 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:04:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:58 INFO - https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:04:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:04:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:04:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:04:59 INFO - Downloaded 17853803 bytes. 18:04:59 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'] 18:04:59 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 18:05:02 INFO - Return code: 0 18:05:02 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 18:05:02 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')]} 18:05:02 INFO - https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:05:05 INFO - Downloaded 17853803 bytes. 18:05:05 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'] 18:05:05 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 18:05:08 INFO - Return code: 0 18:05: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')]} 18:05:08 INFO - https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:05:10 INFO - Downloaded 10845263 bytes. 18:05:10 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'] 18:05:10 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 18:05:10 INFO - Return code: 0 18:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:10 INFO - https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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 18:05:42 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg: The read operation timed out 18:05:42 INFO - retry: attempt #1 caught exception: The read operation timed out 18:05:42 INFO - retry: Failed, sleeping 30 seconds before retrying 18:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #2 18:06:15 INFO - Downloaded 111066772 bytes. 18:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:06:15 INFO - mkdir: /builds/slave/test/properties 18:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 18:06:15 INFO - Contents: 18:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:06:16 INFO - Running post-action listener: _resource_record_post_action 18:06:16 INFO - Running post-action listener: set_extra_try_arguments 18:06:16 INFO - ##### 18:06:16 INFO - ##### Running populate-webroot step. 18:06:16 INFO - ##### 18:06:16 INFO - Running pre-action listener: _resource_record_pre_action 18:06:16 INFO - Running main action method: populate_webroot 18:06:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:06:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:06:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:06:16 INFO - '--tppagecycles', 18:06:16 INFO - '7'], 18:06:16 INFO - 'tests': ['tsvgm']}}, 18:06:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:06:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:06:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:06:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:06:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'tests': ['damp', 'tps']}, 18:06:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['damp', 'tps']}, 18:06:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:06:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:06:16 INFO - 'other': {'tests': ['a11yr', 18:06:16 INFO - 'ts_paint', 18:06:16 INFO - 'tpaint', 18:06:16 INFO - 'sessionrestore', 18:06:16 INFO - 'sessionrestore_no_auto_restore', 18:06:16 INFO - 'tabpaint']}, 18:06:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['a11yr', 18:06:16 INFO - 'ts_paint', 18:06:16 INFO - 'tpaint', 18:06:16 INFO - 'sessionrestore', 18:06:16 INFO - 'sessionrestore_no_auto_restore', 18:06:16 INFO - 'tabpaint']}, 18:06:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['a11yr', 18:06:16 INFO - 'ts_paint', 18:06:16 INFO - 'tpaint', 18:06:16 INFO - 'sessionrestore', 18:06:16 INFO - 'sessionrestore_no_auto_restore', 18:06:16 INFO - 'tabpaint']}, 18:06:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['a11yr', 18:06:16 INFO - 'ts_paint', 18:06:16 INFO - 'tpaint', 18:06:16 INFO - 'sessionrestore', 18:06:16 INFO - 'sessionrestore_no_auto_restore', 18:06:16 INFO - 'tabpaint']}, 18:06:16 INFO - 'other_l64': {'tests': ['a11yr', 18:06:16 INFO - 'ts_paint', 18:06:16 INFO - 'tpaint', 18:06:16 INFO - 'sessionrestore', 18:06:16 INFO - 'sessionrestore_no_auto_restore', 18:06:16 INFO - 'tabpaint']}, 18:06:16 INFO - 'other_nol64': {'tests': ['a11yr', 18:06:16 INFO - 'ts_paint', 18:06:16 INFO - 'tpaint', 18:06:16 INFO - 'sessionrestore', 18:06:16 INFO - 'sessionrestore_no_auto_restore', 18:06:16 INFO - 'tabpaint']}, 18:06:16 INFO - 'svgr': {'tests': ['tsvgx', 18:06:16 INFO - 'tsvgr_opacity', 18:06:16 INFO - 'tart', 18:06:16 INFO - 'tscrollx', 18:06:16 INFO - 'cart']}, 18:06:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['tsvgx', 18:06:16 INFO - 'tsvgr_opacity', 18:06:16 INFO - 'tart', 18:06:16 INFO - 'tscrollx', 18:06:16 INFO - 'cart']}, 18:06:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'tests': ['tp5o']}, 18:06:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'talos_options': ['--e10s'], 18:06:16 INFO - 'tests': ['tp5o']}, 18:06:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'talos_options': ['--xperf_path', 18:06:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:16 INFO - 'tests': ['tp5n']}, 18:06:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:16 INFO - 'talos_options': ['--e10s', 18:06:16 INFO - '--xperf_path', 18:06:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:16 INFO - 'tests': ['tp5n']}}, 18:06:16 INFO - 'talos.zip': {'path': '', 18:06:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:06:16 INFO - Running post-action listener: _resource_record_post_action 18:06:16 INFO - ##### 18:06:16 INFO - ##### Running create-virtualenv step. 18:06:16 INFO - ##### 18:06:16 INFO - Running pre-action listener: _resource_record_pre_action 18:06:16 INFO - Running main action method: create_virtualenv 18:06:16 INFO - Creating virtualenv /builds/slave/test/build/venv 18:06:16 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 18:06:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:06:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:06:16 INFO - Using real prefix '/tools/python27' 18:06:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:06:17 INFO - Installing distribute.............................................................................................................................................................................................done. 18:06:20 INFO - Installing pip.................done. 18:06:20 INFO - Return code: 0 18:06:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:06:20 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')]} 18:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:20 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')]} 18:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:20 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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:20 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 18:06:20 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 18:06:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:20 INFO - 'HOME': '/Users/cltbld', 18:06:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:20 INFO - 'LOGNAME': 'cltbld', 18:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:20 INFO - 'MOZ_NO_REMOTE': '1', 18:06:20 INFO - 'NO_EM_RESTART': '1', 18:06:20 INFO - 'PAGER': '/bin/cat', 18:06:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:20 INFO - 'PWD': '/builds/slave/test', 18:06:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:20 INFO - 'SHELL': '/bin/bash', 18:06:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:20 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:20 INFO - 'USER': 'cltbld', 18:06:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:20 INFO - 'XPC_FLAGS': '0x0', 18:06:20 INFO - 'XPC_SERVICE_NAME': '0', 18:06:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:20 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 18:06:20 INFO - Cleaning up... 18:06:20 INFO - Return code: 0 18:06:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:06:20 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')]} 18:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:20 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')]} 18:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:20 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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:20 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 18:06:20 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 18:06:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:20 INFO - 'HOME': '/Users/cltbld', 18:06:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:20 INFO - 'LOGNAME': 'cltbld', 18:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:20 INFO - 'MOZ_NO_REMOTE': '1', 18:06:20 INFO - 'NO_EM_RESTART': '1', 18:06:20 INFO - 'PAGER': '/bin/cat', 18:06:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:20 INFO - 'PWD': '/builds/slave/test', 18:06:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:20 INFO - 'SHELL': '/bin/bash', 18:06:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:20 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:20 INFO - 'USER': 'cltbld', 18:06:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:20 INFO - 'XPC_FLAGS': '0x0', 18:06:20 INFO - 'XPC_SERVICE_NAME': '0', 18:06:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:20 INFO - Downloading/unpacking psutil>=0.7.1 18:06:20 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 18:06:20 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 18:06:20 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 18:06:20 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 18:06:20 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 18:06:20 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 18:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:06:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:24 INFO - Installing collected packages: psutil 18:06:24 INFO - Running setup.py install for psutil 18:06:24 INFO - building 'psutil._psutil_osx' extension 18:06:24 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 18:06:24 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 18:06:25 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 18:06:25 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 18:06:25 INFO - building 'psutil._psutil_posix' extension 18:06:25 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 18:06:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:06:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:06:25 INFO - ^ 18:06:25 INFO - 1 warning generated. 18:06:25 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 18:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:25 INFO - Successfully installed psutil 18:06:25 INFO - Cleaning up... 18:06:25 INFO - Return code: 0 18:06:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:25 INFO - 'HOME': '/Users/cltbld', 18:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:25 INFO - 'LOGNAME': 'cltbld', 18:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:25 INFO - 'MOZ_NO_REMOTE': '1', 18:06:25 INFO - 'NO_EM_RESTART': '1', 18:06:25 INFO - 'PAGER': '/bin/cat', 18:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:25 INFO - 'PWD': '/builds/slave/test', 18:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:25 INFO - 'SHELL': '/bin/bash', 18:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:25 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:25 INFO - 'USER': 'cltbld', 18:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:25 INFO - 'XPC_FLAGS': '0x0', 18:06:25 INFO - 'XPC_SERVICE_NAME': '0', 18:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:06:28 INFO - Installing collected packages: mozsystemmonitor 18:06:28 INFO - Running setup.py install for mozsystemmonitor 18:06:28 INFO - Successfully installed mozsystemmonitor 18:06:28 INFO - Cleaning up... 18:06:28 INFO - Return code: 0 18:06:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:28 INFO - 'HOME': '/Users/cltbld', 18:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:28 INFO - 'LOGNAME': 'cltbld', 18:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:28 INFO - 'MOZ_NO_REMOTE': '1', 18:06:28 INFO - 'NO_EM_RESTART': '1', 18:06:28 INFO - 'PAGER': '/bin/cat', 18:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:28 INFO - 'PWD': '/builds/slave/test', 18:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:28 INFO - 'SHELL': '/bin/bash', 18:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:28 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:28 INFO - 'USER': 'cltbld', 18:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:28 INFO - 'XPC_FLAGS': '0x0', 18:06:28 INFO - 'XPC_SERVICE_NAME': '0', 18:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:28 INFO - Downloading/unpacking blobuploader==1.2.4 18:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:06:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:06:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:32 INFO - Downloading docopt-0.6.1.tar.gz 18:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:06:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:06:32 INFO - Running setup.py install for blobuploader 18:06:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:06:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:06:32 INFO - Running setup.py install for requests 18:06:33 INFO - Running setup.py install for docopt 18:06:33 INFO - Successfully installed blobuploader requests docopt 18:06:33 INFO - Cleaning up... 18:06:33 INFO - Return code: 0 18:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:33 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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:33 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 18:06:33 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 18:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:33 INFO - 'HOME': '/Users/cltbld', 18:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:33 INFO - 'LOGNAME': 'cltbld', 18:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:33 INFO - 'MOZ_NO_REMOTE': '1', 18:06:33 INFO - 'NO_EM_RESTART': '1', 18:06:33 INFO - 'PAGER': '/bin/cat', 18:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:33 INFO - 'PWD': '/builds/slave/test', 18:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:33 INFO - 'SHELL': '/bin/bash', 18:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:33 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:33 INFO - 'USER': 'cltbld', 18:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:33 INFO - 'XPC_FLAGS': '0x0', 18:06:33 INFO - 'XPC_SERVICE_NAME': '0', 18:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:06:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-eu2ZDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:06:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-fb_fEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:06:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-jGV2fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:06:33 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-qGYOaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-umESHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-rGRHqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-quPey7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-DjxD1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-KPFx0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-62uMnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-7mWX13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SJXJ4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-qT4rhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:06:34 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-plhLNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-pQuMyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:06:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-6C_hTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:06:35 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Ol1sWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:06:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:06:35 INFO - Running setup.py install for manifestparser 18:06:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:06:35 INFO - Running setup.py install for mozcrash 18:06:35 INFO - Running setup.py install for mozdebug 18:06:35 INFO - Running setup.py install for mozdevice 18:06:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:06:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:06:35 INFO - Running setup.py install for mozfile 18:06:36 INFO - Running setup.py install for mozhttpd 18:06:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Running setup.py install for mozinfo 18:06:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Running setup.py install for mozInstall 18:06:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Running setup.py install for mozleak 18:06:36 INFO - Running setup.py install for mozlog 18:06:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Running setup.py install for moznetwork 18:06:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:06:36 INFO - Running setup.py install for mozprocess 18:06:37 INFO - Running setup.py install for mozprofile 18:06:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:06:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:06:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:06:37 INFO - Running setup.py install for mozrunner 18:06:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:06:37 INFO - Running setup.py install for mozscreenshot 18:06:37 INFO - Running setup.py install for moztest 18:06:37 INFO - Running setup.py install for mozversion 18:06:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:06:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:06:37 INFO - Cleaning up... 18:06:37 INFO - Return code: 0 18:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:37 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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:37 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 18:06:37 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 18:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:37 INFO - 'HOME': '/Users/cltbld', 18:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:37 INFO - 'LOGNAME': 'cltbld', 18:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:37 INFO - 'MOZ_NO_REMOTE': '1', 18:06:37 INFO - 'NO_EM_RESTART': '1', 18:06:37 INFO - 'PAGER': '/bin/cat', 18:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:37 INFO - 'PWD': '/builds/slave/test', 18:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:37 INFO - 'SHELL': '/bin/bash', 18:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:37 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:37 INFO - 'USER': 'cltbld', 18:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:37 INFO - 'XPC_FLAGS': '0x0', 18:06:37 INFO - 'XPC_SERVICE_NAME': '0', 18:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xPX5UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Xm4iv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-932TXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-1pFQMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_euFo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-wlKM_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-f4S9yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:06:38 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)) 18:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:06:38 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-m20ZAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-D3ru3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_r3jBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-ssS8QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-xtyDhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-RJIxC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Ln4vEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Ryb4GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-MTV_wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:06:39 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)) 18:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:06:39 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-6je5GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:06:39 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)) 18:06:39 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)) 18:06:39 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)) 18:06:39 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)) 18:06:39 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)) 18:06:39 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)) 18:06:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:42 INFO - Downloading blessings-1.6.tar.gz 18:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:06:42 INFO - Installing collected packages: blessings 18:06:42 INFO - Running setup.py install for blessings 18:06:42 INFO - Successfully installed blessings 18:06:42 INFO - Cleaning up... 18:06:42 INFO - Return code: 0 18:06:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:06:42 INFO - Reading from file tmpfile_stdout 18:06:42 INFO - Current package versions: 18:06:42 INFO - blessings == 1.6 18:06:42 INFO - blobuploader == 1.2.4 18:06:42 INFO - docopt == 0.6.1 18:06:42 INFO - manifestparser == 1.1 18:06:42 INFO - mozInstall == 1.12 18:06:42 INFO - mozcrash == 0.17 18:06:42 INFO - mozdebug == 0.1 18:06:42 INFO - mozdevice == 0.48 18:06:42 INFO - mozfile == 1.2 18:06:42 INFO - mozhttpd == 0.7 18:06:42 INFO - mozinfo == 0.9 18:06:42 INFO - mozleak == 0.1 18:06:42 INFO - mozlog == 3.1 18:06:42 INFO - moznetwork == 0.27 18:06:42 INFO - mozprocess == 0.22 18:06:42 INFO - mozprofile == 0.28 18:06:42 INFO - mozrunner == 6.11 18:06:42 INFO - mozscreenshot == 0.1 18:06:42 INFO - mozsystemmonitor == 0.0 18:06:42 INFO - moztest == 0.7 18:06:42 INFO - mozversion == 1.4 18:06:42 INFO - psutil == 3.1.1 18:06:42 INFO - requests == 1.2.3 18:06:42 INFO - wsgiref == 0.1.2 18:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:06: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')]} 18:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:42 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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:42 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 18:06:42 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 18:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:42 INFO - 'HOME': '/Users/cltbld', 18:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:42 INFO - 'LOGNAME': 'cltbld', 18:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:42 INFO - 'MOZ_NO_REMOTE': '1', 18:06:42 INFO - 'NO_EM_RESTART': '1', 18:06:42 INFO - 'PAGER': '/bin/cat', 18:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:42 INFO - 'PWD': '/builds/slave/test', 18:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:42 INFO - 'SHELL': '/bin/bash', 18:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:42 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:42 INFO - 'USER': 'cltbld', 18:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:42 INFO - 'XPC_FLAGS': '0x0', 18:06:42 INFO - 'XPC_SERVICE_NAME': '0', 18:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 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)) 18:06:43 INFO - Cleaning up... 18:06:43 INFO - Return code: 0 18:06:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:43 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 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:43 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 18:06:43 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 18:06:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:43 INFO - 'HOME': '/Users/cltbld', 18:06:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:43 INFO - 'LOGNAME': 'cltbld', 18:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:43 INFO - 'MOZ_NO_REMOTE': '1', 18:06:43 INFO - 'NO_EM_RESTART': '1', 18:06:43 INFO - 'PAGER': '/bin/cat', 18:06:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:43 INFO - 'PWD': '/builds/slave/test', 18:06:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:43 INFO - 'SHELL': '/bin/bash', 18:06:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:43 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:43 INFO - 'USER': 'cltbld', 18:06:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:43 INFO - 'XPC_FLAGS': '0x0', 18:06:43 INFO - 'XPC_SERVICE_NAME': '0', 18:06:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:43 INFO - Downloading/unpacking jsonschema 18:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:45 INFO - Downloading/unpacking functools32 (from jsonschema) 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:46 INFO - warning: no files found matching '*.txt' 18:06:46 INFO - no previously-included directories found matching 'build' 18:06:46 INFO - no previously-included directories found matching 'dist' 18:06:46 INFO - no previously-included directories found matching '.git*' 18:06:46 INFO - Installing collected packages: jsonschema, functools32 18:06:46 INFO - Running setup.py install for functools32 18:06:46 INFO - warning: no files found matching '*.txt' 18:06:46 INFO - no previously-included directories found matching 'build' 18:06:46 INFO - no previously-included directories found matching 'dist' 18:06:46 INFO - no previously-included directories found matching '.git*' 18:06:46 INFO - Successfully installed jsonschema functools32 18:06:46 INFO - Cleaning up... 18:06:46 INFO - Return code: 0 18:06:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109659a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1b8c8bfd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, '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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 18:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:46 INFO - 'HOME': '/Users/cltbld', 18:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:46 INFO - 'LOGNAME': 'cltbld', 18:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:46 INFO - 'MOZ_NO_REMOTE': '1', 18:06:46 INFO - 'NO_EM_RESTART': '1', 18:06:46 INFO - 'PAGER': '/bin/cat', 18:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:46 INFO - 'PWD': '/builds/slave/test', 18:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:46 INFO - 'SHELL': '/bin/bash', 18:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:06:46 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:46 INFO - 'USER': 'cltbld', 18:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:46 INFO - 'XPC_FLAGS': '0x0', 18:06:46 INFO - 'XPC_SERVICE_NAME': '0', 18:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:46 INFO - Downloading/unpacking flake8 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06: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 18:06:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:06:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:06:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:06:50 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 18:06:50 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 18:06:50 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 18:06:50 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 18:06:50 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 18:06:50 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 18:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:06:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:06:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:06:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:06:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:06:50 INFO - no previously-included directories found matching 'docs/_build' 18:06:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:06:50 INFO - Running setup.py install for pep8 18:06:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:06:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:06:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:06:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:06:50 INFO - no previously-included directories found matching 'docs/_build' 18:06:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:06:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:06:50 INFO - Cleaning up... 18:06:50 INFO - Return code: 0 18:06:50 INFO - Running post-action listener: _resource_record_post_action 18:06:50 INFO - Running post-action listener: _start_resource_monitoring 18:06:50 INFO - Starting resource monitoring. 18:06:50 INFO - ##### 18:06:50 INFO - ##### Running install step. 18:06:50 INFO - ##### 18:06:50 INFO - Running pre-action listener: _resource_record_pre_action 18:06:50 INFO - Running main action method: install 18:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:06:51 INFO - Reading from file tmpfile_stdout 18:06:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:06:51 INFO - Reading from file tmpfile_stdout 18:06:51 INFO - Output received: 18:06:51 INFO - Usage: mozinstall [options] installer 18:06:51 INFO - Options: 18:06:51 INFO - -h, --help show this help message and exit 18:06:51 INFO - -d DEST, --destination=DEST 18:06:51 INFO - Directory to install application into. [default: 18:06:51 INFO - "/builds/slave/test"] 18:06:51 INFO - --app=APP Application being installed. [default: firefox] 18:06:51 INFO - mkdir: /builds/slave/test/build/application 18:06:51 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'] 18:06:51 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 18:07:25 INFO - Reading from file tmpfile_stdout 18:07:25 INFO - Output received: 18:07:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:07:25 INFO - Running post-action listener: _resource_record_post_action 18:07:25 INFO - ##### 18:07:25 INFO - ##### Running run-tests step. 18:07:25 INFO - ##### 18:07:25 INFO - Running pre-action listener: _resource_record_pre_action 18:07:25 INFO - Running main action method: run_tests 18:07:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:07:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:07:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:07:25 INFO - 2016-03-15 18:07:25.038 screenresolution[1646:7869] starting screenresolution argv=screenresolution get 18:07:25 INFO - 2016-03-15 18:07:25.040 screenresolution[1646:7869] Display 0: 1600x1200x32@60 18:07:25 INFO - 2016-03-15 18:07:25.046 screenresolution[1647:7871] starting screenresolution argv=screenresolution list 18:07:25 INFO - Available Modes on Display 0 18:07:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:07:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:07:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:07:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:07:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:07:25 INFO - Intel Iris: 18:07:25 INFO - Chipset Model: Intel Iris 18:07:25 INFO - Type: GPU 18:07:25 INFO - Bus: Built-In 18:07:25 INFO - VRAM (Dynamic, Max): 1536 MB 18:07:25 INFO - Vendor: Intel (0x8086) 18:07:25 INFO - Device ID: 0x0a2e 18:07:25 INFO - Revision ID: 0x0009 18:07:25 INFO - Displays: 18:07:25 INFO - Display: 18:07:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:07:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:07:25 INFO - Display Serial Number: 1600x1200 60 18:07:25 INFO - Main Display: Yes 18:07:25 INFO - Mirror: Off 18:07:25 INFO - Online: Yes 18:07:25 INFO - Rotation: Supported 18:07:25 INFO - Return code: 0 18:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:25 INFO - Python 2.7.3 18:07:25 INFO - Return code: 0 18:07:25 INFO - grabbing minidump binary from tooltool 18:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:25 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 0x1094fdd30>, '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 0x109321db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:25 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 18:07:25 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 18:07:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:25 INFO - Return code: 0 18:07:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:07:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:07:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:07:26 INFO - Return code: 0 18:07:26 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/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 18:07:26 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/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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 18:07:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJ5QOgmmv2/Render', 18:07:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:07:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:07:26 INFO - 'HOME': '/Users/cltbld', 18:07:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:07:26 INFO - 'LOGNAME': 'cltbld', 18:07:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:26 INFO - 'MOZ_NO_REMOTE': '1', 18:07:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:26 INFO - 'NO_EM_RESTART': '1', 18:07:26 INFO - 'PAGER': '/bin/cat', 18:07:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:26 INFO - 'PWD': '/builds/slave/test', 18:07:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:07:26 INFO - 'SHELL': '/bin/bash', 18:07:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nx2gG22bBV/Listeners', 18:07:26 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 18:07:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:07:26 INFO - 'USER': 'cltbld', 18:07:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:07:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:26 INFO - 'XPC_FLAGS': '0x0', 18:07:26 INFO - 'XPC_SERVICE_NAME': '0', 18:07:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:07:26 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/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 18:07:26 INFO - mozversion application_buildid: 20160315161347 18:07:26 INFO - mozversion application_changeset: 0b6f231921d4a102e5258dd5bb4b03df7bea369a 18:07:26 INFO - mozversion application_display_name: Nightly 18:07:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:26 INFO - mozversion application_name: Firefox 18:07:26 INFO - mozversion application_remotingname: firefox 18:07:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:07:26 INFO - mozversion application_vendor: Mozilla 18:07:26 INFO - mozversion application_version: 48.0a1 18:07:26 INFO - mozversion platform_buildid: 20160315161347 18:07:26 INFO - mozversion platform_changeset: 0b6f231921d4a102e5258dd5bb4b03df7bea369a 18:07:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:07:26 INFO - mozversion platform_version: 48.0a1 18:07:26 INFO - using testdate: 1458090446 18:07:26 INFO - actual date: 1458090446 18:07:26 INFO - starting webserver on 'localhost:49272' 18:07:26 INFO - SUITE-START | Running 2 tests 18:07:26 INFO - TEST-START | dromaeo_css 18:07:26 INFO - operating with platform_type : mac_ 18:07:26 INFO - Initialising browser for dromaeo_css test... 18:07:26 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpRWtZvh/profile http://localhost:49272/getInfo.html) 18:07:29 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 18:07:29 INFO - PROCESS | 1665 | colorDepth:24 18:07:29 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 18:07:29 INFO - PROCESS | 1665 | __metrics 18:07:29 INFO - PROCESS | 1665 | 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" 18:07:29 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:07:30 INFO - TEST-INFO | 1665: exit 0 18:07:30 INFO - Browser initialized. 18:07:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:30 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpRWtZvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:07:42 INFO - PROCESS | 1669 | RSS: Main: 243453952 18:07:42 INFO - PROCESS | 1669 | 18:08:33 INFO - PROCESS | 1669 | 1458090513707 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] 18:10:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 18:10:45 INFO - PROCESS | 1669 | RSS: Main: 333074432 18:10:45 INFO - PROCESS | 1669 | 18:13:47 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 18:13:48 INFO - PROCESS | 1669 | RSS: Main: 380428288 18:13:48 INFO - PROCESS | 1669 | 18:16:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 18:16:50 INFO - PROCESS | 1669 | RSS: Main: 377430016 18:16:50 INFO - PROCESS | 1669 | 18:19:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 18:19:53 INFO - PROCESS | 1669 | RSS: Main: 334974976 18:19:53 INFO - PROCESS | 1669 | 18:22:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 18:22:57 INFO - PROCESS | 1669 | RSS: Main: 336699392 18:22:57 INFO - PROCESS | 1669 | 18:25:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 18:26:00 INFO - PROCESS | 1669 | RSS: Main: 382656512 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | __start_tp_report 18:26:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 18:26:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 18:26:00 INFO - PROCESS | 1669 | |i|pagename|runs| 18:26:00 INFO - PROCESS | 1669 | |0;dojo.html;3178.1736748445405;3501.2122272488677;3535.6994655454287;3542.238418739971;3585.551806024247;5560.805371811987;5652.152177173426;5665.405132461094;5683.943160568393;5694.658320500773;5611.3266408030995;5636.239107720457;5666.093425051992;5666.263385759856;5672;5142.665726727751;5145.408278048017;5188.818391356303;5190.11767999441;5249.343832020997;5268.104422248227;5268.973655131719;5269.525742683158;5274.077036518613;5275.208718692188;5134.563562097208;5181.663191892534;5213.530782229599;5220.869478263055;5225.608079394042;5250.6324557281005;5293.602979776532;5303.814366497154;5304.787808487675;5364.222187782789;5103.974480127613;5109.156989096795;5130.948690513122;5184.533391994739;5188.455212202702;5554.694491802949;5575.8606034849045;5595.692236926968;5599.496045355938;5681;6272.686365681743;6276.466500347476;6280.937190628081;6285.120083188357;6285.4343109119945;5426;6157.261128664589;6252.624842509464;6272.968635156841;6286.49708023357;5847.44449277318;5848.356680765112;5848.707564621752;5851.707414629294;5884.823455296348;6290.339514350927;6301;6305.495560355161;6307.369263073748;6319.873602527924;6079.179310793074;6112.077967281658;6156.569040167145;6192.133101365813;6232.56372053961;6208.565400422018;6272.3100458949475;6287.9056814147825;6291.150694656254;6298.212723409574;6153.938460615336;6224.284207316216;6226.906596401058;6235.906461403082;6249.7187626556915;6115.727150604525;6138.232720909887;6193.380661933861;6232;6241.188645476059;4854.708717476963;4863.392075990501;4871.391076115486;4896.4124305082905;4909.459959404463;4390.297552391602;4392.912141757147;4393.604575588212;4430.202563538594;4432.689711720149;5688.317401911714;5772.220750198753;5783.71081445926;5863.296404431496;5879.441453061952;6223.751049958041;6268.686565671789;6277.089821975879;6280.780172694025;6293.96853015732;5790.160426738099;5817.360090390053;5821.039528477754;5822.301323841081;5828.504577110908;5280.9471905281225;5343.278657381282;5352.91970620441;5381.596380271495;5417.404085550586;6372.394622510854;6397.712102955471;6401.64790936503;6409.8077057687415;6430.967845160744;6155.47678447337;6257.812265632038;6258.6391876044445;6284.780032698834;6289.937100628935;6335.366463353628;6386.265579458236;6417.839554011187;6420.935790642221;6434.356564343529;6166.1983942087245;6188.257409110935;6216.2540495140875;6223.657698826608;6226.906596401148;6129.603311142764;6173.660448675366;6289.08808222796;6297.842553936188;6305.180326557518;5078.771455284595;6052.90920636182;6108.8778224436155;6127.509799216141;6137.3248942617165;6109.725062372115;6114.785982490592;6122;6131.019036954066;6140;5805.76776928935;5913.467787898938;5951.434613711691;5972.402759723993;6019.036954087325;6024.90962635552;6082.391760823883;6130.042401873816;6130.50955923534;6147.815565533041;5803.506701930383;5838.474537291494;5843.766249349978;5847.590668653153;5888.970555147368 18:26:00 INFO - PROCESS | 1669 | |1;ext.html;456.24946962247105;480.1836877308572;537.4840153452683;634.7334119669738;636.8280564247652;30145.698543014565;30541.236469088282;30695.69304306956;38362.61637383625;39119.41320880189;42781.7860910695;43195.78402107985;43280.91797705059;43287.56712432875;43399.13201735963;9394.295427842904;9621.903780962206;9622.951885240598;9625.759356016086;9625.807483850354;9372;9518.714438566854;9546.61813527458;9548.665796697116;9564.426134431922;9496.857547136764;9570.234381249518;9573.473458959754;9574.47340396278;9576.090271424238;9387.249020078378;9536.380135291183;9537.952310238405;9554.904450955471;9565.139137477625;9323.860142097874;9445.102715242041;9448.102430269113;9465.100815422524;9481.810363792754;40473.595264047275;40919.38620920689;40923.386149207785;41010.179796404205;41037.384439233436;3127.5152351385573;3202.295494991098;3327.866885324584;3425.743069269815;3830.080780612661;27770.028049018187;28023.579646305323;28112.578311325346;28531.42937141266;28664.713352866413;2745.1764470658723;2745.9862700686567;2770.473610014091;2863.8281703097673;2921.5033444314518;512143;514843;515019;515332;522604;68203;68890.31109688939;69418.9587156193;69451.30548694449;69656.303436966;71178;72175.63912180405;72388.63805680937;72402.27597724061;72440.27559724335;15508.457203997807;15555.30001149951;15624.140672263135;15636.92181539085;15659.451919182773;12026.15816892809;12975.70242975695;12995.155314904501;13060.151090179108;13110.475580976845;21017.789822101888;21346.78653213479;21383.67924481103;21401.250956216456;21860.781392185876;7694.653740581687;8974.86537701935;9146.954265228764;9175.724728258163;9187.356885017985;937.5171786529943;963.9614415423445;1009.3792317724693;1115.654147214366;1182.0779791762438;20766.688499672517;25519.744802551737;29269.56095658567;29313.56029659557;29513.26216844553;1018.8217062014267;1022.2741853284103;1103.0293341859112;1168.6669299249843;1203.1277323940074;14303.426623071453;15903.522894312957;15976.840231597767;16003.919980400024;16415.26131324093;572913;700952;713015;713730;716495;60807.69596151991;60964.08553871696;61511.769764604454;61693;61843.38156618466;1305.536534530247;1334.3061607963805;1445.262915912892;1456.4319915233068;1464.1946929189116;30444.543331849596;31007.379852403275;31314.530282046242;31799.728010879306;31873.8844140454;46421.76789116033;54064.64838379072;54184;54254;54373.91252174855;412317.938410306;412780.9360953176;415165;418881;418903;31082.844585776926;32859.34281314408;32893;32904.84833030833;32946.17634559155;42799.3580096305;43124.78437607792;43204;43694;44384;35960.46059309165;35961.28077438384;36033.81983090068;36745.816270918476;36910;35199.82400087983;35293.117672058404;35857.103572410895;36206.818965905004;36278.09304767402;34552.48171277383;35214.887106773676;35353.11617209487;35533.75631852873;36420;30254.394912102074;31508.89718859829;31539.21151971219;31592.842035790592;31644.367112658078;23743.525129496968;23773.16793912274;23883.761162388848;24100;24101.384792281297 18:26:00 INFO - PROCESS | 1669 | |2;jquery.html;358.1761947520702;359.5469708167708;359.8236863936671;370.7830918912436;371.03160750441344;15929.522114336574;19258.22967081315;20366.083526241317;20767.376978690627;20830.166793328288;19096.33162839301;20065.699014514757;20156.294529691462;20170.991450427457;20186.192552297925;5871.647701137946;6083.270007599072;6088.178095957033;6146.108814221935;6161.29145148307;3447.9655203447896;4179.414881916534;4414.713043652152;4416.646668266531;6609.834754131137;6543.869122617545;6555.967220163892;6558.606483610999;6566.606003639773;6578.901316480256;5589.441055894418;5859.970700146515;5861.9706901465215;6532.08550802888;6537.2482164550975;3742.176721121349;5474.644148130359;5595.468430499096;5604.971975140098;5699.373068962411;13047.282399468026;13267.867321326856;13271.402786874614;13276.336183190899;20766.5846683067;1966.9704954425695;2012.5672980309157;2042.714020037196;2082.1983536338466;2273.988630056839;9477.194438472738;9861.556229969668;9925.75185620358;10300.021497957681;10365.844512332322;1645.5145732008966;1735.7830271216098;1767.8939263644222;1824.5438640339914;1860.5534671678836;84365.15634843634;104314;107015.46492267567;109839;110443;11131.94246546593;11140.387278699749;11140.442977851075;11151.330920144817;11322.547098116147;13614.523491677943;13616.523421680193;13683;13711.382987765575;13717.657058573415;6911.377975982085;8501.787455313666;8552.957235213784;8555.828883422297;8575.1424857515;8276.8344633107;8772.517511536927;8773.692920747742;8850.64597416109;8905.287576993825;4444.755538445416;4484.990877052637;4496.145732310916;4509.34614480905;4549.044700612908;1593.49804811484;1841.8618603604516;1886.6321067391727;1891.6216756648726;1897.345415831536;743.5278598090143;920.7191806498948;940.520334629344;996.7109538233976;1073.683263437288;17441.215145318492;18389.90805045966;19183.32858349951;19523.414297571097;19705.901470492558;938.4885237545554;968.9728887379259;972.8589354543551;972.9659461918799;1052.1898138433364;9018.323625728097;10135.37833946565;10405.21960852924;10579.994900484442;10613.5223914924;559229;582475;601199;657859;665212;118896;118978;122827;123378.38310808389;124320;1024.9955044056717;1028.1671845804922;1061.2942393308517;1077.1544337694872;1083.918706097046;17277.56806079808;17307.653846923244;17478.388256410966;17806.732899006267;17926.462206133838;50005.74997124991;50777;50844;50854.982900342526;51015.46953591398;69481.61036779337;70731.64634177001;71923.28076719165;73566.26433735808;75715;7592;7838.294553490213;7846.843063138819;7858.66402711529;7860.371170306476;10971.725706857393;12025.037996960047;12160;12171.513139474322;12502.624921252376;8443.788905277417;10311.175105991353;10432.791344173225;10675.306105103144;10706.625268115578;9162.175404213653;10278.537465813906;10416;10450.634227801991;10585.941405859661;9060.640903864472;10701.197410194422;10744.623938162127;10824.458777060958;11056.226064175431;7550.924490755022;7666.38668906475;7721;7760.650770715444;7880.527168369917;8275.213854683796;10416.687499375032;10534.315269507457;10874.184436167161;10905.34567925927 18:26:00 INFO - PROCESS | 1669 | |3;mootools.html;1441.9423223071078;1595.553245091374;1621.594601349663;1921.1738952250535;2051.4973831411307;7952.602369881504;8541.914580854189;8686.174813392718;8733.34499912506;8735.91264087359;8469.195426434495;8717.694880679177;8724.17120373565;8729.519876406795;8754.606042728077;2156.439325775294;2410.4937963027787;2473.591857343536;2483.540544999181;2492.476579918219;2490.6264060390904;2493.7381574934643;2498.812589055828;2501.2371226775826;2533.733957934418;2413.3001429585397;2463.9260822175274;2477.3930387055107;2486.3784053986506;2491.028498885436;2434.3183908505557;2471.864047477388;2477.1949116537016;2478.8264821462503;2486.2416962826333;2443.6334549817493;2472.184179220853;2482.1436604371643;2488.30327508298;2493.2146373892165;8742.519161446118;8820.823583528294;8827.823443531093;8846.734597962071;8853.778655533599;5236.476352364771;5381.4349493303425;5421.484958928895;5424.403315635277;5448.891022179574;3324.6010478742705;3506.7551019388006;3596.226811235597;3735.2902948439983;3792.03303157693;1042.4318746283293;1059.8887116852698;1065.579096256982;1071.4963966935527;1074.693712291993;11659.00898423635;11695.239809412362;11841.822372664417;11902.34537100459;11923.046156307475;4841.806327746851;4883.877903052452;4936.90126197474;4946.876328091755;4984.675996060245;10031.69904902854;10032.598696052222;10043.296969212084;10044.246681498771;10084.798304033879;5487.725613719298;5488.56091512686;5493.807716729895;5495.780168793203;5502.284702988586;3859.7877116758286;4393.319035549495;4568.680192386568;4905.337779399807;4963.751812409438;3806.980965095157;3898.96101038986;3904.824282907276;3923.6861051115843;3936.232434675268;1296.5656505070717;1304.8564657887625;1308.640123965917;1311.8360204974379;1313.0939651640338;1318.993405032988;1344.8991325650616;1358.1986627889396;1372.848986611472;1392.025582092519;8061.153578874251;8159.347252219808;8159.877601835978;8162.551059691774;8174.3460523158;475.2680871457985;486.75148244752097;513.709753988995;524.766478916886;526.3184176491453;5072.365954255718;6174.9691251544355;6229.3770622937345;6240.032794916795;6243.500519958392;10170.288079834341;10288.948555257175;10299.588016479256;10322.948385258176;10329.84505232422;9978.501074946224;10319.071283584513;10346.53440595175;10347.27569070158;10347.534360953776;8109.959450202829;8197.385196110316;8318.958405207935;8320.001599807942;8323.916760832315;7951.721689740832;7973.322267607318;7994.720184793737;8086.555239461886;8215.79460513468;8976.910230897607;9450.574724137568;9496.14534691881;9561.282903782105;9696.22430205596;9526.095020972996;9887.802243955224;9908.653197138066;9932.702018939442;9951.701448956543;6755.7973260802255;6937.7224911002995;7144.1784194818265;7391.445641576795;7474.439417043852;8080.151584083822;8124.390670699603;8158.551279679675;8160.591970401338;8166;7191.568505889663;7248.637568121468;7299.598522081124;7451.739189128354;7462.067241594801;7165.462590305852;7218.855622887408;7219.530730502711;7233.927660723325;7243.167035790952;7510.324070833432;7699.846003080019;7705.383569314554;7712.498687585289;7712.537247765152;6488.772892948724;6602.966985165043;6607.041978912935;6609;6620.63586502747;6988.6505674715045;7132.750353737594;7135.678894449658;7156.248593897566;7157.856842863218 18:26:00 INFO - PROCESS | 1669 | |4;prototype.html;300.67977603851887;314.15179016655037;324.3950033188104;335.9697627213552;337.22774845603567;6349.42855143037;6469.835429622666;6532.150820393343;6576.901346479801;6602.10871532343;6364.490840732742;6455.193100862392;6455.870882582346;6475.773347932812;6493.772717954873;4625.098105869357;4719.362886010379;4734.337192793012;4846.273059041155;4880.463149053601;4750.97624511877;4784.497627749089;4836.709797412149;4858.125537403266;4866.440359358666;4744.312074749177;4754.405699287589;4756.7145971241835;4758.547937945907;4759.928601070987;4365.541618130114;4493.303537951622;4593.471750748673;4634.559716826913;4748.976255118702;4090.3455447128317;4096.201240758053;4107.753534787892;4107.856225032109;4116.073883376246;6088.360722124202;6113.144159817629;6116.663583502906;6141.907871381933;6184.938150618481;5588.30146231721;5604.971975140139;5609.074502707049;5611.523020543259;5619.297587801525;6806;6879.931200687979;6882.311768823128;6886.586804791678;6890.483213758988;3677.485152078711;4329.610335069859;4492.7528985905765;4506.571875671806;4531.43357080365;5636;6596.571222870498;7252.746153884589;7259.963700181518;7276.381507571863;4554.817807287672;4555.2711566149255;4564.269716845289;4566.06395688883;4573.451185857718;4199.0552125772065;4607.516210797885;4618.838340658061;4626;4633.513481084505;4990.600751939836;5445.183222516575;5455.945440545624;5458.781648734006;5461.2354270402175;6578.3092775258865;6789.456843452512;6872.587644741231;6876.449884009267;6877;1573.5358069369563;1589.1815714906832;1596.8562829345183;1599.7120518306817;1603.7193491139003;970.068734015339;996.3175224970918;1028.4292217819182;1031.5770534081141;1048.533402635835;5445.346558413015;6400.967995160087;6431.6462594556815;6535.705893234721;6555.934440655532;7166.856662866713;7178.497505174588;7180.281971802882;7186.46101542376;7209.495335326582;6516.380943810425;6520.413162815369;6530.314316996742;6530.869382612321;6533.771318003847;3043.786934914579;3733.906652333659;3790.56408513019;3791.962080379161;3794.5636251831393;7230.096237970254;7508.0239568855695;7529.397648188132;7538.660760265801;7558;7392.926070739331;7428.182899881117;7438.516496427823;7439.925600744032;7455.366293865082;7534.321911027924;7535.944967704416;7555.546667199876;7556.8488630228185;7563.281488258716;5552.250446189712;7083.079199704005;7207.279272072751;7210.062691850026;7211.278872112747;7105.6447177639875;7114.822129446805;7132;7138.678759455941;7141.178764442156;7439.962800185965;7526.32263096324;7536.171021187555;7540.509866858637;7544.660490277841;4565.223911935045;4567.748773817472;4567.954320456753;4572.428446444194;4575.885602859955;7131.750388736369;7139.501644194411;7143.035690181967;7165.677544510405;7176.7129314826825;5569.498745112959;6586.1438013059915;6896.1035065443175;6908.758193463204;6917.584944903322;6811.250762416031;6878.037074809431;6889.586624802528;6894.517383783087;6900.827479313058;5441.591880608891;6745.831354216184;6748.797536073926;6758.831029224112;6768.187817461936;6868;6889.311068893071;6899.344562266577;6903.585784852925;6927.58434493932;6444.162258906312;6495.902561461677;6604.438622717123;6634.104395906491;6672.332766723483 18:26:00 INFO - PROCESS | 1669 | |5;yui.html;677.0893148714978;687.3195536418947;690.2614202803002;751.4589495563199;760.1752098972611;14882.702345953074;15022.774658380133;15146.01550899192;15178.392864285415;15185.54443366698;13999.370028348723;14370.856291437083;14396.568102956902;14407.207603581799;14414.49549265776;737.5832654550189;919.9448033118001;934.7055677461578;944.0182210501105;944.4333399960037;747.0549754560485;911.5806728904712;947.2422062350092;947.4788866123639;950.6197520991624;979.7158823941048;988.011988011988;990.4948476277078;992.2012779712329;992.320260621473;774.1832366852968;971.8299297622923;985.3102828020415;985.6500942165535;985.8324084905512;582.5136011430461;583.0525396231125;583.3262581718122;716.5772194405326;731.297953964195;15332.463363782213;15382.3077961492;15404.537863864101;15411.922940385226;15423;10368.274220804547;12558.120931534704;12577.579228255281;12739.044571657163;12827.743445131046;9946.80106397868;9948.204143668489;10026.64906728261;10072.748181295527;10400.271980961335;3480.477928310748;3543.5039094526787;3608.2242317901514;3612.8554857805657;3628.7459877808565;83076.16923830744;83143.75284370739;83260.16739832585;86118;86728.69906951401;9594.42433453995;9664.661736839176;9723;9885.159761420216;9909.108180263811;22475.325740227818;22516.874156292448;22522.77477225207;22532.77467225307;22554.548909021727;6766.289539598271;6914.481413893978;6952.031580206523;6971.198312194061;6977.372036516738;4019.8995025124605;4021.7989100544855;4062.431259623655;4082.2243773682903;4137.213929353474;3586.55168103987;3604.333198358312;3629.9637003629628;3631.6731494165124;3647.7811331320204;639.526750204845;642.495640921874;645.2515082504273;659.0476761080193;669.6517810738388;483.4609410507329;496.72183577196887;580.5703779203359;606.6784604159802;619.956603037783;6661.933380666228;7550.886736698954;7841.294283514511;7989;8199.363310783947;581.1718301420459;589.1663296435581;594.6788734083547;602.3434456442499;612.2010775937356;3805.1818858945458;3819.6944244460933;3821.5420414373093;3919.8432062717743;4074.6536544393466;91019;91392;92996.53501732448;93033.53483232675;93373.5331323339;77030;77591.22408775953;77886;77934;77991.61004194943;63092;67525.98711019338;67973;68811.31188688149;69114;7610.315071643578;7772;7810.531368117931;7838.216178382117;7957.801054973672;47395;47888.521114788404;48289.27566086582;48679.51320486891;48815.75592122017;62802;63382.68308658427;63525;64407.355926440134;67644.64710705857;10929.508172132115;10990.780184396108;11035.834462482908;11287.548498059985;11799.17405781587;11866;11986.520539178335;12024.699382515508;12191;12201.633950981484;9010.639574417211;11142.498587563741;11212.49543770516;11309.943450282695;11613.593524226611;11306.095512358826;11336.244887449408;11386.259893106922;11571;11694.228822139574;9603.279754018336;11064.446777661246;11190.608328708457;11268.267562608404;11927.224730392496;9386.530673466435;9545.522723863918;9775.853362199716;9822.901770982198;9893.703188904345;6929.514933954575;8403.201695838885;9612.711618651452;9661.565229564545;9670.274729395183 18:26:00 INFO - PROCESS | 1669 | __end_tp_report 18:26:00 INFO - PROCESS | 1669 | __start_cc_report 18:26:00 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1103 18:26:00 INFO - PROCESS | 1669 | __end_cc_report 18:26:00 INFO - PROCESS | 1669 | __startTimestamp1458091560232__endTimestamp 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | ------- Summary: start ------- 18:26:00 INFO - PROCESS | 1669 | Number of tests: 6 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5749.69 Median:5888.97 stddev:639.90 (10.9%) stddev-sans-first:609.24 18:26:00 INFO - PROCESS | 1669 | Values: 3178.2 3501.2 3535.7 3542.2 3585.6 5560.8 5652.2 5665.4 5683.9 5694.7 5611.3 5636.2 5666.1 5666.3 5672.0 5142.7 5145.4 5188.8 5190.1 5249.3 5268.1 5269.0 5269.5 5274.1 5275.2 5134.6 5181.7 5213.5 5220.9 5225.6 5250.6 5293.6 5303.8 5304.8 5364.2 5104.0 5109.2 5130.9 5184.5 5188.5 5554.7 5575.9 5595.7 5599.5 5681.0 6272.7 6276.5 6280.9 6285.1 6285.4 5426.0 6157.3 6252.6 6273.0 6286.5 5847.4 5848.4 5848.7 5851.7 5884.8 6290.3 6301.0 6305.5 6307.4 6319.9 6079.2 6112.1 6156.6 6192.1 6232.6 6208.6 6272.3 6287.9 6291.2 6298.2 6153.9 6224.3 6226.9 6235.9 6249.7 6115.7 6138.2 6193.4 6232.0 6241.2 4854.7 4863.4 4871.4 4896.4 4909.5 4390.3 4392.9 4393.6 4430.2 4432.7 5688.3 5772.2 5783.7 5863.3 5879.4 6223.8 6268.7 6277.1 6280.8 6294.0 5790.2 5817.4 5821.0 5822.3 5828.5 5280.9 5343.3 5352.9 5381.6 5417.4 6372.4 6397.7 6401.6 6409.8 6431.0 6155.5 6257.8 6258.6 6284.8 6289.9 6335.4 6386.3 6417.8 6420.9 6434.4 6166.2 6188.3 6216.3 6223.7 6226.9 6129.6 6173.7 6289.1 6297.8 6305.2 5078.8 6052.9 6108.9 6127.5 6137.3 6109.7 6114.8 6122.0 6131.0 6140.0 5805.8 5913.5 5951.4 5972.4 6019.0 6024.9 6082.4 6130.0 6130.5 6147.8 5803.5 5838.5 5843.8 5847.6 5889.0 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:67930.16 Median:21096.35 stddev:147300.86 (698.2%) stddev-sans-first:147626.96 18:26:00 INFO - PROCESS | 1669 | Values: 456.2 480.2 537.5 634.7 636.8 30145.7 30541.2 30695.7 38362.6 39119.4 42781.8 43195.8 43280.9 43287.6 43399.1 9394.3 9621.9 9623.0 9625.8 9625.8 9372.0 9518.7 9546.6 9548.7 9564.4 9496.9 9570.2 9573.5 9574.5 9576.1 9387.2 9536.4 9538.0 9554.9 9565.1 9323.9 9445.1 9448.1 9465.1 9481.8 40473.6 40919.4 40923.4 41010.2 41037.4 3127.5 3202.3 3327.9 3425.7 3830.1 27770.0 28023.6 28112.6 28531.4 28664.7 2745.2 2746.0 2770.5 2863.8 2921.5 512143.0 514843.0 515019.0 515332.0 522604.0 68203.0 68890.3 69419.0 69451.3 69656.3 71178.0 72175.6 72388.6 72402.3 72440.3 15508.5 15555.3 15624.1 15636.9 15659.5 12026.2 12975.7 12995.2 13060.2 13110.5 21017.8 21346.8 21383.7 21401.3 21860.8 7694.7 8974.9 9147.0 9175.7 9187.4 937.5 964.0 1009.4 1115.7 1182.1 20766.7 25519.7 29269.6 29313.6 29513.3 1018.8 1022.3 1103.0 1168.7 1203.1 14303.4 15903.5 15976.8 16003.9 16415.3 572913.0 700952.0 713015.0 713730.0 716495.0 60807.7 60964.1 61511.8 61693.0 61843.4 1305.5 1334.3 1445.3 1456.4 1464.2 30444.5 31007.4 31314.5 31799.7 31873.9 46421.8 54064.6 54184.0 54254.0 54373.9 412317.9 412780.9 415165.0 418881.0 418903.0 31082.8 32859.3 32893.0 32904.8 32946.2 42799.4 43124.8 43204.0 43694.0 44384.0 35960.5 35961.3 36033.8 36745.8 36910.0 35199.8 35293.1 35857.1 36206.8 36278.1 34552.5 35214.9 35353.1 35533.8 36420.0 30254.4 31508.9 31539.2 31592.8 31644.4 23743.5 23773.2 23883.8 24100.0 24101.4 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33998.98 Median:11456.18 stddev:102032.95 (890.6%) stddev-sans-first:102287.91 18:26:00 INFO - PROCESS | 1669 | Values: 358.2 359.5 359.8 370.8 371.0 15929.5 19258.2 20366.1 20767.4 20830.2 19096.3 20065.7 20156.3 20171.0 20186.2 5871.6 6083.3 6088.2 6146.1 6161.3 3448.0 4179.4 4414.7 4416.6 6609.8 6543.9 6556.0 6558.6 6566.6 6578.9 5589.4 5860.0 5862.0 6532.1 6537.2 3742.2 5474.6 5595.5 5605.0 5699.4 13047.3 13267.9 13271.4 13276.3 20766.6 1967.0 2012.6 2042.7 2082.2 2274.0 9477.2 9861.6 9925.8 10300.0 10365.8 1645.5 1735.8 1767.9 1824.5 1860.6 84365.2 104314.0 107015.5 109839.0 110443.0 11131.9 11140.4 11140.4 11151.3 11322.5 13614.5 13616.5 13683.0 13711.4 13717.7 6911.4 8501.8 8553.0 8555.8 8575.1 8276.8 8772.5 8773.7 8850.6 8905.3 4444.8 4485.0 4496.1 4509.3 4549.0 1593.5 1841.9 1886.6 1891.6 1897.3 743.5 920.7 940.5 996.7 1073.7 17441.2 18389.9 19183.3 19523.4 19705.9 938.5 969.0 972.9 973.0 1052.2 9018.3 10135.4 10405.2 10580.0 10613.5 559229.0 582475.0 601199.0 657859.0 665212.0 118896.0 118978.0 122827.0 123378.4 124320.0 1025.0 1028.2 1061.3 1077.2 1083.9 17277.6 17307.7 17478.4 17806.7 17926.5 50005.7 50777.0 50844.0 50855.0 51015.5 69481.6 70731.6 71923.3 73566.3 75715.0 7592.0 7838.3 7846.8 7858.7 7860.4 10971.7 12025.0 12160.0 12171.5 12502.6 8443.8 10311.2 10432.8 10675.3 10706.6 9162.2 10278.5 10416.0 10450.6 10585.9 9060.6 10701.2 10744.6 10824.5 11056.2 7550.9 7666.4 7721.0 7760.7 7880.5 8275.2 10416.7 10534.3 10874.2 10905.3 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5984.18 Median:2953.88 stddev:3153.35 (106.8%) stddev-sans-first:3143.72 18:26:00 INFO - PROCESS | 1669 | Values: 1441.9 1595.6 1621.6 1921.2 2051.5 7952.6 8541.9 8686.2 8733.3 8735.9 8469.2 8717.7 8724.2 8729.5 8754.6 2156.4 2410.5 2473.6 2483.5 2492.5 2490.6 2493.7 2498.8 2501.2 2533.7 2413.3 2463.9 2477.4 2486.4 2491.0 2434.3 2471.9 2477.2 2478.8 2486.2 2443.6 2472.2 2482.1 2488.3 2493.2 8742.5 8820.8 8827.8 8846.7 8853.8 5236.5 5381.4 5421.5 5424.4 5448.9 3324.6 3506.8 3596.2 3735.3 3792.0 1042.4 1059.9 1065.6 1071.5 1074.7 11659.0 11695.2 11841.8 11902.3 11923.0 4841.8 4883.9 4936.9 4946.9 4984.7 10031.7 10032.6 10043.3 10044.2 10084.8 5487.7 5488.6 5493.8 5495.8 5502.3 3859.8 4393.3 4568.7 4905.3 4963.8 3807.0 3899.0 3904.8 3923.7 3936.2 1296.6 1304.9 1308.6 1311.8 1313.1 1319.0 1344.9 1358.2 1372.8 1392.0 8061.2 8159.3 8159.9 8162.6 8174.3 475.3 486.8 513.7 524.8 526.3 5072.4 6175.0 6229.4 6240.0 6243.5 10170.3 10288.9 10299.6 10322.9 10329.8 9978.5 10319.1 10346.5 10347.3 10347.5 8110.0 8197.4 8319.0 8320.0 8323.9 7951.7 7973.3 7994.7 8086.6 8215.8 8976.9 9450.6 9496.1 9561.3 9696.2 9526.1 9887.8 9908.7 9932.7 9951.7 6755.8 6937.7 7144.2 7391.4 7474.4 8080.2 8124.4 8158.6 8160.6 8166.0 7191.6 7248.6 7299.6 7451.7 7462.1 7165.5 7218.9 7219.5 7233.9 7243.2 7510.3 7699.8 7705.4 7712.5 7712.5 6488.8 6603.0 6607.0 6609.0 6620.6 6988.7 7132.8 7135.7 7156.2 7157.9 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5626.84 Median:6472.80 stddev:1813.85 (28.0%) stddev-sans-first:1774.34 18:26:00 INFO - PROCESS | 1669 | Values: 300.7 314.2 324.4 336.0 337.2 6349.4 6469.8 6532.2 6576.9 6602.1 6364.5 6455.2 6455.9 6475.8 6493.8 4625.1 4719.4 4734.3 4846.3 4880.5 4751.0 4784.5 4836.7 4858.1 4866.4 4744.3 4754.4 4756.7 4758.5 4759.9 4365.5 4493.3 4593.5 4634.6 4749.0 4090.3 4096.2 4107.8 4107.9 4116.1 6088.4 6113.1 6116.7 6141.9 6184.9 5588.3 5605.0 5609.1 5611.5 5619.3 6806.0 6879.9 6882.3 6886.6 6890.5 3677.5 4329.6 4492.8 4506.6 4531.4 5636.0 6596.6 7252.7 7260.0 7276.4 4554.8 4555.3 4564.3 4566.1 4573.5 4199.1 4607.5 4618.8 4626.0 4633.5 4990.6 5445.2 5455.9 5458.8 5461.2 6578.3 6789.5 6872.6 6876.4 6877.0 1573.5 1589.2 1596.9 1599.7 1603.7 970.1 996.3 1028.4 1031.6 1048.5 5445.3 6401.0 6431.6 6535.7 6555.9 7166.9 7178.5 7180.3 7186.5 7209.5 6516.4 6520.4 6530.3 6530.9 6533.8 3043.8 3733.9 3790.6 3792.0 3794.6 7230.1 7508.0 7529.4 7538.7 7558.0 7392.9 7428.2 7438.5 7439.9 7455.4 7534.3 7535.9 7555.5 7556.8 7563.3 5552.3 7083.1 7207.3 7210.1 7211.3 7105.6 7114.8 7132.0 7138.7 7141.2 7440.0 7526.3 7536.2 7540.5 7544.7 4565.2 4567.7 4568.0 4572.4 4575.9 7131.8 7139.5 7143.0 7165.7 7176.7 5569.5 6586.1 6896.1 6908.8 6917.6 6811.3 6878.0 6889.6 6894.5 6900.8 5441.6 6745.8 6748.8 6758.8 6768.2 6868.0 6889.3 6899.3 6903.6 6927.6 6444.2 6495.9 6604.4 6634.1 6672.3 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18146.34 Median:63237.34 stddev:25579.07 (40.4%) stddev-sans-first:25617.19 18:26:00 INFO - PROCESS | 1669 | Values: 677.1 687.3 690.3 751.5 760.2 14882.7 15022.8 15146.0 15178.4 15185.5 13999.4 14370.9 14396.6 14407.2 14414.5 737.6 919.9 934.7 944.0 944.4 747.1 911.6 947.2 947.5 950.6 979.7 988.0 990.5 992.2 992.3 774.2 971.8 985.3 985.7 985.8 582.5 583.1 583.3 716.6 731.3 15332.5 15382.3 15404.5 15411.9 15423.0 10368.3 12558.1 12577.6 12739.0 12827.7 9946.8 9948.2 10026.6 10072.7 10400.3 3480.5 3543.5 3608.2 3612.9 3628.7 83076.2 83143.8 83260.2 86118.0 86728.7 9594.4 9664.7 9723.0 9885.2 9909.1 22475.3 22516.9 22522.8 22532.8 22554.5 6766.3 6914.5 6952.0 6971.2 6977.4 4019.9 4021.8 4062.4 4082.2 4137.2 3586.6 3604.3 3630.0 3631.7 3647.8 639.5 642.5 645.3 659.0 669.7 483.5 496.7 580.6 606.7 620.0 6661.9 7550.9 7841.3 7989.0 8199.4 581.2 589.2 594.7 602.3 612.2 3805.2 3819.7 3821.5 3919.8 4074.7 91019.0 91392.0 92996.5 93033.5 93373.5 77030.0 77591.2 77886.0 77934.0 77991.6 63092.0 67526.0 67973.0 68811.3 69114.0 7610.3 7772.0 7810.5 7838.2 7957.8 47395.0 47888.5 48289.3 48679.5 48815.8 62802.0 63382.7 63525.0 64407.4 67644.6 10929.5 10990.8 11035.8 11287.5 11799.2 11866.0 11986.5 12024.7 12191.0 12201.6 9010.6 11142.5 11212.5 11309.9 11613.6 11306.1 11336.2 11386.3 11571.0 11694.2 9603.3 11064.4 11190.6 11268.3 11927.2 9386.5 9545.5 9775.9 9822.9 9893.7 6929.5 8403.2 9612.7 9661.6 9670.3 18:26:00 INFO - PROCESS | 1669 | -------- Summary: end -------- 18:26:00 INFO - PROCESS | 1669 | 18:26:00 INFO - TEST-INFO | 1669: exit 0 18:26:00 INFO - TEST-OK | dromaeo_css | took 1114054ms 18:26:00 INFO - TEST-START | kraken 18:26:00 INFO - operating with platform_type : mac_ 18:26:00 INFO - Initialising browser for kraken test... 18:26:00 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpcGuXfe/profile http://localhost:49272/getInfo.html) 18:26:03 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 18:26:03 INFO - PROCESS | 1674 | colorDepth:24 18:26:03 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 18:26:03 INFO - PROCESS | 1674 | __metrics 18:26:03 INFO - PROCESS | 1674 | 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" 18:26:03 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:26:03 INFO - TEST-INFO | 1674: exit 0 18:26:03 INFO - Browser initialized. 18:26:03 INFO - Running cycle 1/1 for kraken test... 18:26:03 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpcGuXfe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:15 INFO - PROCESS | 1676 | RSS: Main: 243388416 18:26:15 INFO - PROCESS | 1676 | 18:26:18 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:18 INFO - PROCESS | 1676 | RSS: Main: 290754560 18:26:18 INFO - PROCESS | 1676 | 18:26:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 18:26:22 INFO - PROCESS | 1676 | RSS: Main: 301252608 18:26:22 INFO - PROCESS | 1676 | 18:26:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 18:26:26 INFO - PROCESS | 1676 | RSS: Main: 286953472 18:26:26 INFO - PROCESS | 1676 | 18:26:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 18:26:28 INFO - PROCESS | 1676 | RSS: Main: 288817152 18:26:28 INFO - PROCESS | 1676 | 18:26:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:31 INFO - PROCESS | 1676 | RSS: Main: 287420416 18:26:31 INFO - PROCESS | 1676 | 18:26:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:34 INFO - PROCESS | 1676 | RSS: Main: 288944128 18:26:34 INFO - PROCESS | 1676 | 18:26:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 18:26:37 INFO - PROCESS | 1676 | RSS: Main: 289562624 18:26:37 INFO - PROCESS | 1676 | 18:26:40 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 18:26:41 INFO - PROCESS | 1676 | RSS: Main: 288489472 18:26:41 INFO - PROCESS | 1676 | 18:26:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:26:43 INFO - PROCESS | 1676 | RSS: Main: 323518464 18:26:43 INFO - PROCESS | 1676 | 18:26:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:45 INFO - PROCESS | 1676 | RSS: Main: 322490368 18:26:45 INFO - PROCESS | 1676 | 18:26:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:48 INFO - PROCESS | 1676 | RSS: Main: 332713984 18:26:48 INFO - PROCESS | 1676 | 18:26:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:51 INFO - PROCESS | 1676 | RSS: Main: 334671872 18:26:51 INFO - PROCESS | 1676 | 18:26:54 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:26:55 INFO - PROCESS | 1676 | RSS: Main: 334491648 18:26:55 INFO - PROCESS | 1676 | 18:26:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 18:26:57 INFO - PROCESS | 1676 | RSS: Main: 393949184 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | __start_tp_report 18:26:57 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 18:26:57 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 18:26:57 INFO - PROCESS | 1676 | |i|pagename|runs| 18:26:57 INFO - PROCESS | 1676 | |0;ai-astar;109;109;110;109;108;108;116;107;109;108 18:26:57 INFO - PROCESS | 1676 | |1;audio-beat-detection;156;122;140;159;118;142;135;100;171;146 18:26:57 INFO - PROCESS | 1676 | |2;audio-dft;185;184;189;184;185;183;184;185;187;182 18:26:57 INFO - PROCESS | 1676 | |3;audio-fft;76;78;93;78;58;56;58;81;77;55 18:26:57 INFO - PROCESS | 1676 | |4;audio-oscillator;95;94;133;80;77;87;112;75;80;111 18:26:57 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;85;89;85;88;84;89;86;89;85 18:26:57 INFO - PROCESS | 1676 | |6;imaging-darkroom;93;104;143;94;93;93;93;94;93;93 18:26:57 INFO - PROCESS | 1676 | |7;imaging-desaturate;88;86;100;138;85;87;86;86;85;85 18:26:57 INFO - PROCESS | 1676 | |8;json-parse-financial;56;54;54;55;55;53;55;62;54;53 18:26:57 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;65;66;71;76;71;70;68;67;69;73 18:26:57 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;82;82;82;81;90;109;106;82;84;85 18:26:57 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;131;121;125;119;119;118;120;133;131;135 18:26:57 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;140;128;139;136;139;125;147;176;178;160 18:26:57 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;67;66;67;68;68;66;66;68;68 18:26:57 INFO - PROCESS | 1676 | __end_tp_report 18:26:57 INFO - PROCESS | 1676 | __start_cc_report 18:26:57 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1253 18:26:57 INFO - PROCESS | 1676 | __end_cc_report 18:26:57 INFO - PROCESS | 1676 | __startTimestamp1458091617115__endTimestamp 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | ------- Summary: start ------- 18:26:57 INFO - PROCESS | 1676 | Number of tests: 14 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.00 stddev:2.50 (2.3%) stddev-sans-first:2.65 18:26:57 INFO - PROCESS | 1676 | Values: 109.0 109.0 110.0 109.0 108.0 108.0 116.0 107.0 109.0 108.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:144.00 stddev:21.18 (14.7%) stddev-sans-first:21.55 18:26:57 INFO - PROCESS | 1676 | Values: 156.0 122.0 140.0 159.0 118.0 142.0 135.0 100.0 171.0 146.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.99 (1.1%) stddev-sans-first:2.11 18:26:57 INFO - PROCESS | 1676 | Values: 185.0 184.0 189.0 184.0 185.0 183.0 184.0 185.0 187.0 182.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:71.00 Median:77.50 stddev:13.17 (17.0%) stddev-sans-first:13.85 18:26:57 INFO - PROCESS | 1676 | Values: 76.0 78.0 93.0 78.0 58.0 56.0 58.0 81.0 77.0 55.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:80.00 stddev:18.93 (23.7%) stddev-sans-first:20.07 18:26:57 INFO - PROCESS | 1676 | Values: 95.0 94.0 133.0 80.0 77.0 87.0 112.0 75.0 80.0 111.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.50 stddev:2.08 (2.3%) stddev-sans-first:2.06 18:26:57 INFO - PROCESS | 1676 | Values: 89.0 85.0 89.0 85.0 88.0 84.0 89.0 86.0 89.0 85.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:93.00 stddev:15.73 (16.9%) stddev-sans-first:16.52 18:26:57 INFO - PROCESS | 1676 | Values: 93.0 104.0 143.0 94.0 93.0 93.0 93.0 94.0 93.0 93.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:86.00 stddev:16.57 (19.3%) stddev-sans-first:17.50 18:26:57 INFO - PROCESS | 1676 | Values: 88.0 86.0 100.0 138.0 85.0 87.0 86.0 86.0 85.0 85.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:2.60 (4.7%) stddev-sans-first:2.74 18:26:57 INFO - PROCESS | 1676 | Values: 56.0 54.0 54.0 55.0 55.0 53.0 55.0 62.0 54.0 53.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.50 stddev:3.34 (4.7%) stddev-sans-first:3.10 18:26:57 INFO - PROCESS | 1676 | Values: 65.0 66.0 71.0 76.0 71.0 70.0 68.0 67.0 69.0 73.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:82.00 stddev:10.47 (12.8%) stddev-sans-first:10.85 18:26:57 INFO - PROCESS | 1676 | Values: 82.0 82.0 82.0 81.0 90.0 109.0 106.0 82.0 84.0 85.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:128.00 stddev:6.65 (5.2%) stddev-sans-first:6.71 18:26:57 INFO - PROCESS | 1676 | Values: 131.0 121.0 125.0 119.0 119.0 118.0 120.0 133.0 131.0 135.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:143.50 stddev:18.60 (13.0%) stddev-sans-first:19.56 18:26:57 INFO - PROCESS | 1676 | Values: 140.0 128.0 139.0 136.0 139.0 125.0 147.0 176.0 178.0 160.0 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 18:26:57 INFO - PROCESS | 1676 | Values: 66.0 67.0 66.0 67.0 68.0 68.0 66.0 66.0 68.0 68.0 18:26:57 INFO - PROCESS | 1676 | -------- Summary: end -------- 18:26:57 INFO - PROCESS | 1676 | 18:26:57 INFO - TEST-INFO | 1676: exit 0 18:26:57 INFO - TEST-OK | kraken | took 57023ms 18:26:57 INFO - SUITE-END | took 1171s 18:26:58 INFO - Completed test suite (00:19:31) 18:26:58 INFO - javascript benchmark 18:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3178.1736748445405, 3501.2122272488677, 3535.6994655454287, 3542.238418739971, 3585.551806024247, 5560.805371811987, 5652.152177173426, 5665.405132461094, 5683.943160568393, 5694.658320500773, 5611.3266408030995, 5636.239107720457, 5666.093425051992, 5666.263385759856, 5672.0, 5142.665726727751, 5145.408278048017, 5188.818391356303, 5190.11767999441, 5249.343832020997, 5268.104422248227, 5268.973655131719, 5269.525742683158, 5274.077036518613, 5275.208718692188, 5134.563562097208, 5181.663191892534, 5213.530782229599, 5220.869478263055, 5225.608079394042, 5250.6324557281005, 5293.602979776532, 5303.814366497154, 5304.787808487675, 5364.222187782789, 5103.974480127613, 5109.156989096795, 5130.948690513122, 5184.533391994739, 5188.455212202702, 5554.694491802949, 5575.8606034849045, 5595.692236926968, 5599.496045355938, 5681.0, 6272.686365681743, 6276.466500347476, 6280.937190628081, 6285.120083188357, 6285.4343109119945, 5426.0, 6157.261128664589, 6252.624842509464, 6272.968635156841, 6286.49708023357, 5847.44449277318, 5848.356680765112, 5848.707564621752, 5851.707414629294, 5884.823455296348, 6290.339514350927, 6301.0, 6305.495560355161, 6307.369263073748, 6319.873602527924, 6079.179310793074, 6112.077967281658, 6156.569040167145, 6192.133101365813, 6232.56372053961, 6208.565400422018, 6272.3100458949475, 6287.9056814147825, 6291.150694656254, 6298.212723409574, 6153.938460615336, 6224.284207316216, 6226.906596401058, 6235.906461403082, 6249.7187626556915, 6115.727150604525, 6138.232720909887, 6193.380661933861, 6232.0, 6241.188645476059, 4854.708717476963, 4863.392075990501, 4871.391076115486, 4896.4124305082905, 4909.459959404463, 4390.297552391602, 4392.912141757147, 4393.604575588212, 4430.202563538594, 4432.689711720149, 5688.317401911714, 5772.220750198753, 5783.71081445926, 5863.296404431496, 5879.441453061952, 6223.751049958041, 6268.686565671789, 6277.089821975879, 6280.780172694025, 6293.96853015732, 5790.160426738099, 5817.360090390053, 5821.039528477754, 5822.301323841081, 5828.504577110908, 5280.9471905281225, 5343.278657381282, 5352.91970620441, 5381.596380271495, 5417.404085550586, 6372.394622510854, 6397.712102955471, 6401.64790936503, 6409.8077057687415, 6430.967845160744, 6155.47678447337, 6257.812265632038, 6258.6391876044445, 6284.780032698834, 6289.937100628935, 6335.366463353628, 6386.265579458236, 6417.839554011187, 6420.935790642221, 6434.356564343529, 6166.1983942087245, 6188.257409110935, 6216.2540495140875, 6223.657698826608, 6226.906596401148, 6129.603311142764, 6173.660448675366, 6289.08808222796, 6297.842553936188, 6305.180326557518, 5078.771455284595, 6052.90920636182, 6108.8778224436155, 6127.509799216141, 6137.3248942617165, 6109.725062372115, 6114.785982490592, 6122.0, 6131.019036954066, 6140.0, 5805.76776928935, 5913.467787898938, 5951.434613711691, 5972.402759723993, 6019.036954087325, 6024.90962635552, 6082.391760823883, 6130.042401873816, 6130.50955923534, 6147.815565533041, 5803.506701930383, 5838.474537291494, 5843.766249349978, 5847.590668653153, 5888.970555147368], "unit": "score", "name": "dojo.html", "value": 5709.278235529429}, {"lowerIsBetter": false, "replicates": [456.24946962247105, 480.1836877308572, 537.4840153452683, 634.7334119669738, 636.8280564247652, 30145.698543014565, 30541.236469088282, 30695.69304306956, 38362.61637383625, 39119.41320880189, 42781.7860910695, 43195.78402107985, 43280.91797705059, 43287.56712432875, 43399.13201735963, 9394.295427842904, 9621.903780962206, 9622.951885240598, 9625.759356016086, 9625.807483850354, 9372.0, 9518.714438566854, 9546.61813527458, 9548.665796697116, 9564.426134431922, 9496.857547136764, 9570.234381249518, 9573.473458959754, 9574.47340396278, 9576.090271424238, 9387.249020078378, 9536.380135291183, 9537.952310238405, 9554.904450955471, 9565.139137477625, 9323.860142097874, 9445.102715242041, 9448.102430269113, 9465.100815422524, 9481.810363792754, 40473.595264047275, 40919.38620920689, 40923.386149207785, 41010.179796404205, 41037.384439233436, 3127.5152351385573, 3202.295494991098, 3327.866885324584, 3425.743069269815, 3830.080780612661, 27770.028049018187, 28023.579646305323, 28112.578311325346, 28531.42937141266, 28664.713352866413, 2745.1764470658723, 2745.9862700686567, 2770.473610014091, 2863.8281703097673, 2921.5033444314518, 512143.0, 514843.0, 515019.0, 515332.0, 522604.0, 68203.0, 68890.31109688939, 69418.9587156193, 69451.30548694449, 69656.303436966, 71178.0, 72175.63912180405, 72388.63805680937, 72402.27597724061, 72440.27559724335, 15508.457203997807, 15555.30001149951, 15624.140672263135, 15636.92181539085, 15659.451919182773, 12026.15816892809, 12975.70242975695, 12995.155314904501, 13060.151090179108, 13110.475580976845, 21017.789822101888, 21346.78653213479, 21383.67924481103, 21401.250956216456, 21860.781392185876, 7694.653740581687, 8974.86537701935, 9146.954265228764, 9175.724728258163, 9187.356885017985, 937.5171786529943, 963.9614415423445, 1009.3792317724693, 1115.654147214366, 1182.0779791762438, 20766.688499672517, 25519.744802551737, 29269.56095658567, 29313.56029659557, 29513.26216844553, 1018.8217062014267, 1022.2741853284103, 1103.0293341859112, 1168.6669299249843, 1203.1277323940074, 14303.426623071453, 15903.522894312957, 15976.840231597767, 16003.919980400024, 16415.26131324093, 572913.0, 700952.0, 713015.0, 713730.0, 716495.0, 60807.69596151991, 60964.08553871696, 61511.769764604454, 61693.0, 61843.38156618466, 1305.536534530247, 1334.3061607963805, 1445.262915912892, 1456.4319915233068, 1464.1946929189116, 30444.543331849596, 31007.379852403275, 31314.530282046242, 31799.728010879306, 31873.8844140454, 46421.76789116033, 54064.64838379072, 54184.0, 54254.0, 54373.91252174855, 412317.938410306, 412780.9360953176, 415165.0, 418881.0, 418903.0, 31082.844585776926, 32859.34281314408, 32893.0, 32904.84833030833, 32946.17634559155, 42799.3580096305, 43124.78437607792, 43204.0, 43694.0, 44384.0, 35960.46059309165, 35961.28077438384, 36033.81983090068, 36745.816270918476, 36910.0, 35199.82400087983, 35293.117672058404, 35857.103572410895, 36206.818965905004, 36278.09304767402, 34552.48171277383, 35214.887106773676, 35353.11617209487, 35533.75631852873, 36420.0, 30254.394912102074, 31508.89718859829, 31539.21151971219, 31592.842035790592, 31644.367112658078, 23743.525129496968, 23773.16793912274, 23883.761162388848, 24100.0, 24101.384792281297], "unit": "score", "name": "ext.html", "value": 19959.29227755381}, {"lowerIsBetter": false, "replicates": [358.1761947520702, 359.5469708167708, 359.8236863936671, 370.7830918912436, 371.03160750441344, 15929.522114336574, 19258.22967081315, 20366.083526241317, 20767.376978690627, 20830.166793328288, 19096.33162839301, 20065.699014514757, 20156.294529691462, 20170.991450427457, 20186.192552297925, 5871.647701137946, 6083.270007599072, 6088.178095957033, 6146.108814221935, 6161.29145148307, 3447.9655203447896, 4179.414881916534, 4414.713043652152, 4416.646668266531, 6609.834754131137, 6543.869122617545, 6555.967220163892, 6558.606483610999, 6566.606003639773, 6578.901316480256, 5589.441055894418, 5859.970700146515, 5861.9706901465215, 6532.08550802888, 6537.2482164550975, 3742.176721121349, 5474.644148130359, 5595.468430499096, 5604.971975140098, 5699.373068962411, 13047.282399468026, 13267.867321326856, 13271.402786874614, 13276.336183190899, 20766.5846683067, 1966.9704954425695, 2012.5672980309157, 2042.714020037196, 2082.1983536338466, 2273.988630056839, 9477.194438472738, 9861.556229969668, 9925.75185620358, 10300.021497957681, 10365.844512332322, 1645.5145732008966, 1735.7830271216098, 1767.8939263644222, 1824.5438640339914, 1860.5534671678836, 84365.15634843634, 104314.0, 107015.46492267567, 109839.0, 110443.0, 11131.94246546593, 11140.387278699749, 11140.442977851075, 11151.330920144817, 11322.547098116147, 13614.523491677943, 13616.523421680193, 13683.0, 13711.382987765575, 13717.657058573415, 6911.377975982085, 8501.787455313666, 8552.957235213784, 8555.828883422297, 8575.1424857515, 8276.8344633107, 8772.517511536927, 8773.692920747742, 8850.64597416109, 8905.287576993825, 4444.755538445416, 4484.990877052637, 4496.145732310916, 4509.34614480905, 4549.044700612908, 1593.49804811484, 1841.8618603604516, 1886.6321067391727, 1891.6216756648726, 1897.345415831536, 743.5278598090143, 920.7191806498948, 940.520334629344, 996.7109538233976, 1073.683263437288, 17441.215145318492, 18389.90805045966, 19183.32858349951, 19523.414297571097, 19705.901470492558, 938.4885237545554, 968.9728887379259, 972.8589354543551, 972.9659461918799, 1052.1898138433364, 9018.323625728097, 10135.37833946565, 10405.21960852924, 10579.994900484442, 10613.5223914924, 559229.0, 582475.0, 601199.0, 657859.0, 665212.0, 118896.0, 118978.0, 122827.0, 123378.38310808389, 124320.0, 1024.9955044056717, 1028.1671845804922, 1061.2942393308517, 1077.1544337694872, 1083.918706097046, 17277.56806079808, 17307.653846923244, 17478.388256410966, 17806.732899006267, 17926.462206133838, 50005.74997124991, 50777.0, 50844.0, 50854.982900342526, 51015.46953591398, 69481.61036779337, 70731.64634177001, 71923.28076719165, 73566.26433735808, 75715.0, 7592.0, 7838.294553490213, 7846.843063138819, 7858.66402711529, 7860.371170306476, 10971.725706857393, 12025.037996960047, 12160.0, 12171.513139474322, 12502.624921252376, 8443.788905277417, 10311.175105991353, 10432.791344173225, 10675.306105103144, 10706.625268115578, 9162.175404213653, 10278.537465813906, 10416.0, 10450.634227801991, 10585.941405859661, 9060.640903864472, 10701.197410194422, 10744.623938162127, 10824.458777060958, 11056.226064175431, 7550.924490755022, 7666.38668906475, 7721.0, 7760.650770715444, 7880.527168369917, 8275.213854683796, 10416.687499375032, 10534.315269507457, 10874.184436167161, 10905.34567925927], "unit": "score", "name": "jquery.html", "value": 9064.049872763555}, {"lowerIsBetter": false, "replicates": [1441.9423223071078, 1595.553245091374, 1621.594601349663, 1921.1738952250535, 2051.4973831411307, 7952.602369881504, 8541.914580854189, 8686.174813392718, 8733.34499912506, 8735.91264087359, 8469.195426434495, 8717.694880679177, 8724.17120373565, 8729.519876406795, 8754.606042728077, 2156.439325775294, 2410.4937963027787, 2473.591857343536, 2483.540544999181, 2492.476579918219, 2490.6264060390904, 2493.7381574934643, 2498.812589055828, 2501.2371226775826, 2533.733957934418, 2413.3001429585397, 2463.9260822175274, 2477.3930387055107, 2486.3784053986506, 2491.028498885436, 2434.3183908505557, 2471.864047477388, 2477.1949116537016, 2478.8264821462503, 2486.2416962826333, 2443.6334549817493, 2472.184179220853, 2482.1436604371643, 2488.30327508298, 2493.2146373892165, 8742.519161446118, 8820.823583528294, 8827.823443531093, 8846.734597962071, 8853.778655533599, 5236.476352364771, 5381.4349493303425, 5421.484958928895, 5424.403315635277, 5448.891022179574, 3324.6010478742705, 3506.7551019388006, 3596.226811235597, 3735.2902948439983, 3792.03303157693, 1042.4318746283293, 1059.8887116852698, 1065.579096256982, 1071.4963966935527, 1074.693712291993, 11659.00898423635, 11695.239809412362, 11841.822372664417, 11902.34537100459, 11923.046156307475, 4841.806327746851, 4883.877903052452, 4936.90126197474, 4946.876328091755, 4984.675996060245, 10031.69904902854, 10032.598696052222, 10043.296969212084, 10044.246681498771, 10084.798304033879, 5487.725613719298, 5488.56091512686, 5493.807716729895, 5495.780168793203, 5502.284702988586, 3859.7877116758286, 4393.319035549495, 4568.680192386568, 4905.337779399807, 4963.751812409438, 3806.980965095157, 3898.96101038986, 3904.824282907276, 3923.6861051115843, 3936.232434675268, 1296.5656505070717, 1304.8564657887625, 1308.640123965917, 1311.8360204974379, 1313.0939651640338, 1318.993405032988, 1344.8991325650616, 1358.1986627889396, 1372.848986611472, 1392.025582092519, 8061.153578874251, 8159.347252219808, 8159.877601835978, 8162.551059691774, 8174.3460523158, 475.2680871457985, 486.75148244752097, 513.709753988995, 524.766478916886, 526.3184176491453, 5072.365954255718, 6174.9691251544355, 6229.3770622937345, 6240.032794916795, 6243.500519958392, 10170.288079834341, 10288.948555257175, 10299.588016479256, 10322.948385258176, 10329.84505232422, 9978.501074946224, 10319.071283584513, 10346.53440595175, 10347.27569070158, 10347.534360953776, 8109.959450202829, 8197.385196110316, 8318.958405207935, 8320.001599807942, 8323.916760832315, 7951.721689740832, 7973.322267607318, 7994.720184793737, 8086.555239461886, 8215.79460513468, 8976.910230897607, 9450.574724137568, 9496.14534691881, 9561.282903782105, 9696.22430205596, 9526.095020972996, 9887.802243955224, 9908.653197138066, 9932.702018939442, 9951.701448956543, 6755.7973260802255, 6937.7224911002995, 7144.1784194818265, 7391.445641576795, 7474.439417043852, 8080.151584083822, 8124.390670699603, 8158.551279679675, 8160.591970401338, 8166.0, 7191.568505889663, 7248.637568121468, 7299.598522081124, 7451.739189128354, 7462.067241594801, 7165.462590305852, 7218.855622887408, 7219.530730502711, 7233.927660723325, 7243.167035790952, 7510.324070833432, 7699.846003080019, 7705.383569314554, 7712.498687585289, 7712.537247765152, 6488.772892948724, 6602.966985165043, 6607.041978912935, 6609.0, 6620.63586502747, 6988.6505674715045, 7132.750353737594, 7135.678894449658, 7156.248593897566, 7157.856842863218], "unit": "score", "name": "mootools.html", "value": 4815.360013735469}, {"lowerIsBetter": false, "replicates": [300.67977603851887, 314.15179016655037, 324.3950033188104, 335.9697627213552, 337.22774845603567, 6349.42855143037, 6469.835429622666, 6532.150820393343, 6576.901346479801, 6602.10871532343, 6364.490840732742, 6455.193100862392, 6455.870882582346, 6475.773347932812, 6493.772717954873, 4625.098105869357, 4719.362886010379, 4734.337192793012, 4846.273059041155, 4880.463149053601, 4750.97624511877, 4784.497627749089, 4836.709797412149, 4858.125537403266, 4866.440359358666, 4744.312074749177, 4754.405699287589, 4756.7145971241835, 4758.547937945907, 4759.928601070987, 4365.541618130114, 4493.303537951622, 4593.471750748673, 4634.559716826913, 4748.976255118702, 4090.3455447128317, 4096.201240758053, 4107.753534787892, 4107.856225032109, 4116.073883376246, 6088.360722124202, 6113.144159817629, 6116.663583502906, 6141.907871381933, 6184.938150618481, 5588.30146231721, 5604.971975140139, 5609.074502707049, 5611.523020543259, 5619.297587801525, 6806.0, 6879.931200687979, 6882.311768823128, 6886.586804791678, 6890.483213758988, 3677.485152078711, 4329.610335069859, 4492.7528985905765, 4506.571875671806, 4531.43357080365, 5636.0, 6596.571222870498, 7252.746153884589, 7259.963700181518, 7276.381507571863, 4554.817807287672, 4555.2711566149255, 4564.269716845289, 4566.06395688883, 4573.451185857718, 4199.0552125772065, 4607.516210797885, 4618.838340658061, 4626.0, 4633.513481084505, 4990.600751939836, 5445.183222516575, 5455.945440545624, 5458.781648734006, 5461.2354270402175, 6578.3092775258865, 6789.456843452512, 6872.587644741231, 6876.449884009267, 6877.0, 1573.5358069369563, 1589.1815714906832, 1596.8562829345183, 1599.7120518306817, 1603.7193491139003, 970.068734015339, 996.3175224970918, 1028.4292217819182, 1031.5770534081141, 1048.533402635835, 5445.346558413015, 6400.967995160087, 6431.6462594556815, 6535.705893234721, 6555.934440655532, 7166.856662866713, 7178.497505174588, 7180.281971802882, 7186.46101542376, 7209.495335326582, 6516.380943810425, 6520.413162815369, 6530.314316996742, 6530.869382612321, 6533.771318003847, 3043.786934914579, 3733.906652333659, 3790.56408513019, 3791.962080379161, 3794.5636251831393, 7230.096237970254, 7508.0239568855695, 7529.397648188132, 7538.660760265801, 7558.0, 7392.926070739331, 7428.182899881117, 7438.516496427823, 7439.925600744032, 7455.366293865082, 7534.321911027924, 7535.944967704416, 7555.546667199876, 7556.8488630228185, 7563.281488258716, 5552.250446189712, 7083.079199704005, 7207.279272072751, 7210.062691850026, 7211.278872112747, 7105.6447177639875, 7114.822129446805, 7132.0, 7138.678759455941, 7141.178764442156, 7439.962800185965, 7526.32263096324, 7536.171021187555, 7540.509866858637, 7544.660490277841, 4565.223911935045, 4567.748773817472, 4567.954320456753, 4572.428446444194, 4575.885602859955, 7131.750388736369, 7139.501644194411, 7143.035690181967, 7165.677544510405, 7176.7129314826825, 5569.498745112959, 6586.1438013059915, 6896.1035065443175, 6908.758193463204, 6917.584944903322, 6811.250762416031, 6878.037074809431, 6889.586624802528, 6894.517383783087, 6900.827479313058, 5441.591880608891, 6745.831354216184, 6748.797536073926, 6758.831029224112, 6768.187817461936, 6868.0, 6889.311068893071, 6899.344562266577, 6903.585784852925, 6927.58434493932, 6444.162258906312, 6495.902561461677, 6604.438622717123, 6634.104395906491, 6672.332766723483], "unit": "score", "name": "prototype.html", "value": 5019.4989632694915}, {"lowerIsBetter": false, "replicates": [677.0893148714978, 687.3195536418947, 690.2614202803002, 751.4589495563199, 760.1752098972611, 14882.702345953074, 15022.774658380133, 15146.01550899192, 15178.392864285415, 15185.54443366698, 13999.370028348723, 14370.856291437083, 14396.568102956902, 14407.207603581799, 14414.49549265776, 737.5832654550189, 919.9448033118001, 934.7055677461578, 944.0182210501105, 944.4333399960037, 747.0549754560485, 911.5806728904712, 947.2422062350092, 947.4788866123639, 950.6197520991624, 979.7158823941048, 988.011988011988, 990.4948476277078, 992.2012779712329, 992.320260621473, 774.1832366852968, 971.8299297622923, 985.3102828020415, 985.6500942165535, 985.8324084905512, 582.5136011430461, 583.0525396231125, 583.3262581718122, 716.5772194405326, 731.297953964195, 15332.463363782213, 15382.3077961492, 15404.537863864101, 15411.922940385226, 15423.0, 10368.274220804547, 12558.120931534704, 12577.579228255281, 12739.044571657163, 12827.743445131046, 9946.80106397868, 9948.204143668489, 10026.64906728261, 10072.748181295527, 10400.271980961335, 3480.477928310748, 3543.5039094526787, 3608.2242317901514, 3612.8554857805657, 3628.7459877808565, 83076.16923830744, 83143.75284370739, 83260.16739832585, 86118.0, 86728.69906951401, 9594.42433453995, 9664.661736839176, 9723.0, 9885.159761420216, 9909.108180263811, 22475.325740227818, 22516.874156292448, 22522.77477225207, 22532.77467225307, 22554.548909021727, 6766.289539598271, 6914.481413893978, 6952.031580206523, 6971.198312194061, 6977.372036516738, 4019.8995025124605, 4021.7989100544855, 4062.431259623655, 4082.2243773682903, 4137.213929353474, 3586.55168103987, 3604.333198358312, 3629.9637003629628, 3631.6731494165124, 3647.7811331320204, 639.526750204845, 642.495640921874, 645.2515082504273, 659.0476761080193, 669.6517810738388, 483.4609410507329, 496.72183577196887, 580.5703779203359, 606.6784604159802, 619.956603037783, 6661.933380666228, 7550.886736698954, 7841.294283514511, 7989.0, 8199.363310783947, 581.1718301420459, 589.1663296435581, 594.6788734083547, 602.3434456442499, 612.2010775937356, 3805.1818858945458, 3819.6944244460933, 3821.5420414373093, 3919.8432062717743, 4074.6536544393466, 91019.0, 91392.0, 92996.53501732448, 93033.53483232675, 93373.5331323339, 77030.0, 77591.22408775953, 77886.0, 77934.0, 77991.61004194943, 63092.0, 67525.98711019338, 67973.0, 68811.31188688149, 69114.0, 7610.315071643578, 7772.0, 7810.531368117931, 7838.216178382117, 7957.801054973672, 47395.0, 47888.521114788404, 48289.27566086582, 48679.51320486891, 48815.75592122017, 62802.0, 63382.68308658427, 63525.0, 64407.355926440134, 67644.64710705857, 10929.508172132115, 10990.780184396108, 11035.834462482908, 11287.548498059985, 11799.17405781587, 11866.0, 11986.520539178335, 12024.699382515508, 12191.0, 12201.633950981484, 9010.639574417211, 11142.498587563741, 11212.49543770516, 11309.943450282695, 11613.593524226611, 11306.095512358826, 11336.244887449408, 11386.259893106922, 11571.0, 11694.228822139574, 9603.279754018336, 11064.446777661246, 11190.608328708457, 11268.267562608404, 11927.224730392496, 9386.530673466435, 9545.522723863918, 9775.853362199716, 9822.901770982198, 9893.703188904345, 6929.514933954575, 8403.201695838885, 9612.711618651452, 9661.565229564545, 9670.274729395183], "unit": "score", "name": "yui.html", "value": 6837.621107695802}], "name": "dromaeo_css", "value": 7448.116876345064}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 108.0, 108.0, 116.0, 107.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 140.0, 159.0, 118.0, 142.0, 135.0, 100.0, 171.0, 146.0], "unit": "score", "name": "audio-beat-detection", "value": 138.9}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 189.0, 184.0, 185.0, 183.0, 184.0, 185.0, 187.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 93.0, 78.0, 58.0, 56.0, 58.0, 81.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 71.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 80.0, 77.0, 87.0, 112.0, 75.0, 80.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 89.0, 85.0, 88.0, 84.0, 89.0, 86.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.9}, {"lowerIsBetter": true, "replicates": [93.0, 104.0, 143.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 99.3}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 100.0, 138.0, 85.0, 87.0, 86.0, 86.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 92.6}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 55.0, 55.0, 53.0, 55.0, 62.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 71.0, 76.0, 71.0, 70.0, 68.0, 67.0, 69.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 81.0, 90.0, 109.0, 106.0, 82.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [131.0, 121.0, 125.0, 119.0, 119.0, 118.0, 120.0, 133.0, 131.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [140.0, 128.0, 139.0, 136.0, 139.0, 125.0, 147.0, 176.0, 178.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 68.0, 68.0, 66.0, 66.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1429.2}]} 18:26:58 INFO - Return code: 0 18:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:26:58 ERROR - # TBPL SUCCESS # 18:26:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:26:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:26:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:26:58 INFO - 2016-03-15 18:26:58.410 screenresolution[1680:10105] starting screenresolution argv=screenresolution get 18:26:58 INFO - 2016-03-15 18:26:58.412 screenresolution[1680:10105] Display 0: 1600x1200x32@60 18:26:58 INFO - 2016-03-15 18:26:58.418 screenresolution[1681:10108] starting screenresolution argv=screenresolution list 18:26:58 INFO - Available Modes on Display 0 18:26:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:26:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:26:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:26:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:26:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:26:58 INFO - Intel Iris: 18:26:58 INFO - Chipset Model: Intel Iris 18:26:58 INFO - Type: GPU 18:26:58 INFO - Bus: Built-In 18:26:58 INFO - VRAM (Dynamic, Max): 1536 MB 18:26:58 INFO - Vendor: Intel (0x8086) 18:26:58 INFO - Device ID: 0x0a2e 18:26:58 INFO - Revision ID: 0x0009 18:26:58 INFO - Displays: 18:26:58 INFO - Display: 18:26:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:26:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:26:58 INFO - Display Serial Number: 1600x1200 60 18:26:58 INFO - Main Display: Yes 18:26:58 INFO - Mirror: Off 18:26:58 INFO - Online: Yes 18:26:58 INFO - Rotation: Supported 18:26:58 INFO - Return code: 0 18:26:58 INFO - Running post-action listener: _resource_record_post_action 18:26:58 INFO - Running post-run listener: _resource_record_post_run 18:26:59 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33967616; Write bytes: 706803200; Read time: 361; Write time: 2108 18:26:59 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402432512; Write bytes: 403437056; Read time: 30234; Write time: 728 18:26:59 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32161280; Write bytes: 302518272; Read time: 341; Write time: 1379 18:26:59 INFO - Running post-run listener: _upload_blobber_files 18:26:59 INFO - Blob upload gear active. 18:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:26:59 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 18:26:59 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'] 18:26:59 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 18:27:00 INFO - (blobuploader) - INFO - Open directory for files ... 18:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:01 INFO - (blobuploader) - INFO - Done attempting. 18:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:02 INFO - (blobuploader) - INFO - Done attempting. 18:27:02 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:02 INFO - Return code: 0 18:27:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa3bfc2501451b6122237c07d1198e9309b448f455a90418430b6c6b7e374cf1130455bdcafbe11c770075575242de5a01722e48cfa3f381c62a18dbe703d5d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7017d0f90514f9df63a73bab4f387b7f95513f808c84a4477be6347bf859a4f4f54a7b031542db66f46b3cf4121af0863bd7c42edc9392173a5d308d3caefdd"} 18:27:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:02 INFO - Contents: 18:27:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa3bfc2501451b6122237c07d1198e9309b448f455a90418430b6c6b7e374cf1130455bdcafbe11c770075575242de5a01722e48cfa3f381c62a18dbe703d5d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7017d0f90514f9df63a73bab4f387b7f95513f808c84a4477be6347bf859a4f4f54a7b031542db66f46b3cf4121af0863bd7c42edc9392173a5d308d3caefdd"} 18:27:02 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:02 INFO - Copying logs to upload dir... 18:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1328.140438 ========= master_lag: 2.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2016-03-15 18:27:05.643447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-15 18:27:05.646841) ========= 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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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/aa3bfc2501451b6122237c07d1198e9309b448f455a90418430b6c6b7e374cf1130455bdcafbe11c770075575242de5a01722e48cfa3f381c62a18dbe703d5d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7017d0f90514f9df63a73bab4f387b7f95513f808c84a4477be6347bf859a4f4f54a7b031542db66f46b3cf4121af0863bd7c42edc9392173a5d308d3caefdd"} build_url:https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/YZ8ma9r-Q1ebFYIVxmEVGQ/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/aa3bfc2501451b6122237c07d1198e9309b448f455a90418430b6c6b7e374cf1130455bdcafbe11c770075575242de5a01722e48cfa3f381c62a18dbe703d5d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7017d0f90514f9df63a73bab4f387b7f95513f808c84a4477be6347bf859a4f4f54a7b031542db66f46b3cf4121af0863bd7c42edc9392173a5d308d3caefdd"}' ========= master_lag: 1.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-15 18:27:06.849934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:27:06.850339) ========= 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.gJ5QOgmmv2/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.nx2gG22bBV/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005099 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 18:27:06.878231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 18:27:06.878602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 18:27:06.884478) ========= ========= Total master_lag: 4.28 =========