bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Joseph Mingrone]

[-- Attachment #1: Type: text/plain, Size: 4357 bytes --]

After updating to 24.4 I'm having problems opening files with tramp.
Here are the sequence of events to reproduce the problem.

emacs -Q

Evaluate
(setq tramp-debug-buffer t)
(setq tramp-verbose 10)

C-x C-f /remote-host:/some/path/file

In the minibuffer I see "Tramp: Checking `vc-registered' for
/scp:phe:/home/jrm/input.tre" (then an indefinitely rotating '/').

When I cancel with C-g, then try again visiting the file again
everything works.  If I try again it will fail again.

I've attached the contents of the tramp buffers.  I've reproduced the
problem on other hosts also running FreeBSD (amd64 9.3).

Joseph

In GNU Emacs 24.4.1 (i386-portbld-freebsd9.3, X toolkit)
 of 2014-10-27 on gly.ftfl.ca
Windowing system distributor `The X.Org Foundation', version 11.0.11204000
Configured using:
 `configure --localstatedir=/var --without-compress-install
 --without-dbus --with-file-notification=gfile --without-gconf
 --with-gif --with-gnutls --without-gsettings --with-jpeg
 --without-m17n-flt --with-imagemagick --with-libotf --with-png
 --without-toolkit-scroll-bars --with-rsvg --with-tiff --with-x
 --with-xft --with-xim --with-xml2 --with-xpm --with-x-toolkit=athena
 --without-xaw3d --with-sound=oss --x-libraries=/usr/local/lib
 --x-includes=/usr/local/include --prefix=/usr/local
 --mandir=/usr/local/man --infodir=/usr/local/share/emacs/info/
 --build=i386-portbld-freebsd9.3 'CFLAGS=-O2 -pipe -fno-strict-aliasing'
 CPPFLAGS=-I/usr/local/include 'LDFLAGS= -L/usr/local/lib
 -Wl,-rpath=/usr/local/lib -ltinfo''

Important settings:
  value of $LANG: en_CA.UTF-8
  locale-coding-system: utf-8-unix

Major mode: Fundamental

Minor modes in effect:
  shell-dirtrack-mode: t
  tooltip-mode: t
  electric-indent-mode: t
  mouse-wheel-mode: t
  tool-bar-mode: t
  menu-bar-mode: t
  file-name-shadow-mode: t
  global-font-lock-mode: t
  font-lock-mode: t
  blink-cursor-mode: t
  auto-composition-mode: t
  auto-encryption-mode: t
  auto-compression-mode: t
  line-number-mode: t
  transient-mark-mode: t

Recent input:
C-y M-y C-a C-k C-y C-a C-p ( C-n C-e C-b C-b C-b C-d 
C-d 6 C-e C-p C-e C-x C-e C-n C-x C-e C-x C-f C-a C-k 
/ p h e : / h o m e / j r m / i n p u t . t r e <return> 
C-x C-f <up> <return> M-x r e p o r t - e m <tab> 
<return>

Recent messages:
Tramp: Opening connection for phe using scp...done
Tramp: Inserting `/scp:phe:/home/jrm/input.tre'...
Tramp: Encoding remote file `/scp:phe:/home/jrm/input.tre' with `recode data..base64 <%s'...done
Tramp: Decoding local file `/tmp/tramp.2137x3z.tre' with `base64-decode-region'...done
Tramp: Inserting `/scp:phe:/home/jrm/input.tre'...done

Tramp: Checking `vc-registered' for /scp:phe:/home/jrm/input.tre...failed
Tramp: Inserting `/scp:phe:/home/jrm/input.tre'...done
Quit
scroll-down-command: Beginning of buffer

Load-path shadows:
None found.

Features:
(shadow sort mail-extr emacsbug message rfc822 mml easymenu mml-sec
mm-decode mm-bodies mm-encode mail-parse rfc2231 mailabbrev gmm-utils
mailheader sendmail rfc2047 rfc2045 ietf-drums mail-utils noutline
outline easy-mmode tramp-cache tramp-sh tramp tramp-compat auth-source
eieio byte-opt bytecomp byte-compile cconv eieio-core gnus-util mm-util
mail-prsvr password-cache tramp-loaddefs trampver shell pcomplete comint
ansi-color ring format-spec advice help-fns mule-util time-date tooltip
electric uniquify ediff-hook vc-hooks lisp-float-type mwheel x-win x-dnd
tool-bar dnd fontset image regexp-opt fringe tabulated-list newcomment
lisp-mode prog-mode register page menu-bar rfn-eshadow timer select
scroll-bar mouse jit-lock font-lock syntax facemenu font-core frame cham
georgian utf-8-lang misc-lang vietnamese tibetan thai tai-viet lao
korean japanese hebrew greek romanian slovak czech european ethiopic
indian cyrillic chinese case-table epa-hook jka-cmpr-hook help simple
abbrev minibuffer nadvice loaddefs button faces cus-face macroexp files
text-properties overlay sha1 md5 base64 format env code-pages mule
custom widget hashtable-print-readable backquote make-network-process
gfilenotify dynamic-setting font-render-setting x-toolkit x multi-tty
emacs)

Memory information:
((conses 8 97723 8928)
 (symbols 24 20385 0)
 (miscs 20 45 226)
 (strings 16 19553 3568)
 (string-bytes 1 578648)
 (vectors 8 12967)
 (vector-slots 4 441209 6360)
 (floats 8 129 203)
 (intervals 28 1612 1004)
 (buffers 512 14))


[-- Attachment #2: tramp_debug.txt --]
[-- Type: text/plain, Size: 38714 bytes --]

;; GNU Emacs: 24.4.1 Tramp: 2.2.9-24.4 -*- mode: outline; -*-
16:47:55.377377 tramp-get-file-exists-command (5) # Finding command to check if file exists
16:47:55.377565 tramp-get-test-command (5) # Finding a suitable `test' command
16:47:55.377965 tramp-maybe-open-connection (3) # Opening connection for phe using scp...
16:47:55.378813 tramp-maybe-open-connection (6) # /bin/sh -i
16:47:55.379900 tramp-wait-for-regexp (6) # 
#$ 
16:47:55.380678 tramp-maybe-open-connection (3) # Sending command `exec ssh   -o ControlPath=/tmp/tramp.2137rFq.%r@%h:%p -o ControlMaster=auto -o ControlPersist=no -e none phe'
16:47:55.380822 tramp-send-command (6) # exec ssh   -o ControlPath=/tmp/tramp.2137rFq.%r@%h:%p -o ControlMaster=auto -o ControlPersist=no -e none phe
16:47:55.381165 tramp-process-actions (3) # Waiting for prompts from remote shell...
16:47:55.381484 tramp-process-one-action (5) # Looking for regexp "\(.*ogin\( .*\)?: *\)\'" from remote shell
16:47:55.382102 tramp-process-one-action (5) # Looking for regexp "\(^.*\(\(?:adgangskode\|contrase\(?:\(?:ny\|ñ\)a\)\|geslo\|h\(?:\(?:asł\|esl\)o\)\|iphasiwedi\|jelszó\|l\(?:ozinka\|ösenord\)\|m\(?:ot de passe\|ật khẩu\)\|pa\(?:rola\|s\(?:ahitza\|s\(?: phrase\|ord\|phrase\|wor[dt]\)\|vorto\)\)\|s\(?:alasana\|enha\|laptažodis\)\|wachtwoord\|лозинка\|пароль\|ססמה\|كلمة السر\|गुप्तशब्द\|शब्दकूट\|গুপ্তশব্দ\|পাসওয়ার্ড\|ਪਾਸਵਰਡ\|પાસવર્ડ\|ପ୍ରବେଶ ସଙ୍କେତ\|கடவுச்சொல்\|సంకేతపదము\|ಗುಪ್ತಪದ\|അടയാളവാക്ക്\|රහස්පදය\|ពាក្យសម្ងាត់\|パスワード\|密[码碼]\|암호\)\).*:\0? *\)\'" from remote shell
16:47:55.382458 tramp-process-one-action (5) # Looking for regexp "\(^.*\(Connection \(?:\(?:clo\|refu\)sed\)\|Host key verification failed\.\|Login \(?:[Ii]ncorrect\)\|N\(?:ame or service not known\|o supported authentication methods left to try!\)\|Permission denied\|\(?:Sorry, try again\|Timeout, server not responding\)\.\).*\|^.*\(Received signal [0-9]+\).*\)\'" from remote shell
16:47:55.382708 tramp-process-one-action (5) # Looking for regexp "\(^[^#$%>
]*[#$%>] *\)\'" from remote shell
16:47:55.382854 tramp-process-one-action (5) # Looking for regexp "\(\(?:^\|\r\)[^]#$%>
]*#?[]#$%>] *\(^[\[[0-9;]*[a-zA-Z] *\)*\)\'" from remote shell
16:47:55.383024 tramp-process-one-action (5) # Looking for regexp "\(\(Are you sure you want to continue connecting (yes/no)\?\)\s-*\)\'" from remote shell
16:47:55.383171 tramp-process-one-action (5) # Looking for regexp "\(\(\(?:Store key in cache\? (y/\|Update cached key\? (y/n, Return cancels connectio\)n)\)\s-*\)\'" from remote shell
16:47:55.383314 tramp-process-one-action (5) # Looking for regexp "\(\(TERM = (.*)\|Terminal type\? \[.*\]\)\s-*\)\'" from remote shell
16:47:55.383458 tramp-process-one-action (5) # Looking for regexp "\(\)\'" from remote shell
16:47:55.383592 tramp-process-one-action (5) # Call `tramp-action-process-alive'
16:47:55.581512 tramp-process-one-action (5) # Looking for regexp "\(.*ogin\( .*\)?: *\)\'" from remote shell
16:47:55.582367 tramp-process-one-action (5) # Looking for regexp "\(^.*\(\(?:adgangskode\|contrase\(?:\(?:ny\|ñ\)a\)\|geslo\|h\(?:\(?:asł\|esl\)o\)\|iphasiwedi\|jelszó\|l\(?:ozinka\|ösenord\)\|m\(?:ot de passe\|ật khẩu\)\|pa\(?:rola\|s\(?:ahitza\|s\(?: phrase\|ord\|phrase\|wor[dt]\)\|vorto\)\)\|s\(?:alasana\|enha\|laptažodis\)\|wachtwoord\|лозинка\|пароль\|ססמה\|كلمة السر\|गुप्तशब्द\|शब्दकूट\|গুপ্তশব্দ\|পাসওয়ার্ড\|ਪਾਸਵਰਡ\|પાસવર્ડ\|ପ୍ରବେଶ ସଙ୍କେତ\|கடவுச்சொல்\|సంకేతపదము\|ಗುಪ್ತಪದ\|അടയാളവാക്ക്\|රහස්පදය\|ពាក្យសម្ងាត់\|パスワード\|密[码碼]\|암호\)\).*:\0? *\)\'" from remote shell
16:47:55.582809 tramp-process-one-action (5) # Looking for regexp "\(^.*\(Connection \(?:\(?:clo\|refu\)sed\)\|Host key verification failed\.\|Login \(?:[Ii]ncorrect\)\|N\(?:ame or service not known\|o supported authentication methods left to try!\)\|Permission denied\|\(?:Sorry, try again\|Timeout, server not responding\)\.\).*\|^.*\(Received signal [0-9]+\).*\)\'" from remote shell
16:47:55.583052 tramp-process-one-action (5) # Looking for regexp "\(^[^#$%>
]*[#$%>] *\)\'" from remote shell
16:47:55.583201 tramp-process-one-action (5) # Looking for regexp "\(\(?:^\|\r\)[^]#$%>
]*#?[]#$%>] *\(^[\[[0-9;]*[a-zA-Z] *\)*\)\'" from remote shell
16:47:55.583372 tramp-process-one-action (5) # Looking for regexp "\(\(Are you sure you want to continue connecting (yes/no)\?\)\s-*\)\'" from remote shell
16:47:55.583512 tramp-process-one-action (5) # Looking for regexp "\(\(\(?:Store key in cache\? (y/\|Update cached key\? (y/n, Return cancels connectio\)n)\)\s-*\)\'" from remote shell
16:47:55.583652 tramp-process-one-action (5) # Looking for regexp "\(\(TERM = (.*)\|Terminal type\? \[.*\]\)\s-*\)\'" from remote shell
16:47:55.583789 tramp-process-one-action (5) # Looking for regexp "\(\)\'" from remote shell
16:47:55.583917 tramp-process-one-action (5) # Call `tramp-action-process-alive'
16:47:55.584103 tramp-process-one-action (5) # Looking for regexp "\(.*ogin\( .*\)?: *\)\'" from remote shell
16:47:55.584981 tramp-process-one-action (5) # Looking for regexp "\(^.*\(\(?:adgangskode\|contrase\(?:\(?:ny\|ñ\)a\)\|geslo\|h\(?:\(?:asł\|esl\)o\)\|iphasiwedi\|jelszó\|l\(?:ozinka\|ösenord\)\|m\(?:ot de passe\|ật khẩu\)\|pa\(?:rola\|s\(?:ahitza\|s\(?: phrase\|ord\|phrase\|wor[dt]\)\|vorto\)\)\|s\(?:alasana\|enha\|laptažodis\)\|wachtwoord\|лозинка\|пароль\|ססמה\|كلمة السر\|गुप्तशब्द\|शब्दकूट\|গুপ্তশব্দ\|পাসওয়ার্ড\|ਪਾਸਵਰਡ\|પાસવર્ડ\|ପ୍ରବେଶ ସଙ୍କେତ\|கடவுச்சொல்\|సంకేతపదము\|ಗುಪ್ತಪದ\|അടയാളവാക്ക്\|රහස්පදය\|ពាក្យសម្ងាត់\|パスワード\|密[码碼]\|암호\)\).*:\0? *\)\'" from remote shell
16:47:55.585603 tramp-process-one-action (5) # Looking for regexp "\(^.*\(Connection \(?:\(?:clo\|refu\)sed\)\|Host key verification failed\.\|Login \(?:[Ii]ncorrect\)\|N\(?:ame or service not known\|o supported authentication methods left to try!\)\|Permission denied\|\(?:Sorry, try again\|Timeout, server not responding\)\.\).*\|^.*\(Received signal [0-9]+\).*\)\'" from remote shell
16:47:55.585943 tramp-process-one-action (5) # Looking for regexp "\(^[^#$%>
]*[#$%>] *\)\'" from remote shell
16:47:55.586109 tramp-process-one-action (5) # Looking for regexp "\(\(?:^\|\r\)[^]#$%>
]*#?[]#$%>] *\(^[\[[0-9;]*[a-zA-Z] *\)*\)\'" from remote shell
16:47:55.586310 tramp-process-one-action (5) # Looking for regexp "\(\(Are you sure you want to continue connecting (yes/no)\?\)\s-*\)\'" from remote shell
16:47:55.594711 tramp-process-one-action (5) # Looking for regexp "\(\(\(?:Store key in cache\? (y/\|Update cached key\? (y/n, Return cancels connectio\)n)\)\s-*\)\'" from remote shell
16:47:55.594888 tramp-process-one-action (5) # Looking for regexp "\(\(TERM = (.*)\|Terminal type\? \[.*\]\)\s-*\)\'" from remote shell
16:47:55.595032 tramp-process-one-action (5) # Looking for regexp "\(\)\'" from remote shell
16:47:55.595160 tramp-process-one-action (5) # Call `tramp-action-process-alive'
16:47:55.664335 tramp-process-one-action (5) # Looking for regexp "\(.*ogin\( .*\)?: *\)\'" from remote shell
16:47:55.665803 tramp-process-one-action (5) # Looking for regexp "\(^.*\(\(?:adgangskode\|contrase\(?:\(?:ny\|ñ\)a\)\|geslo\|h\(?:\(?:asł\|esl\)o\)\|iphasiwedi\|jelszó\|l\(?:ozinka\|ösenord\)\|m\(?:ot de passe\|ật khẩu\)\|pa\(?:rola\|s\(?:ahitza\|s\(?: phrase\|ord\|phrase\|wor[dt]\)\|vorto\)\)\|s\(?:alasana\|enha\|laptažodis\)\|wachtwoord\|лозинка\|пароль\|ססמה\|كلمة السر\|गुप्तशब्द\|शब्दकूट\|গুপ্তশব্দ\|পাসওয়ার্ড\|ਪਾਸਵਰਡ\|પાસવર્ડ\|ପ୍ରବେଶ ସଙ୍କେତ\|கடவுச்சொல்\|సంకేతపదము\|ಗುಪ್ತಪದ\|അടയാളവാക്ക്\|රහස්පදය\|ពាក្យសម្ងាត់\|パスワード\|密[码碼]\|암호\)\).*:\0? *\)\'" from remote shell
16:47:55.666639 tramp-process-one-action (5) # Looking for regexp "\(^.*\(Connection \(?:\(?:clo\|refu\)sed\)\|Host key verification failed\.\|Login \(?:[Ii]ncorrect\)\|N\(?:ame or service not known\|o supported authentication methods left to try!\)\|Permission denied\|\(?:Sorry, try again\|Timeout, server not responding\)\.\).*\|^.*\(Received signal [0-9]+\).*\)\'" from remote shell
16:47:55.667009 tramp-process-one-action (5) # Looking for regexp "\(^[^#$%>
]*[#$%>] *\)\'" from remote shell
16:47:55.667183 tramp-process-one-action (5) # Looking for regexp "\(\(?:^\|\r\)[^]#$%>
]*#?[]#$%>] *\(^[\[[0-9;]*[a-zA-Z] *\)*\)\'" from remote shell
16:47:55.667320 tramp-process-one-action (5) # Call `tramp-action-succeed'
16:47:55.667455 tramp-process-actions (6) # 
exec ssh   -o ControlPath=/tmp/tramp.2137rFq.%r@%h:%p -o ControlMaster=auto -o ControlPersist=no -e none phe
Last login: Mon Oct 27 16:44:50 2014 from dynamic34-29.dynamic.dal.ca
            O
            ||
            ||
   /\\  /\  /\
  /  \\/  \/  \
  ||  |    |  OH
  ||  |    |
   \  //   NH2
    \//
