Subject: 24.3.50; package-install fails in non-interactive sessions

From: Sebastian Wiesner <[email-masked]>
Date: Thu, 28 Nov 2013 11:51:53 +0100

In Emacs 24.3.50 `package-install' fails to install packages from MELPA
at http://melpa.milkbox.net/packages/ in non-interactive sessions.

Note, that this does not affect Emacs 24.3, or *interactive* sessions of
Emacs 24.3.50, or the GNU archive generally.  The error only occurs when
installing packages from MELPA in a non-interactive session of Emacs
24.3.50.

The following script, which can also be found at
https://gist.github.com/lunaryorn/7638072, reproduces this problem.  As
you can see, it first installs packages from GNU ELPA, and then some
other packages from MELPA, into the current working directory.

(require 'package)
(require 'url)

(defun debug-msg (message &rest args)
  (message "DEBUG: %s" (apply #'format message args)))

(defmacro with-url-debug-buffer (&rest body)
  (declare (indent 0))
  `(with-current-buffer "*URL-DEBUG*"
     ,@body))

(defun clear-url-debug ()
  (with-url-debug-buffer
    (erase-buffer)))

(defun print-url-debug ()
  (with-url-debug-buffer
   (debug-msg "URL debugging output:\n%s" (buffer-string))))

(defun package-install-debug (pkg)
  (debug-msg "Installing %s" pkg)
  (unwind-protect
      (package-install pkg)
    (print-url-debug)
    (clear-url-debug)))

