[BUG]: Evaluating src block via SSH hop no output returned

[jaidetree]

When evaluating a src block with a remote hop over ssh no results are captured\returned.

Reproduction

1. Install docker on a remote computer
2. On your editor\host computer set DOCKER_HOST

export DOCKER_HOST="ssh://user@my-remote"

3. Create a Dockerfile with a database (I'm using postgres but may not matter)
4. Create an org file
5. Add a src block with a simple command to test

#+BEGIN_SRC sql :dir /sshx:user@my-remote:/|docker:my-container:/
SELECT * FROM my_table;
#+END_SRC

6. Evaluate the source block

Expected

• Upon evaluation emacs first ssh's into my-remote
• Runs docker exec my container psql ...
• Query runs and results collected into org-mode results block

Actual

• Command seems to run, or at least not break
• No results are collected

Additional Information

• If I use bash and use something simpler like "ps ax" it works
• I know there's a chance this might have to do with docker-tramp but anything that can help me debug or where to look next would be highly appreciated.

Environment

Details

emacs   version    27.1
        features   NOTIFY KQUEUE ACL GNUTLS LIBXML2 ZLIB TOOLKIT_SCROLL_BARS MODULES THREADS JSON PDUMPER GMP
        build      Aug 20, 2020
        buildopts  (--enable-locallisppath=/usr/local/share/emacs/site-lisp --infodir=/usr/local/Cellar/emacs-mac/HEAD-493abe4/share/info/emacs --prefix=/usr/local/Cellar/emacs-mac/HEAD-493abe4 --with-mac --enable-mac-app=/usr/local/Cellar/emacs-mac/HEAD-493abe4 --with-gnutls --with-modules)
        windowsys  mac
        daemonp    server-running
doom    version    2.0.9
        build      HEAD -> develop f6f90c97 2020-08-20 03:54:44 -0400
        dir        ~/dotfiles/client/doom.d/
system  type       darwin
        config     x86_64-apple-darwin18.7.0
        shell      /usr/local/bin/fish
        uname      Darwin 18.7.0 Darwin Kernel Version 18.7.0: Thu Jun 18 20:50:10 PDT 2020; root:xnu-4903.278.43~1/RELEASE_X86_64 x86_64
        path       (~/.emacs.d/bin/ ~/.luarocks/bin /usr/local/bin ~/.emacs.d/bin ~/.npm-global/bin ~/bin ~/.yarn/bin ~/.config/yarn/global/node_modules/.bin /usr/local/bin /usr/bin /bin /usr/sbin /sbin /usr/local/share/dotnet ~/.dotnet/tools /usr/local/MacGPG2/bin /Library/TeX/texbin ~/.luarocks/bin ~/.emacs.d/bin ~/.npm-global/bin ~/bin ~/.yarn/bin ~/.config/yarn/global/node_modules/.bin /usr/local/Cellar/emacs-mac/HEAD-493abe4/libexec/emacs/27.1/x86_64-apple-darwin18.7.0/)
config  envfile    envvar-file
        elc-files  0
        modules    (:completion (company +childframe) (ivy +childframe) :ui doom doom-dashboard doom-quit fill-column hl-todo hydra indent-guides modeline ophints (popup +defaults) tabs treemacs vc-gutter vi-tilde-fringe workspaces :editor (evil +everywhere) file-templates fold lispy multiple-cursors snippets :emacs dired electric undo vc :term vterm :checkers (syntax +childframe) :tools direnv docker editorconfig (eval +overlay) gist lookup lsp :os macos :tools magit rgb tmux :lang clojure emacs-lisp fennel json (javascript +lsp) markdown (org +journal) (python +lsp) racket sh (web +lsp) yaml :email (wanderlust +gmail) :config (default +bindings +smartparens))
        packages   ((anakondo) (evil-lisp-state) (fish-mode) (inf-clojure) (sql-indent))
        unpin      (n/a)
        elpa       (n/a)

[jaidetree]

Learned a little more about debugging TRAMP connections below. In it, I found something that may be helpful?

17:00:42.468845 tramp-sh-handle-write-region (0) # Wrote /sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj
17:00:42.475369 tramp-send-command (6) # ( cd /\|docker\:postgres\@vm_db_1/ && /bin/sh -c psql\ --set\=\"ON_ERROR_STOP\=1\"\ \ -A\ -P\ footer\=off\ -F\ \"\	\"\ \ -hlocalhost\ -Upostgres\ -dmycompany\ -f\ /tmp/sql-in-gGkmZB\ -o\ /tmp/sql-out-eSnX5w\  </tmp/ob-input-FYnxwj 2>/tmp/ob-error-2K9AZu; echo tramp_exit_status $? )
17:00:42.484701 tramp-wait-for-regexp (6) # 
/bin/sh: 1293: cd: can't cd to /|docker:postgres@vm_db_1/
tramp_exit_status 2

Full log below, personal info redacted:

Details

;; Emacs: 27.1 Tramp: 2.4.3.27.1 -*- mode: outline; -*-
17:00:41.092916 tramp-send-command (6) # echo are you awake
17:00:41.099455 tramp-wait-for-regexp (6) # 
are you awake
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.099577 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/ 2>/dev/null; echo tramp_exit_status $?
17:00:41.104219 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$17:00:41.104385 tramp-send-command (6) # echo are you awake
17:00:41.112799 tramp-wait-for-regexp (6) # 
are you awake
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.114402 tramp-send-command (6) # test -e /tmp/sql-in-gGkmZB 2>/dev/null; echo tramp_exit_status $?
17:00:41.121250 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.123933 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-in-gGkmZB
17:00:41.124930 tramp-send-command (6) # ( (test -e /tmp/sql-in-gGkmZB || test -h /tmp/sql-in-gGkmZB) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-in-gGkmZB | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:41.134280 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.136030 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /tmp/sql-in-gGkmZB
17:00:41.136984 tramp-send-command (6) # test -e /tmp/sql-in-gGkmZB 2>/dev/null; echo tramp_exit_status $?
17:00:41.143268 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.145398 tramp-send-command (6) # test -h /tmp/sql-in-gGkmZB 2>/dev/null; echo tramp_exit_status $?
17:00:41.151186 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.157364 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/sql-in-gGkmZB’
17:00:41.158411 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/sql-in-gGkmZB 2>/dev/null; echo tramp_exit_status $?
17:00:41.165141 tramp-wait-for-regexp (6) # 
/tmp/sql-in-gGkmZB
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.169114 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/sql-in-gGkmZB’ is ‘/tmp/sql-in-gGkmZB’
17:00:41.174591 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.RkHjXO’ using ‘base64-encode-region’...
17:00:41.176843 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.RkHjXO’ using ‘base64-encode-region’...done
17:00:41.178578 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-in-gGkmZB’ using ‘base64 -d -i >%s’...
17:00:41.180054 tramp-send-command (6) # base64 -d -i >/tmp/sql-in-gGkmZB <<'d54ddf76da42b2280c807639dc002253'
d54ddf76da42b2280c807639dc002253
17:00:41.190359 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.192106 tramp-send-command (6) # echo tramp_exit_status $?
17:00:41.197710 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.201502 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-in-gGkmZB’ using ‘base64 -d -i >%s’...done
17:00:41.206644 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/|docker:postgres@vm_db_1/’
17:00:41.207615 tramp-send-command (6) # \readlink --canonicalize-missing /\|docker\:postgres\@vm_db_1/ 2>/dev/null; echo tramp_exit_status $?
17:00:41.216839 tramp-wait-for-regexp (6) # 
/|docker:postgres@vm_db_1
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.222672 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /|docker:postgres@vm_db_1/
17:00:41.224114 tramp-send-command (6) # ( (test -e /\|docker\:postgres\@vm_db_1/ || test -h /\|docker\:postgres\@vm_db_1/) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /\|docker\:postgres\@vm_db_1/ | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:41.237664 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.240832 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /|docker:postgres@vm_db_1/
17:00:41.242993 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/ 2>/dev/null; echo tramp_exit_status $?
17:00:41.250011 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.252099 tramp-send-command (6) # test -h /\|docker\:postgres\@vm_db_1/ 2>/dev/null; echo tramp_exit_status $?
17:00:41.258869 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.261796 tramp-sh-handle-file-truename (4) # True name of ‘/|docker:postgres@vm_db_1/’ is ‘/|docker:postgres@vm_db_1’
17:00:41.274291 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/.projectile 2>/dev/null; echo tramp_exit_status $?
17:00:41.284290 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.289368 tramp-send-command (6) # test -e /.projectile 2>/dev/null; echo tramp_exit_status $?
17:00:41.296376 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.302776 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/.project 2>/dev/null; echo tramp_exit_status $?
17:00:41.309490 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.314718 tramp-send-command (6) # test -e /.project 2>/dev/null; echo tramp_exit_status $?
17:00:41.321659 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.328089 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/.git 2>/dev/null; echo tramp_exit_status $?
17:00:41.334686 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.339466 tramp-send-command (6) # test -e /.git 2>/dev/null; echo tramp_exit_status $?
17:00:41.347516 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.358128 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/info.rkt 2>/dev/null; echo tramp_exit_status $?
17:00:41.364276 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.368190 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/requirements.txt 2>/dev/null; echo tramp_exit_status $?
17:00:41.377559 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.382098 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/setup.py 2>/dev/null; echo tramp_exit_status $?
17:00:41.389910 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.394743 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/package.json 2>/dev/null; echo tramp_exit_status $?
17:00:41.403435 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.407299 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/deps.edn 2>/dev/null; echo tramp_exit_status $?
17:00:41.415488 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.419511 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/build.boot 2>/dev/null; echo tramp_exit_status $?
17:00:41.428230 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.432143 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/project.clj 2>/dev/null; echo tramp_exit_status $?
17:00:41.441662 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.446569 tramp-send-command (6) # test -e /info.rkt 2>/dev/null; echo tramp_exit_status $?
17:00:41.453722 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.457726 tramp-send-command (6) # test -e /requirements.txt 2>/dev/null; echo tramp_exit_status $?
17:00:41.467239 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.471833 tramp-send-command (6) # test -e /setup.py 2>/dev/null; echo tramp_exit_status $?
17:00:41.479176 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.483067 tramp-send-command (6) # test -e /package.json 2>/dev/null; echo tramp_exit_status $?
17:00:41.492227 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.496262 tramp-send-command (6) # test -e /deps.edn 2>/dev/null; echo tramp_exit_status $?
17:00:41.505499 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.510676 tramp-send-command (6) # test -e /build.boot 2>/dev/null; echo tramp_exit_status $?
17:00:41.517994 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.522018 tramp-send-command (6) # test -e /project.clj 2>/dev/null; echo tramp_exit_status $?
17:00:41.530482 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.540034 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/Makefile 2>/dev/null; echo tramp_exit_status $?
17:00:41.547405 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.551781 tramp-send-command (6) # test -e /Makefile 2>/dev/null; echo tramp_exit_status $?
17:00:41.560850 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.567091 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp’
17:00:41.568044 tramp-send-command (6) # \readlink --canonicalize-missing /tmp 2>/dev/null; echo tramp_exit_status $?
17:00:41.574650 tramp-wait-for-regexp (6) # 
/tmp
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.577935 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp
17:00:41.578909 tramp-send-command (6) # ( (test -e /tmp || test -h /tmp) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:41.588466 tramp-wait-for-regexp (6) # 
(("‘/tmp’") 18 0 0 1580859701 1598302841 1598302841 4096 "drwxrwxrwt" t 4037 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.590852 tramp-sh-handle-file-truename (4) # True name of ‘/tmp’ is ‘/tmp’
17:00:41.593389 tramp-send-command (6) # chown 1000:1000 /tmp/sql-in-gGkmZB
17:00:41.600658 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.605991 tramp-send-command (6) # test -e /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:41.611726 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.614430 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-out-eSnX5w
17:00:41.615430 tramp-send-command (6) # ( (test -e /tmp/sql-out-eSnX5w || test -h /tmp/sql-out-eSnX5w) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-out-eSnX5w | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:41.625371 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.627160 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /tmp/sql-out-eSnX5w
17:00:41.628126 tramp-send-command (6) # test -e /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:41.634049 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.636004 tramp-send-command (6) # test -h /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:41.641904 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.649334 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’
17:00:41.650311 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:41.661308 tramp-wait-for-regexp (6) # 
/tmp/sql-out-eSnX5w
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.664636 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/sql-out-eSnX5w’ is ‘/tmp/sql-out-eSnX5w’
17:00:41.669767 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.ngLP8j’ using ‘base64-encode-region’...
17:00:41.672015 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.ngLP8j’ using ‘base64-encode-region’...done
17:00:41.673405 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ using ‘base64 -d -i >%s’...
17:00:41.675233 tramp-send-command (6) # base64 -d -i >/tmp/sql-out-eSnX5w <<'d54ddf76da42b2280c807639dc002253'
d54ddf76da42b2280c807639dc002253
17:00:41.686009 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.687597 tramp-send-command (6) # echo tramp_exit_status $?
17:00:41.694137 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.698287 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ using ‘base64 -d -i >%s’...done
17:00:41.765917 tramp-send-command (6) # chown 1000:1000 /tmp/sql-out-eSnX5w
17:00:41.776014 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.782072 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-in-gGkmZB
17:00:41.782985 tramp-send-command (6) # ( (test -e /tmp/sql-in-gGkmZB || test -h /tmp/sql-in-gGkmZB) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-in-gGkmZB | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:41.791957 tramp-wait-for-regexp (6) # 
(("‘/tmp/sql-in-gGkmZB’") 1 1000 1000 1598302841 1598302841 1598302841 0 "-rw-rw-r--" t 6889 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.797673 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/sql-in-gGkmZB’
17:00:41.798553 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/sql-in-gGkmZB 2>/dev/null; echo tramp_exit_status $?
17:00:41.805808 tramp-wait-for-regexp (6) # 
/tmp/sql-in-gGkmZB
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.809390 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/sql-in-gGkmZB’ is ‘/tmp/sql-in-gGkmZB’
17:00:41.819812 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.MuRRoe’ using ‘base64-encode-region’...
17:00:41.821699 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.MuRRoe’ using ‘base64-encode-region’...done
17:00:41.823039 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-in-gGkmZB’ using ‘base64 -d -i >%s’...
17:00:41.824346 tramp-send-command (6) # base64 -d -i >/tmp/sql-in-gGkmZB <<'d54ddf76da42b2280c807639dc002253'
U0VMRUNUICoKICBGUk9NIGFjY291bnRfdXNlciB1CiAgICAgICAgIElOTkVSIEpPSU4gYWNjb3Vu
dF9lbWFpbGFkZHJlc3MgYWUKICAgICAgICAgICAgIE9OIGFlLnVzZXJfaWQgPSB1LmlkCiBXSEVS
RSB1LmlkID0gMTQzMDs=
d54ddf76da42b2280c807639dc002253
17:00:41.835134 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.836702 tramp-send-command (6) # echo tramp_exit_status $?
17:00:41.843099 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.847335 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-in-gGkmZB’ using ‘base64 -d -i >%s’...done
17:00:41.908937 tramp-send-command (6) # chown 1000:1000 /tmp/sql-in-gGkmZB
17:00:41.918335 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.923500 tramp-send-command (6) # test -e /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:41.933022 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.935533 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/ob-input-FYnxwj
17:00:41.936440 tramp-send-command (6) # ( (test -e /tmp/ob-input-FYnxwj || test -h /tmp/ob-input-FYnxwj) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/ob-input-FYnxwj | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:41.945249 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.946820 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /tmp/ob-input-FYnxwj
17:00:41.947707 tramp-send-command (6) # test -e /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:41.954588 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.956213 tramp-send-command (6) # test -h /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:41.961722 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.967740 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj’
17:00:41.968738 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:41.976547 tramp-wait-for-regexp (6) # 
/tmp/ob-input-FYnxwj
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.979951 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/ob-input-FYnxwj’ is ‘/tmp/ob-input-FYnxwj’
17:00:41.984687 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.6HTCdq’ using ‘base64-encode-region’...
17:00:41.986538 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.6HTCdq’ using ‘base64-encode-region’...done
17:00:41.987774 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj’ using ‘base64 -d -i >%s’...
17:00:41.988952 tramp-send-command (6) # base64 -d -i >/tmp/ob-input-FYnxwj <<'d54ddf76da42b2280c807639dc002253'
d54ddf76da42b2280c807639dc002253
17:00:41.996923 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:41.998502 tramp-send-command (6) # echo tramp_exit_status $?
17:00:42.004230 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.008129 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj’ using ‘base64 -d -i >%s’...done
17:00:42.074464 tramp-send-command (6) # chown 1000:1000 /tmp/ob-input-FYnxwj
17:00:42.086586 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.091601 tramp-send-command (6) # test -e /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.099741 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.102333 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/ob-error-2K9AZu
17:00:42.103247 tramp-send-command (6) # ( (test -e /tmp/ob-error-2K9AZu || test -h /tmp/ob-error-2K9AZu) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/ob-error-2K9AZu | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:42.112190 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.113767 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /tmp/ob-error-2K9AZu
17:00:42.114630 tramp-send-command (6) # test -e /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.120359 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.122011 tramp-send-command (6) # test -h /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.128379 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.134032 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/ob-error-2K9AZu’
17:00:42.134913 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.142400 tramp-wait-for-regexp (6) # 
/tmp/ob-error-2K9AZu
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.146131 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/ob-error-2K9AZu’ is ‘/tmp/ob-error-2K9AZu’
17:00:42.150896 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.EDTo8F’ using ‘base64-encode-region’...
17:00:42.152589 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.EDTo8F’ using ‘base64-encode-region’...done
17:00:42.153686 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/ob-error-2K9AZu’ using ‘base64 -d -i >%s’...
17:00:42.154839 tramp-send-command (6) # base64 -d -i >/tmp/ob-error-2K9AZu <<'d54ddf76da42b2280c807639dc002253'
d54ddf76da42b2280c807639dc002253
17:00:42.164359 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.165924 tramp-send-command (6) # echo tramp_exit_status $?
17:00:42.172216 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.176127 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/ob-error-2K9AZu’ using ‘base64 -d -i >%s’...done
17:00:42.241619 tramp-send-command (6) # chown 1000:1000 /tmp/ob-error-2K9AZu
17:00:42.250781 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.255754 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /usr/local/bin/fish
17:00:42.256679 tramp-send-command (6) # ( (test -e /usr/local/bin/fish || test -h /usr/local/bin/fish) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h /////%U///// /////%G///// %X %Y %Z %s /////%A///// t %i -1)' /usr/local/bin/fish | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:42.267041 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.269353 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /usr/local/bin/fish
17:00:42.270691 tramp-send-command (6) # test -e /usr/local/bin/fish 2>/dev/null; echo tramp_exit_status $?
17:00:42.279010 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.280666 tramp-send-command (6) # test -h /usr/local/bin/fish 2>/dev/null; echo tramp_exit_status $?
17:00:42.286895 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.289461 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /usr/local/bin/fish
17:00:42.290368 tramp-send-command (6) # ( (test -e /usr/local/bin/fish || test -h /usr/local/bin/fish) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /usr/local/bin/fish | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:42.299871 tramp-wait-for-regexp (6) # 
nil
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.301520 tramp-do-file-attributes-with-ls (5) # file attributes with ls: /usr/local/bin/fish
17:00:42.302410 tramp-send-command (6) # test -e /usr/local/bin/fish 2>/dev/null; echo tramp_exit_status $?
17:00:42.309227 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.310853 tramp-send-command (6) # test -h /usr/local/bin/fish 2>/dev/null; echo tramp_exit_status $?
17:00:42.317000 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.318689 tramp-send-command (6) # test -x /usr/local/bin/fish 2>/dev/null; echo tramp_exit_status $?
17:00:42.324660 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.329036 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/ob-input-FYnxwj
17:00:42.329989 tramp-send-command (6) # ( (test -e /tmp/ob-input-FYnxwj || test -h /tmp/ob-input-FYnxwj) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/ob-input-FYnxwj | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:42.341751 tramp-wait-for-regexp (6) # 
(("‘/tmp/ob-input-FYnxwj’") 1 1000 1000 1598302842 1598302842 1598302842 0 "-rw-rw-r--" t 6891 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.347880 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj’
17:00:42.348938 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:42.356323 tramp-wait-for-regexp (6) # 
/tmp/ob-input-FYnxwj
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.359735 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/ob-input-FYnxwj’ is ‘/tmp/ob-input-FYnxwj’
17:00:42.364584 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.CtsYC7’ using ‘base64-encode-region’...
17:00:42.366246 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.CtsYC7’ using ‘base64-encode-region’...done
17:00:42.367399 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj’ using ‘base64 -d -i >%s’...
17:00:42.368641 tramp-send-command (6) # base64 -d -i >/tmp/ob-input-FYnxwj <<'d54ddf76da42b2280c807639dc002253'
d54ddf76da42b2280c807639dc002253
17:00:42.377429 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.379006 tramp-send-command (6) # echo tramp_exit_status $?
17:00:42.384459 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.388880 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj’ using ‘base64 -d -i >%s’...done
17:00:42.453308 tramp-send-command (6) # chown 1000:1000 /tmp/ob-input-FYnxwj
17:00:42.463305 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.468845 tramp-sh-handle-write-region (0) # Wrote /sshx:user@devbox01.fake:/tmp/ob-input-FYnxwj
17:00:42.475369 tramp-send-command (6) # ( cd /\|docker\:postgres\@vm_db_1/ && /bin/sh -c psql\ --set\=\"ON_ERROR_STOP\=1\"\ \ -A\ -P\ footer\=off\ -F\ \"\	\"\ \ -hlocalhost\ -Upostgres\ -dmycompany\ -f\ /tmp/sql-in-gGkmZB\ -o\ /tmp/sql-out-eSnX5w\  </tmp/ob-input-FYnxwj 2>/tmp/ob-error-2K9AZu; echo tramp_exit_status $? )
17:00:42.484701 tramp-wait-for-regexp (6) # 
/bin/sh: 1293: cd: can't cd to /|docker:postgres@vm_db_1/
tramp_exit_status 2
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.487578 tramp-send-command (6) # test -e /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:42.495602 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.554992 tramp-send-command (6) # test -d /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:42.563478 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.566138 tramp-send-command (6) # rm -f /tmp/ob-input-FYnxwj 2>/dev/null; echo tramp_exit_status $?
17:00:42.572913 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.575645 tramp-send-command (6) # test -e /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.581288 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.583885 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/ob-error-2K9AZu
17:00:42.585035 tramp-send-command (6) # ( (test -e /tmp/ob-error-2K9AZu || test -h /tmp/ob-error-2K9AZu) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/ob-error-2K9AZu | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:42.598294 tramp-wait-for-regexp (6) # 
(("‘/tmp/ob-error-2K9AZu’") 1 1000 1000 1598302842 1598302842 1598302842 0 "-rw-rw-r--" t 6892 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.659171 tramp-send-command (6) # test -d /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.665896 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.668607 tramp-send-command (6) # rm -f /tmp/ob-error-2K9AZu 2>/dev/null; echo tramp_exit_status $?
17:00:42.675567 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.686555 tramp-send-command (6) # test -e /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:42.693946 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.699382 tramp-handle-insert-file-contents (3) # Inserting ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’...
17:00:42.704217 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’
17:00:42.705202 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:42.713742 tramp-wait-for-regexp (6) # 
/tmp/sql-out-eSnX5w
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.716791 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-out-eSnX5w
17:00:42.717769 tramp-send-command (6) # ( (test -e /tmp/sql-out-eSnX5w || test -h /tmp/sql-out-eSnX5w) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-out-eSnX5w | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:42.729465 tramp-wait-for-regexp (6) # 
(("‘/tmp/sql-out-eSnX5w’") 1 1000 1000 1598302841 1598302841 1598302841 0 "-rw-rw-r--" t 6890 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.731491 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/sql-out-eSnX5w’ is ‘/tmp/sql-out-eSnX5w’
17:00:42.739279 tramp-sh-handle-file-local-copy (3) # Encoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ with ‘base64 <%s’...
17:00:42.740516 tramp-send-command (6) # base64 </tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:42.748254 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.753797 tramp-sh-handle-file-local-copy (3) # Encoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ with ‘base64 <%s’...done
17:00:42.755073 tramp-sh-handle-file-local-copy (3) # Decoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.aGJl2Y’ with ‘base64-decode-region’...
17:00:42.757086 tramp-sh-handle-file-local-copy (3) # Decoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.aGJl2Y’ with ‘base64-decode-region’...done
17:00:42.762286 tramp-call-process (6) # ‘chown 501:20 /var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.aGJl2Y’ nil nil
17:00:42.774890 tramp-call-process (6) # 0
17:00:42.777015 tramp-handle-insert-file-contents (3) # Inserting ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’...done
17:00:42.861941 tramp-send-command (6) # test -e /tmp/.projectile 2>/dev/null; echo tramp_exit_status $?
17:00:42.871080 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.879041 tramp-send-command (6) # test -e /tmp/.project 2>/dev/null; echo tramp_exit_status $?
17:00:42.884702 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.892129 tramp-send-command (6) # test -e /tmp/.git 2>/dev/null; echo tramp_exit_status $?
17:00:42.900672 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.911561 tramp-send-command (6) # test -e /tmp/info.rkt 2>/dev/null; echo tramp_exit_status $?
17:00:42.917870 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.921574 tramp-send-command (6) # test -e /tmp/requirements.txt 2>/dev/null; echo tramp_exit_status $?
17:00:42.930609 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.934163 tramp-send-command (6) # test -e /tmp/setup.py 2>/dev/null; echo tramp_exit_status $?
17:00:42.940335 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.944370 tramp-send-command (6) # test -e /tmp/package.json 2>/dev/null; echo tramp_exit_status $?
17:00:42.952434 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.956166 tramp-send-command (6) # test -e /tmp/deps.edn 2>/dev/null; echo tramp_exit_status $?
17:00:42.964599 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.968164 tramp-send-command (6) # test -e /tmp/build.boot 2>/dev/null; echo tramp_exit_status $?
17:00:42.978170 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:42.982478 tramp-send-command (6) # test -e /tmp/project.clj 2>/dev/null; echo tramp_exit_status $?
17:00:42.990108 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.009661 tramp-send-command (6) # test -e /tmp/Makefile 2>/dev/null; echo tramp_exit_status $?
17:00:43.016736 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.043664 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-out-eSnX5w
17:00:43.044821 tramp-send-command (6) # ( (test -e /tmp/sql-out-eSnX5w || test -h /tmp/sql-out-eSnX5w) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h /////%U///// /////%G///// %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-out-eSnX5w | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:43.057381 tramp-wait-for-regexp (6) # 
(("‘/tmp/sql-out-eSnX5w’") 1 "user" "user" 1598302842 1598302841 1598302841 0 "-rw-rw-r--" t 6890 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.063585 tramp-sh-handle-vc-registered (3) # Checking ‘vc-registered’ for /sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w...
17:00:43.068199 tramp-send-command (6) # test -d /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:43.076705 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.077944 tramp-send-command (6) # test -d /tmp 2>/dev/null; echo tramp_exit_status $?
17:00:43.084120 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.085708 tramp-send-command (6) # test -d / 2>/dev/null; echo tramp_exit_status $?
17:00:43.092028 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.104150 tramp-maybe-send-script (5) # Sending script ‘tramp_vc_registered_read_file_names’...
17:00:43.104594 tramp-send-command (6) # tramp_vc_registered_read_file_names () {
echo "("
while read file; do
    quoted=`echo "$file" | sed -e "s/\"/\\\\\\\\\"/"`
    if test -e "$file"; then
        echo "(\"$quoted\" \"file-exists-p\" t)"
    else
        echo "(\"$quoted\" \"file-exists-p\" nil)"
    fi
    if test -r "$file"; then
        echo "(\"$quoted\" \"file-readable-p\" t)"
    else
        echo "(\"$quoted\" \"file-readable-p\" nil)"
    fi
done
echo ")"
} 2>/dev/null; echo tramp_exit_status $?
17:00:43.110773 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.111528 tramp-maybe-send-script (5) # Sending script ‘tramp_vc_registered_read_file_names’...done
17:00:43.112118 tramp-send-command (6) # tramp_vc_registered_read_file_names <<'d54ddf76da42b2280c807639dc002253'
/tmp/RCS/sql-out-eSnX5w\,v
/tmp/sql-out-eSnX5w\,v
/tmp/RCS/sql-out-eSnX5w
/tmp/CVS/Entries
/\|docker\:postgres\@vm_db_1/
/tmp/.svn
/.svn
/tmp/SCCS/s.sql-out-eSnX5w
/tmp/s.sql-out-eSnX5w
/tmp/.src/sql-out-eSnX5w\,v
/tmp/.bzr/checkout/format
/.bzr/checkout/format
/tmp/.git
/.git
/tmp/.hg
/.hg
d54ddf76da42b2280c807639dc002253
17:00:43.146680 tramp-wait-for-regexp (6) # 
(
("/tmp/RCS/sql-out-eSnX5w,v" "file-exists-p" nil)
("/tmp/RCS/sql-out-eSnX5w,v" "file-readable-p" nil)
("/tmp/sql-out-eSnX5w,v" "file-exists-p" nil)
("/tmp/sql-out-eSnX5w,v" "file-readable-p" nil)
("/tmp/RCS/sql-out-eSnX5w" "file-exists-p" nil)
("/tmp/RCS/sql-out-eSnX5w" "file-readable-p" nil)
("/tmp/CVS/Entries" "file-exists-p" nil)
("/tmp/CVS/Entries" "file-readable-p" nil)
("/|docker:postgres@vm_db_1/" "file-exists-p" nil)
("/|docker:postgres@vm_db_1/" "file-readable-p" nil)
("/tmp/.svn" "file-exists-p" nil)
("/tmp/.svn" "file-readable-p" nil)
("/.svn" "file-exists-p" nil)
("/.svn" "file-readable-p" nil)
("/tmp/SCCS/s.sql-out-eSnX5w" "file-exists-p" nil)
("/tmp/SCCS/s.sql-out-eSnX5w" "file-readable-p" nil)
("/tmp/s.sql-out-eSnX5w" "file-exists-p" nil)
("/tmp/s.sql-out-eSnX5w" "file-readable-p" nil)
("/tmp/.src/sql-out-eSnX5w,v" "file-exists-p" nil)
("/tmp/.src/sql-out-eSnX5w,v" "file-readable-p" nil)
("/tmp/.bzr/checkout/format" "file-exists-p" nil)
("/tmp/.bzr/checkout/format" "file-readable-p" nil)
("/.bzr/checkout/format" "file-exists-p" nil)
("/.bzr/checkout/format" "file-readable-p" nil)
("/tmp/.git" "file-exists-p" nil)
("/tmp/.git" "file-readable-p" nil)
("/.git" "file-exists-p" nil)
("/.git" "file-readable-p" nil)
("/tmp/.hg" "file-exists-p" nil)
("/tmp/.hg" "file-readable-p" nil)
("/.hg" "file-exists-p" nil)
("/.hg" "file-readable-p" nil)
)
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.178537 tramp-sh-handle-vc-registered (3) # Checking ‘vc-registered’ for /sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w...done
17:00:43.196296 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/
17:00:43.197468 tramp-send-command (6) # ( (test -e /tmp/ || test -h /tmp/) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h /////%U///// /////%G///// %X %Y %Z %s /////%A///// t %i -1)' /tmp/ | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:43.206832 tramp-wait-for-regexp (6) # 
(("‘/tmp/’") 18 "root" "root" 1580859701 1598302842 1598302842 4096 "drwxrwxrwt" t 4037 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.224810 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.tEJnud’ using ‘base64-encode-region’...
17:00:43.227902 tramp-sh-handle-write-region (3) # Encoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.tEJnud’ using ‘base64-encode-region’...done
17:00:43.234459 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ using ‘base64 -d -i >%s’...
17:00:43.235916 tramp-send-command (6) # base64 -d -i >/tmp/sql-out-eSnX5w <<'d54ddf76da42b2280c807639dc002253'
LQo=
d54ddf76da42b2280c807639dc002253
17:00:43.247934 tramp-wait-for-regexp (6) # 
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.249552 tramp-send-command (6) # echo tramp_exit_status $?
17:00:43.255548 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.259222 tramp-sh-handle-write-region (3) # Decoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ using ‘base64 -d -i >%s’...done
17:00:43.319114 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-out-eSnX5w
17:00:43.320051 tramp-send-command (6) # ( (test -e /tmp/sql-out-eSnX5w || test -h /tmp/sql-out-eSnX5w) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-out-eSnX5w | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:43.330007 tramp-wait-for-regexp (6) # 
(("‘/tmp/sql-out-eSnX5w’") 1 1000 1000 1598302842 1598302843 1598302843 2 "-rw-rw-r--" t 6890 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.335490 tramp-sh-handle-write-region (0) # Wrote /sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w
17:00:43.342976 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’
17:00:43.343889 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:43.350781 tramp-wait-for-regexp (6) # 
/tmp/sql-out-eSnX5w
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.354458 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/sql-out-eSnX5w’ is ‘/tmp/sql-out-eSnX5w’
17:00:43.430421 tramp-sh-handle-vc-registered (3) # Checking ‘vc-registered’ for /sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w...
17:00:43.434598 tramp-send-command (6) # test -d /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:43.443242 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.445209 tramp-send-command (6) # test -d /tmp 2>/dev/null; echo tramp_exit_status $?
17:00:43.451596 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.454195 tramp-send-command (6) # test -d / 2>/dev/null; echo tramp_exit_status $?
17:00:43.460320 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.475638 tramp-send-command (6) # tramp_vc_registered_read_file_names <<'d54ddf76da42b2280c807639dc002253'
/tmp/RCS/sql-out-eSnX5w\,v
/tmp/sql-out-eSnX5w\,v
/tmp/RCS/sql-out-eSnX5w
/tmp/CVS/Entries
/\|docker\:postgres\@vm_db_1/
/tmp/.svn
/.svn
/tmp/SCCS/s.sql-out-eSnX5w
/tmp/s.sql-out-eSnX5w
/tmp/.src/sql-out-eSnX5w\,v
/tmp/.bzr/checkout/format
/.bzr/checkout/format
/tmp/.git
/.git
/tmp/.hg
/.hg
d54ddf76da42b2280c807639dc002253
17:00:43.510777 tramp-wait-for-regexp (6) # 
(
("/tmp/RCS/sql-out-eSnX5w,v" "file-exists-p" nil)
("/tmp/RCS/sql-out-eSnX5w,v" "file-readable-p" nil)
("/tmp/sql-out-eSnX5w,v" "file-exists-p" nil)
("/tmp/sql-out-eSnX5w,v" "file-readable-p" nil)
("/tmp/RCS/sql-out-eSnX5w" "file-exists-p" nil)
("/tmp/RCS/sql-out-eSnX5w" "file-readable-p" nil)
("/tmp/CVS/Entries" "file-exists-p" nil)
("/tmp/CVS/Entries" "file-readable-p" nil)
("/|docker:postgres@vm_db_1/" "file-exists-p" nil)
("/|docker:postgres@vm_db_1/" "file-readable-p" nil)
("/tmp/.svn" "file-exists-p" nil)
("/tmp/.svn" "file-readable-p" nil)
("/.svn" "file-exists-p" nil)
("/.svn" "file-readable-p" nil)
("/tmp/SCCS/s.sql-out-eSnX5w" "file-exists-p" nil)
("/tmp/SCCS/s.sql-out-eSnX5w" "file-readable-p" nil)
("/tmp/s.sql-out-eSnX5w" "file-exists-p" nil)
("/tmp/s.sql-out-eSnX5w" "file-readable-p" nil)
("/tmp/.src/sql-out-eSnX5w,v" "file-exists-p" nil)
("/tmp/.src/sql-out-eSnX5w,v" "file-readable-p" nil)
("/tmp/.bzr/checkout/format" "file-exists-p" nil)
("/tmp/.bzr/checkout/format" "file-readable-p" nil)
("/.bzr/checkout/format" "file-exists-p" nil)
("/.bzr/checkout/format" "file-readable-p" nil)
("/tmp/.git" "file-exists-p" nil)
("/tmp/.git" "file-readable-p" nil)
("/.git" "file-exists-p" nil)
("/.git" "file-readable-p" nil)
("/tmp/.hg" "file-exists-p" nil)
("/tmp/.hg" "file-readable-p" nil)
("/.hg" "file-exists-p" nil)
("/.hg" "file-readable-p" nil)
)
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.543685 tramp-sh-handle-vc-registered (3) # Checking ‘vc-registered’ for /sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w...done
17:00:43.547271 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-out-eSnX5w
17:00:43.548107 tramp-send-command (6) # ( (test -e /tmp/sql-out-eSnX5w || test -h /tmp/sql-out-eSnX5w) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h /////%U///// /////%G///// %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-out-eSnX5w | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:43.556830 tramp-wait-for-regexp (6) # 
(("‘/tmp/sql-out-eSnX5w’") 1 "user" "user" 1598302842 1598302843 1598302843 2 "-rw-rw-r--" t 6890 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.561051 tramp-send-command (6) # test -e /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:43.570730 tramp-wait-for-regexp (6) # 
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.574804 tramp-handle-insert-file-contents (3) # Inserting ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’...
17:00:43.579347 tramp-sh-handle-file-truename (4) # Finding true name for ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’
17:00:43.580268 tramp-send-command (6) # \readlink --canonicalize-missing /tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:43.590004 tramp-wait-for-regexp (6) # 
/tmp/sql-out-eSnX5w
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.593459 tramp-do-file-attributes-with-stat (5) # file attributes with stat: /tmp/sql-out-eSnX5w
17:00:43.594726 tramp-send-command (6) # ( (test -e /tmp/sql-out-eSnX5w || test -h /tmp/sql-out-eSnX5w) && (env QUOTING_STYLE=locale \stat -c '((/////%N/////) %h %u %g %X %Y %Z %s /////%A///// t %i -1)' /tmp/sql-out-eSnX5w | sed -e 's/"/\\"/g' -e 's/\/\/\/\/\//"/g') || echo nil) 2>/dev/null; echo tramp_exit_status $?
17:00:43.603955 tramp-wait-for-regexp (6) # 
(("‘/tmp/sql-out-eSnX5w’") 1 1000 1000 1598302842 1598302843 1598302843 2 "-rw-rw-r--" t 6890 -1)
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.605899 tramp-sh-handle-file-truename (4) # True name of ‘/tmp/sql-out-eSnX5w’ is ‘/tmp/sql-out-eSnX5w’
17:00:43.752290 tramp-sh-handle-file-local-copy (3) # Encoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ with ‘base64 <%s’...
17:00:43.753831 tramp-send-command (6) # base64 </tmp/sql-out-eSnX5w 2>/dev/null; echo tramp_exit_status $?
17:00:43.760991 tramp-wait-for-regexp (6) # 
LQo=
tramp_exit_status 0
///bac5284a3944c0ba3caa592f2502b122#$
17:00:43.766486 tramp-sh-handle-file-local-copy (3) # Encoding remote file ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’ with ‘base64 <%s’...done
17:00:43.767723 tramp-sh-handle-file-local-copy (3) # Decoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.i7EhZ3’ with ‘base64-decode-region’...
17:00:43.775300 tramp-sh-handle-file-local-copy (3) # Decoding local file ‘/var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.i7EhZ3’ with ‘base64-decode-region’...done
17:00:43.780601 tramp-call-process (6) # ‘chown 501:20 /var/folders/kz/c0gjk6g16jn95qnj139kyl480000gn/T/tramp.i7EhZ3’ nil nil
17:00:43.786234 tramp-call-process (6) # 0
17:00:43.787791 tramp-handle-insert-file-contents (3) # Inserting ‘/sshx:user@devbox01.fake:/tmp/sql-out-eSnX5w’...done
17:01:05.394548 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/ 2>/dev/null; echo tramp_exit_status $?
17:01:05.403648 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$17:01:05.403987 tramp-send-command (6) # test -e /\|docker\:postgres\@vm_db_1/ 2>/dev/null; echo tramp_exit_status $?
17:01:05.414023 tramp-wait-for-regexp (6) # 
tramp_exit_status 1
///bac5284a3944c0ba3caa592f2502b122#$