%                                                                              \r \r\r^[[31mjrm^[[39m@^[[32mphe^[[39m ^[[33m~^[[39m % 
16:47:55.667774 tramp-process-actions (3) # Waiting for prompts from remote shell...done
16:47:55.668005 tramp-maybe-open-connection (3) # Found remote shell prompt on `phe'
16:47:55.668159 tramp-open-shell (5) # Opening remote shell `/bin/sh'...
16:47:55.668335 tramp-send-command (6) # exec env ENV='' HISTFILE=/dev/null PROMPT_COMMAND='' PS1=\#\$\  PS2='' PS3='' /bin/sh 
16:47:55.689839 tramp-wait-for-regexp (6) # 
exec env ENV='' HISTFILE=/dev/null PROMPT_COMMAND='' PS1=\#\$\  PS\r</null PROMPT_COMMAND='' PS1=\#\$\  PS2                                       \r				$\  PS2='' PS3='' /bin/sh \b\b\b\b\b\b\b\b/bin/sh 
#$ 
16:47:55.690053 tramp-open-shell (5) # Opening remote shell `/bin/sh'...done
16:47:55.690196 tramp-open-connection-setup-interactive-shell (5) # Setting up remote shell environment
16:47:55.690389 tramp-send-command (6) # stty -inlcr -echo kill '^U' erase '^H'
16:47:55.692173 tramp-wait-for-regexp (6) # 
stty -inlcr -echo kill '^U' erase '^H'
#$ 
16:47:55.692351 tramp-send-command (6) # echo foo
16:47:55.693277 tramp-wait-for-regexp (6) # 
echo foo
foo
#$ 
16:47:55.693432 tramp-open-connection-setup-interactive-shell (5) # Remote echo still on. Ok.
16:47:55.693590 tramp-send-command (6) # _echo\b\b\b\b\bstty icanon erase ^H cols 32767_echo\b\b\b\b\b
16:47:55.694572 tramp-check-for-regexp (5) # echo-mark found
16:47:55.695160 tramp-wait-for-regexp (6) # 
#$ 
16:47:55.695320 tramp-open-connection-setup-interactive-shell (5) # Setting shell prompt
16:47:55.695490 tramp-send-command (6) # _echo\b\b\b\b\bPS1=///e8cc1455672e9693eb509c5ab07efa7f\#\$_echo\b\b\b\b\b
16:47:55.697010 tramp-check-for-regexp (5) # echo-mark found
16:47:55.697174 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.697397 tramp-send-command (6) # _echo\b\b\b\b\bPS2=''_echo\b\b\b\b\b
16:47:55.698758 tramp-check-for-regexp (5) # echo-mark found
16:47:55.698913 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.699137 tramp-send-command (6) # _echo\b\b\b\b\bPS3=''_echo\b\b\b\b\b
16:47:55.700444 tramp-check-for-regexp (5) # echo-mark found
16:47:55.700663 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.700872 tramp-send-command (6) # _echo\b\b\b\b\bPROMPT_COMMAND=''_echo\b\b\b\b\b
16:47:55.702389 tramp-check-for-regexp (5) # echo-mark found
16:47:55.702529 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.702721 tramp-open-connection-setup-interactive-shell (5) # Determining coding system
16:47:55.702869 tramp-send-command (6) # _echo\b\b\b\b\becho foo ; echo bar_echo\b\b\b\b\b
16:47:55.704686 tramp-check-for-regexp (5) # echo-mark found
16:47:55.704850 tramp-wait-for-regexp (6) # 
foo
bar
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.705070 tramp-open-connection-setup-interactive-shell (5) # Setting coding system to `utf-8-unix' and `utf-8-unix'
16:47:55.705227 tramp-send-command (6) # _echo\b\b\b\b\bset +o vi +o emacs_echo\b\b\b\b\b
16:47:55.706557 tramp-check-for-regexp (5) # echo-mark found
16:47:55.706765 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.706963 tramp-open-connection-setup-interactive-shell (5) # Checking system information
16:47:55.707170 tramp-send-command (6) # _echo\b\b\b\b\becho \"`uname -sr`\" 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.709506 tramp-wait-for-regexp (6) # 
"FreeBSD 9.3-STABLE"
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.709785 tramp-open-connection-setup-interactive-shell (5) # Checking remote host type for `send-process-string' bug
16:47:55.709937 tramp-set-remote-path (5) # Setting $PATH environment variable
16:47:55.710150 tramp-send-command (6) # _echo\b\b\b\b\becho \"`getconf PATH 2>/dev/null`\" 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.712407 tramp-wait-for-regexp (6) # 
"/usr/bin:/bin:/usr/sbin:/sbin"
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.713055 tramp-get-test-command (5) # Finding a suitable `test' command
16:47:55.713267 tramp-send-command (6) # _echo\b\b\b\b\btest 0 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.714260 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.714572 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.715600 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.716284 tramp-send-command (6) # _echo\b\b\b\b\btest -d /bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.717269 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.717939 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/sbin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.719321 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.719989 tramp-send-command (6) # _echo\b\b\b\b\btest -d /sbin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.721031 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.721703 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/local/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.722797 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.723480 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/local/sbin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.724574 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.725260 tramp-send-command (6) # _echo\b\b\b\b\btest -d /local/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.726321 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.727017 tramp-send-command (6) # _echo\b\b\b\b\btest -d /local/freeware/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.728104 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.728771 tramp-send-command (6) # _echo\b\b\b\b\btest -d /local/gnu/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.729957 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.730638 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/freeware/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.731732 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.732411 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/pkg/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.733358 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.734033 tramp-send-command (6) # _echo\b\b\b\b\btest -d /usr/contrib/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.735356 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.744876 tramp-send-command (6) # _echo\b\b\b\b\btest -d /opt/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.746030 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.746718 tramp-send-command (6) # _echo\b\b\b\b\btest -d /opt/sbin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.747851 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.748521 tramp-send-command (6) # _echo\b\b\b\b\btest -d /opt/local/bin 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.749567 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.749876 tramp-send-command (6) # _echo\b\b\b\b\bPATH=/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/local/sbin; export PATH_echo\b\b\b\b\b
16:47:55.750861 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.751109 tramp-send-command (6) # _echo\b\b\b\b\becho ~root_echo\b\b\b\b\b
16:47:55.752446 tramp-wait-for-regexp (6) # 
/root
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.752670 tramp-send-command (6) # _echo\b\b\b\b\bmesg n; biff n_echo\b\b\b\b\b
16:47:55.754892 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.755161 tramp-send-command (6) # _echo\b\b\b\b\bstty -oxtabs_echo\b\b\b\b\b
16:47:55.756551 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.756815 tramp-send-command (6) # _echo\b\b\b\b\becho \"`tty`\" 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.758415 tramp-wait-for-regexp (6) # 
"/dev/pts/6"
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.758669 tramp-open-connection-setup-interactive-shell (5) # Setting default environment
16:47:55.758859 tramp-send-command (6) # _echo\b\b\b\b\blocale -a_echo\b\b\b\b\b
16:47:55.761021 tramp-wait-for-regexp (6) # 
C
POSIX
af_ZA.ISO8859-1
af_ZA.ISO8859-15
af_ZA.UTF-8
am_ET.UTF-8
be_BY.CP1131
be_BY.CP1251
be_BY.ISO8859-5
be_BY.UTF-8
bg_BG.CP1251
bg_BG.UTF-8
ca_AD.ISO8859-1
ca_AD.ISO8859-15
ca_AD.UTF-8
ca_ES.ISO8859-1
ca_ES.ISO8859-15
ca_ES.UTF-8
ca_FR.ISO8859-1
ca_FR.ISO8859-15
ca_FR.UTF-8
ca_IT.ISO8859-1
ca_IT.ISO8859-15
ca_IT.UTF-8
cs_CZ.ISO8859-2
cs_CZ.UTF-8
da_DK.ISO8859-1
da_DK.ISO8859-15
da_DK.UTF-8
de_AT.ISO8859-1
de_AT.ISO8859-15
de_AT.UTF-8
de_CH.ISO8859-1
de_CH.ISO8859-15
de_CH.UTF-8
de_DE.ISO8859-1
de_DE.ISO8859-15
de_DE.UTF-8
el_GR.ISO8859-7
el_GR.UTF-8
en_AU.ISO8859-1
en_AU.ISO8859-15
en_AU.US-ASCII
en_AU.UTF-8
en_CA.ISO8859-1
en_CA.ISO8859-15
en_CA.US-ASCII
en_CA.UTF-8
en_GB.ISO8859-1
en_GB.ISO8859-15
en_GB.US-ASCII
en_GB.UTF-8
en_IE.UTF-8
en_NZ.ISO8859-1
en_NZ.ISO8859-15
en_NZ.US-ASCII
en_NZ.UTF-8
en_US.ISO8859-1
en_US.ISO8859-15
en_US.US-ASCII
en_US.UTF-8
es_ES.ISO8859-1
es_ES.ISO8859-15
es_ES.UTF-8
et_EE.ISO8859-15
et_EE.UTF-8
eu_ES.ISO8859-1
eu_ES.ISO8859-15
eu_ES.UTF-8
fi_FI.ISO8859-1
fi_FI.ISO8859-15
fi_FI.UTF-8
fr_BE.ISO8859-1
fr_BE.ISO8859-15
fr_BE.UTF-8
fr_CA.ISO8859-1
fr_CA.ISO8859-15
fr_CA.UTF-8
fr_CH.ISO8859-1
fr_CH.ISO8859-15
fr_CH.UTF-8
fr_FR.ISO8859-1
fr_FR.ISO8859-15
fr_FR.UTF-8
he_IL.UTF-8
hi_IN.ISCII-DEV
hr_HR.ISO8859-2
hr_HR.UTF-8
hu_HU.ISO8859-2
hu_HU.UTF-8
hy_AM.ARMSCII-8
hy_AM.UTF-8
is_IS.ISO8859-1
is_IS.ISO8859-15
is_IS.UTF-8
it_CH.ISO8859-1
it_CH.ISO8859-15
it_CH.UTF-8
it_IT.ISO8859-1
it_IT.ISO8859-15
it_IT.UTF-8
ja_JP.SJIS
ja_JP.UTF-8
ja_JP.eucJP
kk_KZ.PT154
kk_KZ.UTF-8
ko_KR.CP949
ko_KR.UTF-8
ko_KR.eucKR
la_LN.ISO8859-1
la_LN.ISO8859-13
la_LN.ISO8859-15
la_LN.ISO8859-2
la_LN.ISO8859-4
la_LN.US-ASCII
lt_LT.ISO8859-13
lt_LT.ISO8859-4
lt_LT.UTF-8
lv_LV.ISO8859-13
lv_LV.UTF-8
mn_MN.UTF-8
nb_NO.ISO8859-1
nb_NO.ISO8859-15
nb_NO.UTF-8
nl_BE.ISO8859-1
nl_BE.ISO8859-15
nl_BE.UTF-8
nl_NL.ISO8859-1
nl_NL.ISO8859-15
nl_NL.UTF-8
nn_NO.ISO8859-1
nn_NO.ISO8859-15
nn_NO.UTF-8
no_NO.ISO8859-1
no_NO.ISO8859-15
no_NO.UTF-8
pl_PL.ISO8859-2
pl_PL.UTF-8
pt_BR.ISO8859-1
pt_BR.UTF-8
pt_PT.ISO8859-1
pt_PT.ISO8859-15
pt_PT.UTF-8
ro_RO.ISO8859-2
ro_RO.UTF-8
ru_RU.CP1251
ru_RU.CP866
ru_RU.ISO8859-5
ru_RU.KOI8-R
ru_RU.UTF-8
sk_SK.ISO8859-2
sk_SK.UTF-8
sl_SI.ISO8859-2
sl_SI.UTF-8
sr_YU.ISO8859-2
sr_YU.ISO8859-5
sr_YU.UTF-8
sv_SE.ISO8859-1
sv_SE.ISO8859-15
sv_SE.UTF-8
tr_TR.ISO8859-9
tr_TR.UTF-8
uk_UA.CP1251
uk_UA.ISO8859-5
uk_UA.KOI8-U
uk_UA.UTF-8
zh_CN.GB18030
zh_CN.GB2312
zh_CN.GBK
zh_CN.UTF-8
zh_CN.eucCN
zh_HK.Big5HKSCS
zh_HK.UTF-8
zh_TW.Big5
zh_TW.UTF-8
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.761489 tramp-send-command (6) # _echo\b\b\b\b\bLC_ALL=C; export LC_ALL_echo\b\b\b\b\b
16:47:55.762452 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.762715 tramp-send-command (6) # _echo\b\b\b\b\bTMOUT=0; export TMOUT_echo\b\b\b\b\b
16:47:55.763693 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.763906 tramp-send-command (6) # _echo\b\b\b\b\bLC_CTYPE=''; export LC_CTYPE_echo\b\b\b\b\b
16:47:55.764846 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.765061 tramp-send-command (6) # _echo\b\b\b\b\bTERM=dumb; export TERM_echo\b\b\b\b\b
16:47:55.765989 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.766203 tramp-send-command (6) # _echo\b\b\b\b\bEMACS=t; export EMACS_echo\b\b\b\b\b
16:47:55.767051 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.767261 tramp-send-command (6) # _echo\b\b\b\b\bINSIDE_EMACS='24.4.1,tramp:2.2.9-24.4'; export INSIDE_EMACS_echo\b\b\b\b\b
16:47:55.768182 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.768405 tramp-send-command (6) # _echo\b\b\b\b\bPAGER=""; export PAGER_echo\b\b\b\b\b
16:47:55.769552 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.769798 tramp-send-command (6) # _echo\b\b\b\b\bunset correct autocorrect MAILPATH MAILCHECK MAIL HISTORY CDPATH_echo\b\b\b\b\b
16:47:55.770769 tramp-wait-for-regexp (6) # 
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.771174 tramp-maybe-open-connection (3) # Opening connection for phe using scp...done
16:47:55.771328 tramp-send-command (6) # _echo\b\b\b\b\btest 0 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.772244 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.772513 tramp-send-command (6) # _echo\b\b\b\b\btest -e / 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.773449 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.773764 tramp-send-command (6) # _echo\b\b\b\b\btest -e /\ this\ file\ does\ not\ exist\  2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.774813 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.775103 tramp-send-command (6) # _echo\b\b\b\b\btest -e /home/jrm/input.tre 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.776119 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.777342 tramp-send-command (6) # _echo\b\b\b\b\btest -d /home/jrm/input.tre 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.778310 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.779277 tramp-sh-handle-file-truename (4) # Finding true name for `/scp:phe:/home/jrm/input.tre'
16:47:55.779423 tramp-get-remote-readlink (5) # Finding a suitable `readlink' command
16:47:55.779618 tramp-send-command (6) # _echo\b\b\b\b\bwhich \readlink | wc -w_echo\b\b\b\b\b
16:47:55.781244 tramp-wait-for-regexp (6) # 
       1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.781504 tramp-send-command (6) # _echo\b\b\b\b\b\readlink --canonicalize-missing / 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.783928 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.784153 tramp-get-remote-perl (5) # Finding a suitable `perl' command
16:47:55.784347 tramp-send-command (6) # _echo\b\b\b\b\bwhich \perl5 | wc -w_echo\b\b\b\b\b
16:47:55.785984 tramp-wait-for-regexp (6) # 
       1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.786245 tramp-send-command (6) # _echo\b\b\b\b\b\perl5 -e 'use File::Spec;' 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.831544 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.831837 tramp-send-command (6) # _echo\b\b\b\b\b\perl5 -e 'use Cwd "realpath";' 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.844315 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.844548 tramp-maybe-send-script (5) # Sending script `tramp_perl_file_truename'...
16:47:55.844810 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_truename () {
\perl5 -e '
use File::Spec;
use Cwd "realpath";

sub recursive {
    my ($volume, @dirs) = @_;
    my $real = realpath(File::Spec->catpath(
                   $volume, File::Spec->catdir(@dirs), ""));
    if ($real) {
        my ($vol, $dir) = File::Spec->splitpath($real, 1);
        return ($vol, File::Spec->splitdir($dir));
    }
    else {
        my $last = pop(@dirs);
        ($volume, @dirs) = recursive($volume, @dirs);
        push(@dirs, $last);
        return ($volume, @dirs);
    }
}

$result = realpath($ARGV[0]);
if (!$result) {
    my ($vol, $dir) = File::Spec->splitpath($ARGV[0], 1);
    ($vol, @dirs) = recursive($vol, File::Spec->splitdir($dir));

    $result = File::Spec->catpath($vol, File::Spec->catdir(@dirs), "");
}

if ($ARGV[0] =~ /\/$/) {
    $result = $result . "/";
}

print "\"$result\"\n";
' "$1" 2>/dev/null
} 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.846888 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.847138 tramp-maybe-send-script (5) # Sending script `tramp_perl_file_truename'...done
16:47:55.847344 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_truename /home/jrm/input.tre 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.873008 tramp-wait-for-regexp (6) # 
"/usr/home/jrm/input.tre"
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.873244 tramp-sh-handle-file-truename (4) # True name of `/home/jrm/input.tre' is `/usr/home/jrm/input.tre'
16:47:55.874008 tramp-get-remote-stat (5) # Finding a suitable `stat' command
16:47:55.874226 tramp-send-command (6) # _echo\b\b\b\b\bwhich \stat | wc -w_echo\b\b\b\b\b
16:47:55.875984 tramp-wait-for-regexp (6) # 
       1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.876254 tramp-send-command (6) # _echo\b\b\b\b\b\stat -c '("%N" %s)' / 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.877767 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.878029 tramp-do-file-attributes-with-perl (5) # file attributes with perl: /usr/home/jrm/input.tre
16:47:55.878176 tramp-maybe-send-script (5) # Sending script `tramp_perl_file_attributes'...
16:47:55.878442 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_attributes () {
\perl5 -e '
@stat = lstat($ARGV[0]);
if (!@stat) {
    print "nil\n";
    exit 0;
}
if (($stat[2] & 0170000) == 0120000)
{
    $type = readlink($ARGV[0]);
    $type = "\"$type\"";
}
elsif (($stat[2] & 0170000) == 040000)
{
    $type = "t";
}
else
{
    $type = "nil"
};
$uid = ($ARGV[1] eq "integer") ? $stat[4] : "\"" . getpwuid($stat[4]) . "\"";
$gid = ($ARGV[1] eq "integer") ? $stat[5] : "\"" . getgrgid($stat[5]) . "\"";
printf(
    "(%s %u %s %s (%u %u) (%u %u) (%u %u) %u.0 %u t (%u . %u) -1)\n",
    $type,
    $stat[3],
    $uid,
    $gid,
    $stat[8] >> 16 & 0xffff,
    $stat[8] & 0xffff,
    $stat[9] >> 16 & 0xffff,
    $stat[9] & 0xffff,
    $stat[10] >> 16 & 0xffff,
    $stat[10] & 0xffff,
    $stat[7],
    $stat[2],
    $stat[1] >> 16 & 0xffff,
    $stat[1] & 0xffff
);' "$1" "$2" 2>/dev/null
} 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.880632 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.880870 tramp-maybe-send-script (5) # Sending script `tramp_perl_file_attributes'...done
16:47:55.881087 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_attributes /usr/home/jrm/input.tre integer 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.884182 tramp-wait-for-regexp (6) # 
(nil 1 1001 1001 (21575 7661) (21575 8129) (21575 8129) 58.0 33188 t (25 . 6757) -1)
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.884447 tramp-get-remote-id (5) # Finding POSIX `id' command
16:47:55.884655 tramp-send-command (6) # _echo\b\b\b\b\bwhile read d; do if test -x $d/id -a -f $d/id; then echo tramp_executable $d/id; break; fi; done <<'2d77ce7e974c062042415a86f6410328'
/usr/bin
/bin
/usr/sbin
/sbin
/usr/local/bin
/usr/local/sbin
2d77ce7e974c062042415a86f6410328_echo\b\b\b\b\b
16:47:55.885902 tramp-wait-for-regexp (6) # 
tramp_executable /usr/bin/id
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.886173 tramp-send-command (6) # _echo\b\b\b\b\b/usr/bin/id -u 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.888333 tramp-wait-for-regexp (6) # 
1001
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.888625 tramp-send-command (6) # _echo\b\b\b\b\b/usr/bin/id -g  2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.890439 tramp-wait-for-regexp (6) # 
1001
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.901892 tramp-handle-insert-file-contents (3) # Inserting `/scp:phe:/home/jrm/input.tre'...
16:47:55.903709 tramp-find-inline-encoding (5) # Checking local encoding function `base64-encode-region'
16:47:55.903846 tramp-find-inline-encoding (5) # Checking local decoding function `base64-decode-region'
16:47:55.903968 tramp-find-inline-encoding (5) # Checking remote encoding command `base64' for sanity
16:47:55.904172 tramp-send-command (6) # _echo\b\b\b\b\b( base64 </dev/null 2>/dev/null; echo tramp_exit_status $? )_echo\b\b\b\b\b
16:47:55.905629 tramp-wait-for-regexp (6) # 
tramp_exit_status 127
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.905847 tramp-find-inline-encoding (5) # Checking remote encoding command `base64' for sanity
16:47:55.906031 tramp-send-command (6) # _echo\b\b\b\b\b( base64 </dev/null 2>/dev/null; echo tramp_exit_status $? )_echo\b\b\b\b\b
16:47:55.907792 tramp-wait-for-regexp (6) # 
tramp_exit_status 127
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.908019 tramp-find-inline-encoding (5) # Checking remote encoding command `mimencode -b' for sanity
16:47:55.908214 tramp-send-command (6) # _echo\b\b\b\b\b( mimencode -b </dev/null 2>/dev/null; echo tramp_exit_status $? )_echo\b\b\b\b\b
16:47:55.909598 tramp-wait-for-regexp (6) # 
tramp_exit_status 127
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.909809 tramp-find-inline-encoding (5) # Checking remote encoding command `mmencode -b' for sanity
16:47:55.909991 tramp-send-command (6) # _echo\b\b\b\b\b( mmencode -b </dev/null 2>/dev/null; echo tramp_exit_status $? )_echo\b\b\b\b\b
16:47:55.911420 tramp-wait-for-regexp (6) # 
tramp_exit_status 127
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.911636 tramp-find-inline-encoding (5) # Checking remote encoding command `recode data..base64' for sanity
16:47:55.911818 tramp-send-command (6) # _echo\b\b\b\b\b( recode data..base64 </dev/null 2>/dev/null; echo tramp_exit_status $? )_echo\b\b\b\b\b
16:47:55.930396 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.930600 tramp-find-inline-encoding (5) # Checking remote decoding command `recode base64..data' for sanity
16:47:55.930783 tramp-send-command (6) # _echo\b\b\b\b\b( echo xyzzy | recode data..base64 | recode base64..data 2>/dev/null; echo tramp_exit_status $? )_echo\b\b\b\b\b
16:47:55.937126 tramp-wait-for-regexp (6) # 
xyzzy
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.937417 tramp-find-inline-encoding (5) # Using local encoding `base64-encode-region'
16:47:55.937559 tramp-find-inline-encoding (5) # Using local decoding `base64-decode-region'
16:47:55.937686 tramp-find-inline-encoding (5) # Using remote encoding `recode data..base64'
16:47:55.937809 tramp-find-inline-encoding (5) # Using remote decoding `recode base64..data'
16:47:55.940179 tramp-sh-handle-file-local-copy (3) # Encoding remote file `/scp:phe:/home/jrm/input.tre' with `recode data..base64 <%s'...
16:47:55.940657 tramp-send-command (6) # _echo\b\b\b\b\brecode data..base64 </home/jrm/input.tre 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.947077 tramp-wait-for-regexp (6) # 
KCgoMToxLDI6MSk6MSwzOjIpOjIsKCg0OjEsNToxKToyLCg2OjIsKDc6MSw4OjEpOjEpOjEpOjEp
Ow==
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.947512 tramp-sh-handle-file-local-copy (3) # Encoding remote file `/scp:phe:/home/jrm/input.tre' with `recode data..base64 <%s'...done
16:47:55.947776 tramp-sh-handle-file-local-copy (3) # Decoding local file `/tmp/tramp.2137x3z.tre' with `base64-decode-region'...
16:47:55.949217 tramp-sh-handle-file-local-copy (3) # Decoding local file `/tmp/tramp.2137x3z.tre' with `base64-decode-region'...done
16:47:55.950935 tramp-call-process (6) # `chown 1001:1001 /tmp/tramp.2137x3z.tre' nil nil
16:47:55.953946 tramp-do-file-attributes-with-perl (5) # file attributes with perl: /home/jrm/input.tre
16:47:55.954177 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_attributes /home/jrm/input.tre string 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.959107 tramp-wait-for-regexp (6) # 
(nil 1 "jrm" "jrm" (21575 7661) (21575 8129) (21575 8129) 58.0 33188 t (25 . 6757) -1)
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.959432 tramp-send-command (6) # _echo\b\b\b\b\b/usr/bin/id -gn | sed -e s/^/\"/ -e s/$/\"/ 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.962132 tramp-wait-for-regexp (6) # 
"jrm"
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.962878 tramp-do-file-attributes-with-perl (5) # file attributes with perl: /home/jrm/input.tre
16:47:55.963101 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_attributes /home/jrm/input.tre integer 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.967106 tramp-wait-for-regexp (6) # 
(nil 1 1001 1001 (21575 7661) (21575 8129) (21575 8129) 58.0 33188 t (25 . 6757) -1)
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.967512 tramp-send-command (6) # _echo\b\b\b\b\btest -w /home/jrm/input.tre 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.968934 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.969916 tramp-do-file-attributes-with-perl (5) # file attributes with perl: /home/jrm/input.tre
16:47:55.970148 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_attributes /home/jrm/input.tre integer 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.973363 tramp-wait-for-regexp (6) # 
(nil 1 1001 1001 (21575 7661) (21575 8129) (21575 8129) 58.0 33188 t (25 . 6757) -1)
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.973961 tramp-handle-insert-file-contents (3) # Inserting `/scp:phe:/home/jrm/input.tre'...done
16:47:55.975790 tramp-send-command (6) # _echo\b\b\b\b\btest -e /home/jrm/\#_ascp_bphe_b_ahome_ajrm_ainput.tre\# 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:55.976882 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:55.991753 tramp-sh-handle-vc-registered (3) # Checking `vc-registered' for /scp:phe:/home/jrm/input.tre...
16:47:56.000960 tramp-maybe-send-script (5) # Sending script `tramp_vc_registered_read_file_names'...
16:47:56.001213 tramp-send-command (6) # _echo\b\b\b\b\btramp_vc_registered_read_file_names () {
echo "("
while read file; do
    if test -e "$file"; then
	echo "(\"$file\" \"file-exists-p\" t)"
    else
	echo "(\"$file\" \"file-exists-p\" nil)"
    fi
    if test -r "$file"; then
	echo "(\"$file\" \"file-readable-p\" t)"
    else
	echo "(\"$file\" \"file-readable-p\" nil)"
    fi
done
echo ")"
} 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:47:56.002640 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$
16:47:56.002887 tramp-maybe-send-script (5) # Sending script `tramp_vc_registered_read_file_names'...done
16:47:56.003426 tramp-send-command (6) # _echo\b\b\b\b\btramp_vc_registered_read_file_names <<'2d77ce7e974c062042415a86f6410328'
/home/jrm/RCS/input.tre\,v
/home/jrm/input.tre\,v
/home/jrm/RCS/input.tre
/home/jrm/CVS/Entries
/home/jrm/input.tre/.svn
/home/jrm/.svn
/home/.svn
/.svn
/home/jrm/SCCS/s.input.tre
/home/jrm/s.input.tre
/home/jrm/input.tre/.bzr/checkout/format
/home/jrm/.bzr/checkout/format
/home/.bzr/checkout/format
/.bzr/checkout/format
/home/jrm/input.tre/.git
/home/jrm/.git
/home/.git
/.git
/home/jrm/input.tre/.hg
/home/jrm/.hg
/home/.hg
/.hg
/home/jrm/input.tre/_MTN/format
/home/jrm/_MTN/format
/home/_MTN/format
/_MTN/format
/home/jrm/input.tre/\{arch\}/\=tagging-method
/home/jrm/\{arch\}/\=tagging-method
/home/\{arch\}/\=tagging-method
/\{arch\}/\=tagging-method
2d77ce7e974c062042415a86f6410328
_echo\b\b\b\b\b
16:47:58.741867 tramp-sh-handle-vc-registered (3) # Checking `vc-registered' for /scp:phe:/home/jrm/input.tre...failed
16:47:58.742146 tramp-file-name-handler (1) # Interrupt received in operation (vc-registered /scp:phe:/home/jrm/input.tre)
16:48:04.938081 tramp-do-file-attributes-with-perl (5) # file attributes with perl: /home/jrm/input.tre
16:48:04.938325 tramp-send-command (6) # _echo\b\b\b\b\btramp_perl_file_attributes /home/jrm/input.tre integer 2>/dev/null; echo tramp_exit_status $?_echo\b\b\b\b\b
16:48:04.941893 tramp-wait-for-regexp (6) # 
(nil 1 1001 1001 (21575 7661) (21575 8129) (21575 8129) 58.0 33188 t (25 . 6757) -1)
tramp_exit_status 0
///e8cc1455672e9693eb509c5ab07efa7f#$

[-- Attachment #3: tramp.txt --]
[-- Type: text/plain, Size: 4742 bytes --]

(
("/home/jrm/RCS/input.tre,v" "file-exists-p" nil)
("/home/jrm/RCS/input.tre,v" "file-readable-p" nil)
("/home/jrm/input.tre,v" "file-exists-p" nil)
("/home/jrm/input.tre,v" "file-readable-p" nil)
("/home/jrm/RCS/input.tre" "file-exists-p" nil)
("/home/jrm/RCS/input.tre" "file-readable-p" nil)
("/home/jrm/CVS/Entries" "file-exists-p" nil)
("/home/jrm/CVS/Entries" "file-readable-p" nil)
("/home/jrm/input.tre/.svn" "file-exists-p" nil)
("/home/jrm/input.tre/.svn" "file-readable-p" nil)
("/home/jrm/.svn" "file-exists-p" nil)
("/home/jrm/.svn" "file-readable-p" nil)
("/home/.svn" "file-exists-p" nil)
("/home/.svn" "file-readable-p" nil)
("/.svn" "file-exists-p" nil)
("/.svn" "file-readable-p" nil)
("/home/jrm/SCCS/s.input.tre" "file-exists-p" nil)
("/home/jrm/SCCS/s.input.tre" "file-readable-p" nil)
("/home/jrm/s.input.tre" "file-exists-p" nil)
("/home/jrm/s.input.tre" "file-readable-p" nil)
("/home/jrm/input.tre/.bzr/checkout/format" "file-exists-p" nil)
("/home/jrm/input.tre/.bzr/checkout/format" "file-readable-p" nil)
("/home/jrm/.bzr/checkout/format" "file-exists-p" nil)
("/home/jrm/.bzr/checkout/format" "file-readable-p" nil)
("/home/.bzr/checkout/format" "file-exists-p" nil)
("/home/.bzr/checkout/format" "file-readable-p" nil)
("/.bzr/checkout/format" "file-exists-p" nil)
("/.bzr/checkout/format" "file-readable-p" nil)
("/home/jrm/input.tre/.git" "file-exists-p" nil)
("/home/jrm/input.tre/.git" "file-readable-p" nil)
("/home/jrm/.git" "file-exists-p" nil)
("/home/jrm/.git" "file-readable-p" nil)
("/home/.git" "file-exists-p" nil)
("/home/.git" "file-readable-p" nil)
("/.git" "file-exists-p" nil)
("/.git" "file-readable-p" nil)
("/home/jrm/input.tre/.hg" "file-exists-p" nil)
("/home/jrm/input.tre/.hg" "file-readable-p" nil)
("/home/jrm/.hg" "file-exists-p" nil)
("/home/jrm/.hg" "file-readable-p" nil)
("/home/.hg" "file-exists-p" nil)
("/home/.hg" "file-readable-p" nil)
("/.hg" "file-exists-p" nil)
("/.hg" "file-readable-p" nil)
("/home/jrm/input.tre/_MTN/format" "file-exists-p" nil)
("/home/jrm/input.tre/_MTN/format" "file-readable-p" nil)
("/home/jrm/_MTN/format" "file-exists-p" nil)
("/home/jrm/_MTN/format" "file-readable-p" nil)
("/home/_MTN/format" "file-exists-p" nil)
("/home/_MTN/format" "file-readable-p" nil)
("/_MTN/format" "file-exists-p" nil)
("/_MTN/format" "file-readable-p" nil)
("/home/jrm/input.tre/{arch}/=tagging-method" "file-exists-p" nil)
("/home/jrm/input.tre/{arch}/=tagging-method" "file-readable-p" nil)
("/home/jrm/{arch}/=tagging-method" "file-exists-p" nil)
("/home/jrm/{arch}/=tagging-method" "file-readable-p" nil)
("/home/{arch}/=tagging-method" "file-exists-p" nil)
("/home/{arch}/=tagging-method" "file-readable-p" nil)
("/{arch}/=tagging-method" "file-exists-p" nil)
("/{arch}/=tagging-method" "file-readable-p" nil)
)
///e8cc1455672e9693eb509c5ab07efa7f#$///e8cc1455672e9693eb509c5ab07efa7f#$are you awake
ok
ok
./
../
.gtkrc-2.0.conkeror
.lesshst
STAT2080_Fall2014_Midterm1.odt
.conkeror.mozdev.org/
.gstreamer-0.10/
dl/
.mozilla/
.slime/
.Xdefaults
.xsession
auto/
STAT2080_Fall2014_Midterm1.aux
.Rhistory
.latexmkrc
.zshenv
.surf/
.xautolock.log
.slime-history.eld
emacs_current_port/
STAT2080_Fall2014_Midterm1.tex
.VirtualBox/
.opera/
.zcompdump
.adobe/
.tmux.conf
.bash_history
.nnmail-cache
.XCompose
.mpv/
.octave_hist
.sbclrc
.pki/
.urxvt/
mail/
.local/
.gitconfig
.Xauthority
.zshrc
.pentadactylrc
patch-sources.el
scm/
.unison/
.bitcoin/
.xdvirc
.gnupg/
VirtualBox VMs/
.newsrc
.porttools
input.tre
.emacs.d/
.zshhistory
.cabal/
STAT2080_Fall2014_Midterm1.pdf
.ssh/
students_with_midterm_problems.txt
.purple/
STAT2080_Fall2014_Midterm1.doc
.rtorrent.rc
.fonts.conf
.gimp-2.8/
.rnd
.pefs.db
emacs/
.sqlite_history
STAT2080_Fall2014_Midterm1.log
.xpdfrc
.Xmodmap
.links/
.ido.last
.wine/
.mplayer/
.plan
.xinitrc
.macromedia/
.conkerorrc/
useragentswitcher.xml
.pulse-cookie
.wine-pipelight/
.cache/
.login_conf
.fossil
.hunspell_en_CA
.smex-items
files/
.gtkrc-2.0
local/
.nexrc
Makefile
Mail/
.ghc/
.pentadactyl/
.pulse/
.config/
.xbindkeysrc
.mailrc
.fontconfig/
tmp/
News/
mnt/
.gtkrc.mime
ports_reinstall.txt
.subversion/
.xsession-errors
.stumpwmrc
.mail_aliases
.Skype/
R/
ok
jrm/
ok
./
../
_dnscrypt-proxy/
jrm/
ok
home/
ok
./
../
proc/
usr/
bin/
root/
etc/
boot/
lib/
compat/
sys/
.cshrc
tmp/
mnt/
data/
.profile
COPYRIGHT
entropy
media/
sbin/
var/
dev/
mountpoints
home/
libexec/
rescue/
ok
/usr/home/jrm
./
../
proc/
usr/
bin/
root/
etc/
boot/
lib/
compat/
sys/
.cshrc
tmp/
mnt/
data/
.profile
COPYRIGHT
entropy
media/
sbin/
var/
dev/
mountpoints
home/
libexec/
rescue/
ok
./
../
proc/
usr/
bin/
root/
etc/
boot/
lib/
compat/
sys/
.cshrc
tmp/
mnt/
data/
.profile
COPYRIGHT
entropy
media/
sbin/
var/
dev/
mountpoints
home/
libexec/
rescue/
ok
ok

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Wolfgang Jenkner]

On Mon, Oct 27 2014, Joseph Mingrone wrote:

> C-x C-f /remote-host:/some/path/file
>
> In the minibuffer I see "Tramp: Checking `vc-registered' for
> /scp:phe:/home/jrm/input.tre" (then an indefinitely rotating '/').
>
> When I cancel with C-g, then try again visiting the file again
> everything works.  If I try again it will fail again.
>
> I've attached the contents of the tramp buffers.  I've reproduced the
> problem on other hosts also running FreeBSD (amd64 9.3).

I have been running tramp with a local patch for this for a while now
(and forgot about it).  The tramp bug is in code which is only used if
sending "stty -echo" to the remote /bin/sh leaves echoing on, in effect.
In FreeBSD this happens with /bin/sh if line editing via libedit is used
and emacs or vi bindings are enabled (see also bug#10295).


Date: Sat, 8 Mar 2014 16:14:10 +0100
Subject: [PATCH] Fix hang in `tramp-sh-handle-vc-registered'.

---
 lisp/net/tramp-sh.el | 11 +++++++++++
 1 file changed, 11 insertions(+)

diff --git a/lisp/net/tramp-sh.el b/lisp/net/tramp-sh.el
index 315bc08..4a25980 100644
--- a/lisp/net/tramp-sh.el
+++ b/lisp/net/tramp-sh.el
@@ -4763,6 +4763,17 @@ function waits for output unless NOOUTPUT is set."
     (when (tramp-get-connection-property p "remote-echo" nil)
       ;; We mark the command string that it can be erased in the output buffer.
       (tramp-set-connection-property p "check-remote-echo" t)
+      ;; If we put `tramp-echo-mark' after a trailing newline (which
+      ;; is assumed to be unquoted) `tramp-send-string' doesn't see
+      ;; that newline and adds `tramp-rsh-end-of-line' right after
+      ;; `tramp-echo-mark', so the remote shell sees two consecutive
+      ;; trailing line endings and sends two prompts after executing
+      ;; the command, which confuses `tramp-wait-for-output'.
+      (when (and (not (string= command ""))
+		 (string-equal (substring command -1) "\n"))
+	(setq command (substring command 0 -1)))
+      ;; No need to restore a trailing newline here since `tramp-send-string'
+      ;; makes sure that the string ends in `tramp-rsh-end-of-line', anyway.
       (setq command (format "%s%s%s" tramp-echo-mark command tramp-echo-mark)))
     ;; Send the command.
     (tramp-message vec 6 "%s" command)
-- 
2.1.2

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Joseph Mingrone]

Wolfgang Jenkner <wjenkner@inode.at> writes:

> On Mon, Oct 27 2014, Joseph Mingrone wrote:
>
>> C-x C-f /remote-host:/some/path/file
>>
>> In the minibuffer I see "Tramp: Checking `vc-registered' for
>> /scp:phe:/home/jrm/input.tre" (then an indefinitely rotating '/').
>>
>> When I cancel with C-g, then try again visiting the file again
>> everything works.  If I try again it will fail again.
>>
>> I've attached the contents of the tramp buffers.  I've reproduced the
>> problem on other hosts also running FreeBSD (amd64 9.3).
>
> I have been running tramp with a local patch for this for a while now
> (and forgot about it).  The tramp bug is in code which is only used if
> sending "stty -echo" to the remote /bin/sh leaves echoing on, in effect.
> In FreeBSD this happens with /bin/sh if line editing via libedit is used
> and emacs or vi bindings are enabled (see also bug#10295).

It solves the problem here.  I'll submit the patch for the FreeBSD port.
Thanks.

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Michael Albinus]

Joseph Mingrone <jrm@ftfl.ca> writes:

>> I have been running tramp with a local patch for this for a while now
>> (and forgot about it).  The tramp bug is in code which is only used if
>> sending "stty -echo" to the remote /bin/sh leaves echoing on, in effect.
>> In FreeBSD this happens with /bin/sh if line editing via libedit is used
>> and emacs or vi bindings are enabled (see also bug#10295).
>
> It solves the problem here.  I'll submit the patch for the FreeBSD port.
> Thanks.

Thanks for confirmation. I have no chance to run a BSD system, but I
would be willing to commit this patch to the repostories, once I'm back
from my business trip. Wolfgang, could you please provide a ChangeLog
entry for this?

Best regards, Michael.

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Wolfgang Jenkner]

On Tue, Oct 28 2014, Joseph Mingrone wrote:

> It solves the problem here.  I'll submit the patch for the FreeBSD port.

Before doing this I'd wait a few days for comments, though...

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Michael Albinus]

Wolfgang Jenkner <wjenkner@inode.at> writes:

> Before doing this I'd wait a few days for comments, though...

Well, I won't comment 'cos I don't run BSD. But OTOH, when it is
committed to the repositories, people will get the patch anyway and are
faced with this. This time I do expect more comments (in case there are
problems) as before.

Anyway, I'm still on the road for the rest of the week, and I have a
long todo stack when I return. So there's plenty of time for you to wait :-)

Best regards, Michael.

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Wolfgang Jenkner]

On Tue, Oct 28 2014, Michael Albinus wrote:

>  Wolfgang, could you please provide a ChangeLog entry for this?

2014-10-28  Wolfgang Jenkner  <wjenkner@inode.at>

	* net/tramp-sh.el (tramp-send-command): Fix the case where the
	remote-echo connection property is non-nil (bug#18858).

bug#18858: 24.4; tramp vc-registered errors after upgrading to 24.4

[Michael Albinus]

Wolfgang Jenkner <wjenkner@inode.at> writes:

> 2014-10-28  Wolfgang Jenkner  <wjenkner@inode.at>
>
> 	* net/tramp-sh.el (tramp-send-command): Fix the case where the
> 	remote-echo connection property is non-nil (bug#18858).

I've committed the patch to the Emacs24 branch. Shall be propagated to
the trunk as well.

Closing the bug.

Best regards, Michael.