(defun install-melpa-packages ()
  (let ((package-archives '(("melpa" . "http://melpa.milkbox.net/packages/"))))
    (debug-msg "Refreshing MELPA archive")
    (package-refresh-contents)
    (print-url-debug)
    (clear-url-debug)
    (dolist (pkg '(dash s ag solarized-theme magit))
      (package-install-debug pkg))))

(defun install-gnu-packages ()
  (package-refresh-contents)
  (debug-msg "Refreshing GNU archive")
  (print-url-debug)
  (clear-url-debug)
  (dolist (pkg '(company coffee-mode js2-mode register-list undo-tree))
    (package-install-debug pkg)))

(defun main ()
  (let ((package-user-dir (expand-file-name "elpa"))
        (url-debug t)
        (debug-on-error t))
    ;; Erase the package directory to make things reproducible
    (when (file-exists-p package-user-dir)
      (delete-directory package-user-dir 'recursive))

    (package-initialize)

    ;; GNU packages should work fine
    (debug-msg "Installing GNU packages")
    (install-gnu-packages)

    ;; But MELPA packages do not
    (debug-msg "Installing MELPA packages")
    (install-melpa-packages)))

When saving this script as package-error.el and running it with "emacs
-Q -batch -l package-error.el -f main.el", it produces the following
output, which shows package-installation failing in
`package-handle-response':

DEBUG: Installing GNU packages
Contacting host: elpa.gnu.org:80
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/archives/gnu/archive-contents...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/archives/gnu/archive-contents
DEBUG: Refreshing GNU archive
DEBUG: URL debugging output:
http -> Contacting host: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Request is: 
GET /packages/archive-contents HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*)
http -> Saw end of headers... ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Got a content-length, being smart about document end.
http -> Calling initial content-length for extra data at end of headers
http -> Spinning waiting for headers...
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*>)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
HEAD /packages/archive-contents.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*-332966>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*-332966)
http -> Saw end of headers... ( *http elpa.gnu.org:80*-332966)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-332966)
http -> HEAD request must have headers only ( *http elpa.gnu.org:80*-332966).
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*-332966)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-332966)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*-332966)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*-332966>)
http -> Spinning waiting for headers...

DEBUG: Installing company
Contacting host: elpa.gnu.org:80
Parsing tar file...
Parsing tar file...done
Extracting company-0.6.12/
Extracting company-0.6.12/company-ispell.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-ispell.el
Extracting company-0.6.12/company-etags.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-etags.el
Extracting company-0.6.12/company-keywords.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-keywords.el
Extracting company-0.6.12/company-nxml.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-nxml.el
Extracting company-0.6.12/.gitignore
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/.gitignore
Extracting company-0.6.12/company-template.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-template.el
Extracting company-0.6.12/company-abbrev.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-abbrev.el
Extracting company-0.6.12/company-css.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-css.el
Extracting company-0.6.12/company-dabbrev.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-dabbrev.el
Extracting company-0.6.12/company-tests.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-tests.el
Extracting company-0.6.12/company-capf.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-capf.el
Extracting company-0.6.12/company-elisp.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-elisp.el
Extracting company-0.6.12/company-files.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-files.el
Extracting company-0.6.12/company-oddmuse.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-oddmuse.el
Extracting company-0.6.12/.dir-locals.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/.dir-locals.el
Extracting company-0.6.12/ChangeLog
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/ChangeLog
Extracting company-0.6.12/company-pysmell.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pysmell.el
Extracting company-0.6.12/README.md
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/README.md
Extracting company-0.6.12/company.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company.el
Extracting company-0.6.12/company-clang.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-clang.el
Extracting company-0.6.12/company-tempo.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-tempo.el
Extracting company-0.6.12/company-ropemacs.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-ropemacs.el
Extracting company-0.6.12/company-xcode.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-xcode.el
Extracting company-0.6.12/NEWS.md
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/NEWS.md
Extracting company-0.6.12/company-dabbrev-code.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-dabbrev-code.el
Extracting company-0.6.12/company-gtags.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-gtags.el
Extracting company-0.6.12/.travis.yml
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/.travis.yml
Extracting company-0.6.12/Makefile
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/Makefile
Extracting company-0.6.12/company-eclim.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-eclim.el
Extracting company-0.6.12/company-pkg.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pkg.el
Extracting company-0.6.12/company-semantic.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-semantic.el
Extracting company-0.6.12/company-cmake.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-cmake.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-autoloads.el
Making version-control local to company-autoloads.el while let-bound!
Generating autoloads for company-abbrev.el...
Generating autoloads for company-abbrev.el...done
Generating autoloads for company-capf.el...
Generating autoloads for company-capf.el...done
Generating autoloads for company-clang.el...
Generating autoloads for company-clang.el...done
Generating autoloads for company-cmake.el...
Generating autoloads for company-cmake.el...done
Generating autoloads for company-css.el...
Generating autoloads for company-css.el...done
Generating autoloads for company-dabbrev-code.el...
Generating autoloads for company-dabbrev-code.el...done
Generating autoloads for company-dabbrev.el...
Generating autoloads for company-dabbrev.el...done
Generating autoloads for company-eclim.el...
Generating autoloads for company-eclim.el...done
Generating autoloads for company-elisp.el...
Generating autoloads for company-elisp.el...done
Generating autoloads for company-etags.el...
Generating autoloads for company-etags.el...done
Generating autoloads for company-files.el...
Generating autoloads for company-files.el...done
Generating autoloads for company-gtags.el...
Generating autoloads for company-gtags.el...done
Generating autoloads for company-ispell.el...
Generating autoloads for company-ispell.el...done
Generating autoloads for company-keywords.el...
Generating autoloads for company-keywords.el...done
Generating autoloads for company-nxml.el...
Generating autoloads for company-nxml.el...done
Generating autoloads for company-oddmuse.el...
Generating autoloads for company-oddmuse.el...done
Generating autoloads for company-pkg.el...
Generating autoloads for company-pkg.el...done
Generating autoloads for company-pysmell.el...
Generating autoloads for company-pysmell.el...done
Generating autoloads for company-ropemacs.el...
Generating autoloads for company-ropemacs.el...done
Generating autoloads for company-semantic.el...
Generating autoloads for company-semantic.el...done
Generating autoloads for company-template.el...
Generating autoloads for company-template.el...done
Generating autoloads for company-tempo.el...
Generating autoloads for company-tempo.el...done
Generating autoloads for company-tests.el...
Generating autoloads for company-tests.el...done
Generating autoloads for company-xcode.el...
Generating autoloads for company-xcode.el...done
Generating autoloads for company.el...
Generating autoloads for company.el...done
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-autoloads.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-autoloads.el
(No changes need to be saved)
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pkg.el
Checking /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-abbrev.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-abbrev.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-autoloads.el...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-capf.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-capf.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-clang.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-clang.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-cmake.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-cmake.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-css.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-css.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-dabbrev-code.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-dabbrev-code.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-dabbrev.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-dabbrev.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-eclim.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-eclim.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-elisp.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-elisp.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-etags.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-etags.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-files.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-files.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-gtags.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-gtags.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-ispell.el...

In company-ispell-available:
company-ispell.el:46:21:Warning: `lookup-words' is an obsolete function (as of
    24.4); use `ispell-lookup-words' instead.

In company-ispell:
company-ispell.el:63:6:Warning: `lookup-words' is an obsolete function (as of
    24.4); use `ispell-lookup-words' instead.
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-ispell.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-keywords.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-keywords.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-nxml.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-nxml.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-oddmuse.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-oddmuse.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pkg.el...

In toplevel form:
company-pkg.el:1:1:Warning: `"abbrev"' is a malformed function
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pkg.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pysmell.el...

In end of data:
company-pysmell.el:70:1:Warning: the function `pysmell-get-all-completions' is
    not known to be defined.
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-pysmell.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-ropemacs.el...

In end of data:
company-ropemacs.el:77:1:Warning: the following functions are not known to be
    defined: rope-get-doc, rope-definition-location, pymacs-load,
    rope-completions
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-ropemacs.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-semantic.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-semantic.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-template.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-template.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-tempo.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-tempo.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-tests.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-tests.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-xcode.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company-xcode.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/company-0.6.12/company.elc
Done (Total of 25 files compiled, 1 skipped)
DEBUG: URL debugging output:
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
GET /packages/company-0.6.12.tar HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*)
http -> Saw end of headers... ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Got a content-length, being smart about document end.
http -> Calling initial content-length for extra data at end of headers
http -> Spinning waiting for headers...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*>)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
HEAD /packages/company-0.6.12.tar.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*-305204>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*-305204)
http -> Saw end of headers... ( *http elpa.gnu.org:80*-305204)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-305204)
http -> HEAD request must have headers only ( *http elpa.gnu.org:80*-305204).
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*-305204)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-305204)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*-305204)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*-305204>)
http -> Spinning waiting for headers...

DEBUG: Installing coffee-mode
Contacting host: elpa.gnu.org:80
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-autoloads.el
Generating autoloads for coffee-mode.el...
Generating autoloads for coffee-mode.el...done
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-autoloads.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-autoloads.el
(No changes need to be saved)
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-pkg.el
Checking /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-autoloads.el...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-pkg.el...

In toplevel form:
coffee-mode-pkg.el:1:1:Warning: `"CoffeeScript major mode"' is a malformed
    function
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode-pkg.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/coffee-mode-0.4.1.1/coffee-mode.elc
Done (Total of 2 files compiled, 1 skipped)
DEBUG: URL debugging output:
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
GET /packages/coffee-mode-0.4.1.1.el HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*)
http -> Saw end of headers... ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Got a content-length, being smart about document end.
http -> Calling initial content-length for extra data at end of headers
http -> Spinning waiting for headers...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*>)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
HEAD /packages/coffee-mode-0.4.1.1.el.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*-264700>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*-264700)
http -> Saw end of headers... ( *http elpa.gnu.org:80*-264700)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-264700)
http -> HEAD request must have headers only ( *http elpa.gnu.org:80*-264700).
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*-264700)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-264700)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*-264700)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*-264700>)
http -> Spinning waiting for headers...

