Store last download status
[tt.git] / tt.rkt
diff --git a/tt.rkt b/tt.rkt
index 9a38136..a40003f 100644 (file)
--- a/tt.rkt
+++ b/tt.rkt
   (U 'old->new
      'new->old))
 
+(define-type Result
+  (∀ (α β) (U (cons 'ok α)
+              (cons 'error β))))
+
 (struct Msg
         ([ts-epoch   : Integer]
          [ts-orig    : String]
          [uri  : Url])
         #:transparent)
 
+(struct Resp
+        ([status-line : String]
+         [headers     : (Listof Bytes)]
+         [body-input  : Input-Port])
+        #:transparent)
+
 (: tt-home-dir Path-String)
 (define tt-home-dir (build-path (expand-user-path "~") ".tt"))
 
 (define str->msg
   (let ([re (pregexp "^([^\\s\t]+)[\\s\t]+(.*)$")])
     (λ (nick uri str)
+       (define str-head (substring str 0 (min 100 (string-length str))))
        (with-handlers*
          ([exn:fail?
             (λ (e)
                (log-error
                  "Failed to parse msg: ~v, from: ~v, at: ~v, because: ~v"
-                 str nick (url->string uri) e)
+                 str-head nick (url->string uri) e)
                #f)])
          (match (regexp-match re str)
            [(list _wholething ts-orig text)
                   (begin
                     (log-error
                       "Msg rejected due to invalid timestamp: ~v, nick:~v, uri:~v"
-                      str nick (url->string uri))
+                      str-head nick (url->string uri))
                     #f)))]
            [_
-             (log-debug "Non-msg line from nick:~v, line:~a" nick str)
+             (log-debug "Non-msg line from nick:~v, line:~a" nick str-head)
              #f])))))
 
 (module+ test
 
 (define url->cache-object-path url->cache-file-path-v2)
 
+(: cache-object-filename->url (-> Path-String Url))
+(define (cache-object-filename->url name)
+  (string->url (uri-decode (path->string name))))
+
 (define (url->cache-etag-path uri)
   (build-path cache-dir "etags" (uri-encode (url->string uri))))
 
     [(list val) val]
     [_           #f]))
 
-(: uri-download (-> Url Void))
-(define (uri-download u)
+(: uri-download-from-port
+   (-> Url (Listof (U Bytes String)) Input-Port
+       (U 'skipped-cached 'downloaded-new))) ; TODO 'ok|'error ?
+(define (uri-download-from-port u headers body-input)
+  (define u-str (url->string u))
+  (log-debug "uri-download-from-port ~v into ~v" u-str cached-object-path)
   (define cached-object-path (url->cache-object-path u))
   (define cached-etag-path (url->cache-etag-path u))
   (define cached-lmod-path (url->cache-lmod-path u))
-  (log-debug "uri-download ~v into ~v" u cached-object-path)
-  (define-values (status-line headers body-input)
-    ; TODO Timeout. Currently hangs on slow connections.
-    (http-sendrecv/url u #:headers (list (format "User-Agent: ~a" user-agent))))
-  (log-debug "headers: ~v" headers)
-  (log-debug "status-line: ~v" status-line)
-  (define status
-    (string->number (second (string-split (bytes->string/utf-8 status-line)))))
-  (log-debug "status: ~v" status)
-  ; TODO Handle redirects
-  (match status
-    [200
-      (let* ([etag      (header-get headers #"ETag")]
-             [lmod      (header-get headers #"Last-Modified")]
-             [lmod-curr (if lmod (rfc2822->epoch lmod) #f)]
-             [lmod-prev (if (file-exists? cached-lmod-path)
-                            (rfc2822->epoch (file->bytes cached-lmod-path))
-                            #f)])
-        (log-debug "lmod-curr:~v lmod-prev:~v" lmod-curr lmod-prev)
-        (unless (or (and etag
-                         (file-exists? cached-etag-path)
-                         (bytes=? etag (file->bytes cached-etag-path))
-                         (begin
-                           (log-info "ETags match, skipping the rest of ~v" (url->string u))
-                           #t))
-                    (and lmod-curr
-                         lmod-prev
-                         (<= lmod-curr lmod-prev)
-                         (begin
-                           (log-info "Last-Modified <= current skipping the rest of ~v" (url->string u))
-                           #t)))
-          (begin
-            (log-info
-              "Downloading the rest of ~v. ETag: ~a, Last-Modified: ~v"
-              (url->string u) etag lmod)
-            (make-parent-directory* cached-object-path)
-            (make-parent-directory* cached-etag-path)
-            (make-parent-directory* cached-lmod-path)
-            (call-with-output-file cached-object-path
-                                   (curry copy-port body-input)
-                                   #:exists 'replace)
-            (when etag
-              (display-to-file etag cached-etag-path #:exists 'replace))
-            (when lmod
-              (display-to-file lmod cached-lmod-path #:exists 'replace))))
-        (close-input-port body-input))]
-    [_
-      (raise status)]))
+  (define etag      (header-get headers #"ETag"))
+  (define lmod      (header-get headers #"Last-Modified"))
+  (define lmod-curr (if lmod (rfc2822->epoch lmod) #f))
+  (define lmod-prev (if (file-exists? cached-lmod-path)
+                        (rfc2822->epoch (file->bytes cached-lmod-path))
+                        #f))
+  (log-debug "lmod-curr:~v lmod-prev:~v" lmod-curr lmod-prev)
+  (define cached?
+    (or (and etag
+             (file-exists? cached-etag-path)
+             (bytes=? etag (file->bytes cached-etag-path))
+             (begin
+               (log-debug "ETags match, skipping the rest of ~v" u-str)
+               #t))
+        (and lmod-curr
+             lmod-prev
+             (<= lmod-curr lmod-prev)
+             (begin
+               (log-debug "Last-Modified <= current skipping the rest of ~v" u-str)
+               #t))))
+  (if (not cached?)
+    (begin
+      (log-debug
+        "Downloading the rest of ~v. ETag: ~a, Last-Modified: ~v"
+        u-str etag lmod)
+      (make-parent-directory* cached-object-path)
+      (make-parent-directory* cached-etag-path)
+      (make-parent-directory* cached-lmod-path)
+      (call-with-output-file cached-object-path
+                             (curry copy-port body-input)
+                             #:exists 'replace)
+      (when etag
+        (display-to-file etag cached-etag-path #:exists 'replace))
+      (when lmod
+        (display-to-file lmod cached-lmod-path #:exists 'replace))
+      'downloaded-new)
+    'skipped-cached))
+
+(: uri-download
+   (-> Positive-Float Url
+       (Result (U 'skipped-cached 'downloaded-new)
+               Any))) ; TODO Maybe more-precise error type?
+(define (uri-download timeout u)
+  (define u-str (url->string u))
+  (define timeout-chan (make-channel))
+  (define result-chan (make-channel))
+  (define timeout-thread
+    (thread (λ ()
+               ; Doing this instead of sync/timeout to distinguish error values,
+               ; rather than just have #f to work with.
+               (sleep timeout)
+               (channel-put timeout-chan '(error . timeout)))))
+  (define result-thread
+    (thread (λ ()
+               ; XXX We timeout getting a response, but body download could
+               ; also take a long time and we might want to time that out as
+               ; well, but then we may end-up with partially downloaded
+               ; objects. But that could happen anyway if the server drops the
+               ; connection for whatever reason.
+               ;
+               ; Maybe that is OK once we start treating the
+               ; downloaded object as an addition to the stored set of
+               ; messages, rather than the final set of messages.
+
+               ; TODO message db
+               ; - 1st try can just be an in-memory set that gets written-to
+               ;   and read-from disk as a whole.
+               (define result
+                 (with-handlers
+                   ; TODO Maybe name each known errno? (exn:fail:network:errno-errno e)
+                   ([exn:fail:network?
+                      (λ (e) `(error . (net-error . ,e)))]
+                    [exn?
+                      (λ (e) `(error . (other . ,e)))])
+                   (define-values (status-line headers body-input)
+                     (http-sendrecv/url
+                       u
+                       #:headers (list (format "User-Agent: ~a" user-agent))))
+                   `(ok . ,(Resp status-line headers body-input))))
+               (channel-put result-chan result))))
+  (define result
+    (sync timeout-chan
+          result-chan))
+  (kill-thread result-thread)
+  (kill-thread timeout-thread)
+  (match result
+    [(cons 'error _)
+     result]
+    [(cons 'ok (Resp status-line headers body-input))
+     (log-debug "headers: ~v" headers)
+     (log-debug "status-line: ~v" status-line)
+     (define status
+       (string->number (second (string-split (bytes->string/utf-8 status-line)))))
+     (log-debug "status: ~v" status)
+     ; TODO Handle redirects. Should be within same timeout as req and body.
+     (let ([result
+             (match status
+               [200
+                 `(ok . ,(uri-download-from-port u headers body-input))]
+               [_
+                 `(error . (http . ,status))])])
+       (close-input-port body-input)
+       result)]))
 
 (: timeline-print (-> Out-Format (Listof Msg) Void))
 (define (timeline-print out-format timeline)
   (log-info "Reading peer nick:~v uri:~v" nick (url->string uri))
   (str->msgs nick uri (uri-read-cached uri)))
 
-(: peer-download (-> Peer Void))
-(define (peer-download f)
-  (match-define (Peer nick uri) f)
+(: peer-download
+   (-> Positive-Float Peer
+       (Result (U 'skipped-cached 'downloaded-new)
+               Any)))
+(define (peer-download timeout peer)
+  (match-define (Peer nick uri) peer)
   (define u (url->string uri))
-  (log-info "Downloading peer uri:~a" u)
-  (with-handlers
-    ([exn:fail?
-       (λ (e)
-          (log-error "Network error nick:~v uri:~v  exn:~v" nick u e)
-          #f)]
-     [integer?
-       (λ (status)
-          (log-error "HTTP error nick:~v uri:~a  status:~a" nick u status)
-          #f)])
-    (define-values (_result _tm-cpu-ms tm-real-ms _tm-gc-ms)
-      (time-apply uri-download (list uri)))
-    (log-info "Peer downloaded in ~a seconds, uri: ~a" (/ tm-real-ms 1000.0) u)))
-
-(: timeline-download (-> Integer (Listof Peer) Void))
-(define (timeline-download num-workers peers)
-  ; TODO No need for map - can just iter
-  (void (concurrent-filter-map num-workers peer-download peers)))
+  (log-info "Download BEGIN URL:~a" u)
+  (define-values (results _tm-cpu-ms tm-real-ms _tm-gc-ms)
+    (time-apply uri-download (list timeout uri)))
+  (define result (car results))
+  (log-info "Download END in ~a seconds, URL:~a, result:~s"
+            (/ tm-real-ms 1000.0)
+            u
+            result)
+  result)
+
+(: timeline-download (-> Integer Positive-Float (Listof Peer) Void))
+(define (timeline-download num-workers timeout peers)
+  (define results
+    (concurrent-filter-map num-workers
+                           (λ (p) (cons p (peer-download timeout p)))
+                           peers))
+  (define ok? (match-lambda
+                [(cons _ (cons 'ok _)) #t]
+                [(cons _ (cons 'error _)) #f]))
+  (define (err? r) (not (ok? r)))
+  (define peers-ok (map car (filter ok? results)))
+  (define peers-err (map car (filter err? results)))
+  (peers->file peers-ok (build-path tt-home-dir "peers-last-downloaded-ok"))
+  ; TODO Append error as a comment: <nick> <uri> # <error>
+  ; TODO Support inline/trailing comments in peer files
+  (peers->file peers-err (build-path tt-home-dir "peers-last-downloaded-err")))
 
 (: uniq (∀ (α) (-> (Listof α) (Listof α))))
 (define (uniq xs)
     (log-info "Read-in ~a peers." (length peers))
     (uniq peers)))
 
+(: mentioned-peers-in-cache (-> (Listof Peer)))
+(define (mentioned-peers-in-cache)
+  (define msgs
+    (append* (map (λ (filename)
+                     (define path (build-path cache-object-dir filename))
+                     (define size (/ (file-size path) 1000000.0))
+                     (log-info "BEGIN parsing ~a MB from file: ~v"
+                               size
+                               (path->string path))
+                     (define t0 (current-inexact-milliseconds))
+                     (define m (filter-map
+                                 (λ (line)
+                                    (str->msg #f (cache-object-filename->url filename) line))
+                                 (filter-comments
+                                   (file->lines path))))
+                     (define t1 (current-inexact-milliseconds))
+                     (log-info "END parsing ~a MB in ~a seconds from file: ~v."
+                               size
+                               (* 0.001 (- t1 t0))
+                               (path->string path))
+                     (when (empty? m)
+                       (log-warning "No messages found in ~a" (path->string path)))
+                     m)
+                  (directory-list cache-object-dir))))
+  (uniq (append* (map Msg-mentions msgs))))
+
 (: log-writer-stop (-> Thread Void))
 (define (log-writer-stop log-writer)
   (log-message (current-logger) 'fatal 'stop "Exiting." #f)
         [(or "d" "download")
          ; Initially, 15 was fastest out of the tried: 1, 5, 10, 20.  Then I
          ; started noticing significant slowdowns. Reducing to 5 seems to help.
-         (let ([num-workers 5])
+         (let ([num-workers 5]
+               [timeout     10.0])
            (command-line
              #:program
              "tt download"
              [("-j" "--jobs")
               njobs "Number of concurrent jobs."
               (set! num-workers (string->number njobs))]
+             [("-t" "--timeout")
+              seconds "Timeout seconds per request."
+              (set! timeout (string->number seconds))]
              #:args file-paths
              (let ([peers (paths->peers file-paths)])
                (define-values (_res _cpu real-ms _gc)
-                 (time-apply timeline-download (list num-workers peers)))
+                 (time-apply timeline-download (list num-workers timeout peers)))
                (log-info "Downloaded timelines from ~a peers in ~a seconds."
                          (length peers)
                          (/ real-ms 1000.0)))))]
          (command-line
            #:program
            "tt crawl"
-           #:args file-paths
+           #:args ()
            (let* ([peers-sort
                     (λ (peers) (sort peers (match-lambda**
                                              [((Peer n1 _) (Peer n2 _))
                     (build-path tt-home-dir "peers-all")]
                   [peers-mentioned-file
                     (build-path tt-home-dir "peers-mentioned")]
-                  [peers
-                    (paths->peers
-                      (match file-paths
-                        ; TODO Refactor such that path->string not needed
-                        ['() (list (path->string peers-all-file))]
-                        [_   file-paths]))]
-                  [timeline
-                    (peers->timeline peers)]
                   [peers-mentioned-curr
-                    (uniq (append* (map Msg-mentions timeline)))]
+                    (mentioned-peers-in-cache)]
                   [peers-mentioned-prev
                     (file->peers peers-mentioned-file)]
                   [peers-mentioned
                   [peers-all-prev
                     (file->peers peers-all-file)]
                   [peers-all
-                    (list->set (append peers
-                                       peers-mentioned
+                    (list->set (append peers-mentioned
                                        peers-all-prev))]
-                  [n-peers-discovered
-                    (set-count (set-subtract peers-all
-                                             (list->set peers-all-prev)))]
+                  [peers-discovered
+                    (set-subtract peers-all (list->set peers-all-prev))]
                   [peers-all
                     (peers-sort (set->list peers-all))])
-             (log-info "Discovered ~a new peers." n-peers-discovered)
+             (log-info "Known peers mentioned: ~a" (length peers-mentioned))
+             (log-info "Known peers total: ~a" (length peers-all))
+             (log-info "Discovered ~a new peers:~n~a"
+                       (set-count peers-discovered)
+                       (pretty-format (map
+                                        (λ (p) (cons (Peer-nick p)
+                                                     (url->string (Peer-uri p))))
+                                        (set->list peers-discovered))))
              (peers->file peers-mentioned
                           peers-mentioned-file)
              (peers->file peers-all
This page took 0.042865 seconds and 4 git commands to generate.