DEBUG: Installing js2-mode
Contacting host: elpa.gnu.org:80
Parsing tar file...
Parsing tar file...done
Extracting js2-mode-20131106/
Extracting js2-mode-20131106/js2-mode-pkg.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-pkg.el
Extracting js2-mode-20131106/tests/
Extracting js2-mode-20131106/tests/indent.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/indent.el
Extracting js2-mode-20131106/tests/externs.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/externs.el
Extracting js2-mode-20131106/tests/parser.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/parser.el
Extracting js2-mode-20131106/.gitignore
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/.gitignore
Extracting js2-mode-20131106/js2-mode.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode.el
Extracting js2-mode-20131106/js2-imenu-extras.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-imenu-extras.el
Extracting js2-mode-20131106/.dir-locals.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/.dir-locals.el
Extracting js2-mode-20131106/ChangeLog
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/ChangeLog
Extracting js2-mode-20131106/README.md
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/README.md
Extracting js2-mode-20131106/.travis.yml
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/.travis.yml
Extracting js2-mode-20131106/Makefile
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/Makefile
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-autoloads.el
Generating autoloads for js2-imenu-extras.el...
Generating autoloads for js2-imenu-extras.el...done
Generating autoloads for js2-mode-pkg.el...
Generating autoloads for js2-mode-pkg.el...done
Generating autoloads for js2-mode.el...
Generating autoloads for js2-mode.el...done
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-autoloads.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-autoloads.el
(No changes need to be saved)
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-pkg.el
Checking /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-imenu-extras.el...
js2-mode.el: `labels' is an obsolete macro (as of 24.3); use `cl-labels' instead.
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-imenu-extras.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-autoloads.el...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-pkg.el...

In toplevel form:
js2-mode-pkg.el:1:1:Warning: `"languages"' is a malformed function
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode-pkg.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode.el...

In js2-skip-line:
js2-mode.el:5192:9:Warning: assignment to free variable `js2-token-end'

In js2-display-error-list:
js2-mode.el:10236:6:Warning: `labels' is an obsolete macro (as of 24.3); use
    `cl-labels' instead.
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/js2-mode.elc
Checking /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/externs.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/externs.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/indent.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/indent.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/parser.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/js2-mode-20131106/tests/parser.elc
Done (Total of 6 files compiled, 1 skipped in 2 directories)
DEBUG: URL debugging output:
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
GET /packages/js2-mode-20131106.tar HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*)
http -> Saw end of headers... ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Saw chunked encoding.
http -> Calling initial chunked-encoding for extra data at end of headers
http -> Reading chunk 0 (342 1428 1086)
http -> Saw start of chunk 1 (length=8106, start=343
http -> Reading chunk 1 (342 1428 1086)
http -> Still need 7021 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Spinning waiting for headers...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 1 (1422 4302 2880)
http -> Still need 4147 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 1 (4302 8398 4096)
http -> Still need 51 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 1 (8398 9891 1493)
http -> Got to the end of chunk #1!
http -> Saw start of chunk 2 (length=8096, start=8449
http -> Reading chunk 2 (8398 9891 1493)
http -> Still need 6654 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 2 (9883 11323 1440)
http -> Still need 5222 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 2 (11323 12763 1440)
http -> Still need 3782 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 2 (12763 15643 2880)
http -> Still need 902 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 2 (15643 17083 1440)
http -> Got to the end of chunk #2!
http -> Saw start of chunk 3 (length=8096, start=16545
http -> Reading chunk 3 (15643 17083 1440)
http -> Still need 7558 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 3 (17075 21171 4096)
http -> Still need 3470 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 3 (21171 25267 4096)
http -> Got to the end of chunk #3!
http -> Saw start of chunk 4 (length=8096, start=24641
http -> Reading chunk 4 (21171 25267 4096)
http -> Still need 7470 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 4 (25259 27147 1888)
http -> Still need 5590 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 4 (27147 28587 1440)
http -> Still need 4150 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 4 (28587 30027 1440)
http -> Still need 2710 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 4 (30027 31467 1440)
http -> Still need 1270 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 4 (31467 32907 1440)
http -> Got to the end of chunk #4!
http -> Saw start of chunk 5 (length=8096, start=32737
http -> Reading chunk 5 (31467 32907 1440)
http -> Still need 7926 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 5 (32899 34339 1440)
http -> Still need 6494 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 5 (34339 35779 1440)
http -> Still need 5054 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 5 (35779 37219 1440)
http -> Still need 3614 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 5 (37219 38659 1440)
http -> Still need 2174 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 5 (38659 40099 1440)
http -> Still need 734 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 5 (40099 41539 1440)
http -> Got to the end of chunk #5!
http -> Saw start of chunk 6 (length=8096, start=40833
http -> Reading chunk 6 (40099 41539 1440)
http -> Still need 7390 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 6 (41531 42971 1440)
http -> Still need 5958 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 6 (42971 44411 1440)
http -> Still need 4518 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 6 (44411 45851 1440)
http -> Still need 3078 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 6 (45851 47291 1440)
http -> Still need 1638 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 6 (47291 48731 1440)
http -> Still need 198 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 6 (48731 50171 1440)
http -> Got to the end of chunk #6!
http -> Saw start of chunk 7 (length=8096, start=48929
http -> Reading chunk 7 (48731 50171 1440)
http -> Still need 6854 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 7 (50163 51603 1440)
http -> Still need 5422 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 7 (51603 53043 1440)
http -> Still need 3982 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 7 (53043 54483 1440)
http -> Still need 2542 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 7 (54483 55923 1440)
http -> Still need 1102 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 7 (55923 57363 1440)
http -> Got to the end of chunk #7!
http -> Saw start of chunk 8 (length=55414, start=57025
http -> Reading chunk 8 (55923 57363 1440)
http -> Still need 55076 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (57355 58795 1440)
http -> Still need 53644 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (58795 60235 1440)
http -> Still need 52204 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (60235 61675 1440)
http -> Still need 50764 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (61675 63115 1440)
http -> Still need 49324 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (63115 64555 1440)
http -> Still need 47884 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (64555 65995 1440)
http -> Still need 46444 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (65995 67435 1440)
http -> Still need 45004 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (67435 68875 1440)
http -> Still need 43564 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (68875 70315 1440)
http -> Still need 42124 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (70315 71755 1440)
http -> Still need 40684 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (71755 73195 1440)
http -> Still need 39244 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (73195 74635 1440)
http -> Still need 37804 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (74635 78731 4096)
http -> Still need 33708 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (78731 81835 3104)
http -> Still need 30604 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (81835 83275 1440)
http -> Still need 29164 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (83275 84715 1440)
http -> Still need 27724 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (84715 86155 1440)
http -> Still need 26284 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (86155 87595 1440)
http -> Still need 24844 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (87595 89035 1440)
http -> Still need 23404 bytes to hit end of chunk
http -> Still spinning for next chunk...
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (89035 90475 1440)
http -> Still need 21964 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (90475 91915 1440)
http -> Still need 20524 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (91915 93355 1440)
http -> Still need 19084 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (93355 94795 1440)
http -> Still need 17644 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (94795 96235 1440)
http -> Still need 16204 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (96235 97675 1440)
http -> Still need 14764 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (97675 99115 1440)
http -> Still need 13324 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (99115 100555 1440)
http -> Still need 11884 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (100555 101995 1440)
http -> Still need 10444 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (101995 103435 1440)
http -> Still need 9004 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (103435 104875 1440)
http -> Still need 7564 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (104875 106315 1440)
http -> Still need 6124 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (106315 107755 1440)
http -> Still need 4684 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (107755 109195 1440)
http -> Still need 3244 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (109195 110635 1440)
http -> Still need 1804 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (110635 112075 1440)
http -> Still need 364 bytes to hit end of chunk
http -> Still spinning for next chunk...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-chunked-encoding-after-change-function' for `#<process elpa.gnu.org>'
http -> Reading chunk 8 (112075 112446 371)
http -> Got to the end of chunk #8!
http -> Saw start of chunk 9 (length=0, start=112439
http -> Saw end of stream chunk!
http -> Removing terminator of last chunk
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*>)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
HEAD /packages/js2-mode-20131106.tar.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*-168705>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*-168705)
http -> Saw end of headers... ( *http elpa.gnu.org:80*-168705)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-168705)
http -> HEAD request must have headers only ( *http elpa.gnu.org:80*-168705).
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*-168705)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-168705)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*-168705)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*-168705>)
http -> Spinning waiting for headers...

DEBUG: Installing register-list
Contacting host: elpa.gnu.org:80
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-autoloads.el
Generating autoloads for register-list.el...
Generating autoloads for register-list.el...done
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-autoloads.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-autoloads.el
(No changes need to be saved)
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-pkg.el
Checking /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-autoloads.el...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-pkg.el...

In toplevel form:
register-list-pkg.el:1:1:Warning: `"register"' is a malformed function
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list-pkg.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list.el...

In register-list:
register-list.el:406:8:Warning: called-interactively-p called with 0
    arguments, but requires 1
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/register-list-0.1/register-list.elc
Done (Total of 2 files compiled, 1 skipped)
DEBUG: URL debugging output:
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
GET /packages/register-list-0.1.el HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*)
http -> Saw end of headers... ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Got a content-length, being smart about document end.
http -> Calling initial content-length for extra data at end of headers
http -> Spinning waiting for headers...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*>)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
HEAD /packages/register-list-0.1.el.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*-592319>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*-592319)
http -> Saw end of headers... ( *http elpa.gnu.org:80*-592319)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-592319)
http -> HEAD request must have headers only ( *http elpa.gnu.org:80*-592319).
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*-592319)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-592319)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*-592319)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*-592319>)
http -> Spinning waiting for headers...

DEBUG: Installing undo-tree
Contacting host: elpa.gnu.org:80
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree.el
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-autoloads.el
Generating autoloads for undo-tree.el...
Generating autoloads for undo-tree.el...done
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-autoloads.el...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-autoloads.el
(No changes need to be saved)
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-pkg.el
Checking /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-autoloads.el...
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-pkg.el...

In toplevel form:
undo-tree-pkg.el:1:1:Warning: `"convenience"' is a malformed function
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree-pkg.elc
Compiling /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree.el...

In toplevel form:
undo-tree.el:1964:1:Warning: Unused lexical variable `i'
undo-tree.el:1964:1:Warning: Unused lexical variable `i'
undo-tree.el:1964:1:Warning: Unused lexical variable `i'
undo-tree.el:1964:1:Warning: Unused lexical variable `i'
undo-tree.el:2662:1:Warning: Unused lexical variable `i'
undo-tree.el:2768:1:Warning: Unused lexical variable `i'
undo-tree.el:3254:1:Warning: Unused lexical variable `n'
undo-tree.el:3437:1:Warning: Unused lexical variable `i'
undo-tree.el:3437:1:Warning: Unused lexical variable `i'
undo-tree.el:3584:1:Warning: Unused lexical variable `i'
undo-tree.el:3658:1:Warning: Unused lexical variable `i'
undo-tree.el:3658:1:Warning: Unused lexical variable `i'
undo-tree.el:4066:1:Warning: Unused lexical variable `i'
undo-tree.el:4086:1:Warning: Unused lexical variable `i'
undo-tree.el:4108:1:Warning: Unused lexical variable `i'
undo-tree.el:4129:1:Warning: Unused lexical variable `i'
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/undo-tree-0.6.3/undo-tree.elc
Done (Total of 2 files compiled, 1 skipped)
DEBUG: URL debugging output:
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
GET /packages/undo-tree-0.6.3.el HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*)
http -> Saw end of headers... ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Got a content-length, being smart about document end.
http -> Calling initial content-length for extra data at end of headers
http -> Spinning waiting for headers...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process elpa.gnu.org>'
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*>)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*)
http -> Found existing connection: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Reusing existing connection: elpa.gnu.org:80
http -> Marking connection as busy: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Request is: 
HEAD /packages/undo-tree-0.6.3.el.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: elpa.gnu.org
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http elpa.gnu.org:80*-906212>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process elpa.gnu.org>'
http -> url-http-wait-for-headers-change-function ( *http elpa.gnu.org:80*-906212)
http -> Saw end of headers... ( *http elpa.gnu.org:80*-906212)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-906212)
http -> HEAD request must have headers only ( *http elpa.gnu.org:80*-906212).
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> url-http-parse-headers called in ( *http elpa.gnu.org:80*-906212)
http -> url-http-parse-response called in ( *http elpa.gnu.org:80*-906212)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: elpa.gnu.org:80 #<process elpa.gnu.org>
http -> Activating callback in buffer ( *http elpa.gnu.org:80*-906212)
retrieval -> Synchronous fetching done (#<buffer  *http elpa.gnu.org:80*-906212>)
http -> Spinning waiting for headers...

DEBUG: Installing MELPA packages
DEBUG: Refreshing MELPA archive
Contacting host: melpa.milkbox.net:80
Saving file /Users/swiesner/Developer/Sandbox/package-error/elpa/archives/melpa/archive-contents...
Wrote /Users/swiesner/Developer/Sandbox/package-error/elpa/archives/melpa/archive-contents
DEBUG: URL debugging output:
http -> Contacting host: melpa.milkbox.net:80
http -> Marking connection as busy: melpa.milkbox.net:80 #<process melpa.milkbox.net>
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Request is: 
GET /packages/archive-contents HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: melpa.milkbox.net
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process melpa.milkbox.net>'
http -> url-http-wait-for-headers-change-function ( *http melpa.milkbox.net:80*)
http -> Saw end of headers... ( *http melpa.milkbox.net:80*)
http -> url-http-parse-response called in ( *http melpa.milkbox.net:80*)
http -> Got a content-length, being smart about document end.
http -> Calling initial content-length for extra data at end of headers
http -> Spinning waiting for headers...
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*>)
http -> Calling after change function `url-http-content-length-after-change-function' for `#<process melpa.milkbox.net>'
http -> Marking connection as free: melpa.milkbox.net:80 #<process melpa.milkbox.net>
http -> url-http-parse-headers called in ( *http melpa.milkbox.net:80*)
http -> url-http-parse-response called in ( *http melpa.milkbox.net:80*)
http -> Parsed HTTP headers: class=2 status=200
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: melpa.milkbox.net:80 #<process melpa.milkbox.net>
http -> Activating callback in buffer ( *http melpa.milkbox.net:80*)
retrieval -> Synchronous fetching done (#<buffer  *http melpa.milkbox.net:80*>)
http -> url-http-parse-response called in ( *http melpa.milkbox.net:80*)
http -> Found existing connection: melpa.milkbox.net:80 #<process melpa.milkbox.net>
http -> Reusing existing connection: melpa.milkbox.net:80
http -> Marking connection as busy: melpa.milkbox.net:80 #<process melpa.milkbox.net>
http -> Request is: 
HEAD /packages/archive-contents.sig HTTP/1.1
MIME-Version: 1.0
Connection: keep-alive
Extension: Security/Digest Security/SSL
Host: melpa.milkbox.net
Accept-encoding: gzip
Accept: */*
User-Agent: URL/Emacs

retrieval -> Spinning in url-retrieve-synchronously: nil (#<buffer  *http melpa.milkbox.net:80*-917161>)
http -> Calling after change function `url-http-wait-for-headers-change-function' for `#<process melpa.milkbox.net>'
http -> url-http-wait-for-headers-change-function ( *http melpa.milkbox.net:80*-917161)
http -> Saw end of headers... ( *http melpa.milkbox.net:80*-917161)
http -> url-http-parse-response called in ( *http melpa.milkbox.net:80*-917161)
http -> HEAD request must have headers only ( *http melpa.milkbox.net:80*-917161).
http -> Marking connection as free: melpa.milkbox.net:80 #<process melpa.milkbox.net>
http -> url-http-parse-headers called in ( *http melpa.milkbox.net:80*-917161)
http -> url-http-parse-response called in ( *http melpa.milkbox.net:80*-917161)
http -> Parsed HTTP headers: class=4 status=404
http -> Finished parsing HTTP headers: t
http -> Marking connection as free: melpa.milkbox.net:80 #<process melpa.milkbox.net>
http -> Activating callback in buffer ( *http melpa.milkbox.net:80*-917161)
retrieval -> Synchronous fetching done (#<buffer  *http melpa.milkbox.net:80*-917161>)
http -> Spinning waiting for headers...

DEBUG: Installing dash
Contacting host: melpa.milkbox.net:80
Debugger entered--Lisp error: (wrong-type-argument number-or-marker-p )
  package-handle-response()
  package-install-from-archive([cl-struct-package-desc dash (20131030 2119) "A modern list library for Emacs" nil single "melpa" nil nil nil])
  mapc(package-install-from-archive ([cl-struct-package-desc dash (20131030 2119) "A modern list library for Emacs" nil single "melpa" nil nil nil]))
  package-download-transaction(([cl-struct-package-desc dash (20131030 2119) "A modern list library for Emacs" nil single "melpa" nil nil nil]))
  package-install(dash)
  (unwind-protect (package-install pkg) (print-url-debug) (clear-url-debug))
  package-install-debug(dash)
  (while --dolist-tail-- (setq pkg (car --dolist-tail--)) (package-install-debug pkg) (setq --dolist-tail-- (cdr --dolist-tail--)))
  (let ((--dolist-tail-- (quote (dash s ag solarized-theme magit))) pkg) (while --dolist-tail-- (setq pkg (car --dolist-tail--)) (package-install-debug pkg) (setq --dolist-tail-- (cdr --dolist-tail--))))
  (let ((package-archives (quote (("melpa" . "http://melpa.milkbox.net/packages/"))))) (debug-msg "Refreshing MELPA archive") (package-refresh-contents) (print-url-debug) (clear-url-debug) (let ((--dolist-tail-- (quote (dash s ag solarized-theme magit))) pkg) (while --dolist-tail-- (setq pkg (car --dolist-tail--)) (package-install-debug pkg) (setq --dolist-tail-- (cdr --dolist-tail--)))))
  install-melpa-packages()
  (let ((package-user-dir (expand-file-name "elpa")) (url-debug t) (debug-on-error t)) (if (file-exists-p package-user-dir) (progn (delete-directory package-user-dir (quote recursive)))) (package-initialize) (debug-msg "Installing GNU packages") (install-gnu-packages) (debug-msg "Installing MELPA packages") (install-melpa-packages))
  main()
  command-line-1(("-l" "package-error.el" "-f" "main"))
  command-line()
  normal-top-level()

This error is consistently reproducible on Emacs 24.3.50. See also
https://github.com/milkypostman/melpa/issues/1193 and
https://github.com/cask/cask/issues/153