Skip to content
This repository has been archived by the owner on Feb 12, 2024. It is now read-only.

Flaky gc test #2999

Closed
achingbrain opened this issue Apr 23, 2020 · 4 comments · Fixed by #3008
Closed

Flaky gc test #2999

achingbrain opened this issue Apr 23, 2020 · 4 comments · Fixed by #3008

Comments

@achingbrain
Copy link
Member

Fails in CI on windows sometimes:

ipfs:     .repo.gc
ipfs:       1) should clean up indirectly pinned data after recursive pin removal
ipfs:   1109 passing (18m)
ipfs:   69 pending
ipfs:   1 failing
ipfs:   1) interface-ipfs-core over ipfs-http-client tests
ipfs:        .repo.gc
ipfs:          should clean up indirectly pinned data after recursive pin removal:
ipfs:      AssertionError: expected [ Array(19) ] to not include 'QmYUY5XnbdTH914VW6dfGSvuyMuBXdjaHk2aUKNWQxMMNQ'
ipfs:       at Context.it (C:\Users\travis\build\ipfs\js-ipfs\packages\interface-ipfs-core\src\repo\gc.js:58:377)
ipfs:       at process._tickCallback (internal/process/next_tick.js:68:7)
ipfs:
@achingbrain
Copy link
Member Author

Could be that TSize here should be Tsize: https://github.com/ipfs/js-ipfs/blob/master/packages/interface-ipfs-core/src/repo/gc.js#L183

@achingbrain
Copy link
Member Author

Over http to go-ipfs:

  interface-ipfs-core tests
    .repo.gc
2020-04-27T17:43:29.473Z ipfsd-ctl:daemon:stdout initializing IPFS node at C:\Users\alex\AppData\Local\Temp\go_ipfs_V8bdl8I5cb2u60M8B5gdp
generating 1024-bit RSA keypair...done
peer identity: QmV6rMbYE7712aQxAERMYdZ11bsxrYdcno7dTVKkLkdKkp
to get started, enter:

        ipfs cat /ipfs/QmS4ustL54uo8FzR9455qaxZwuMiUhyvMcX9Ba8nUH4uVv/readme

2020-04-27T17:43:29.473Z ipfsd-ctl:daemon:stderr
2020-04-27T17:43:29.712Z ipfsd-ctl:utils Unable to open api file
2020-04-27T17:43:29.837Z ipfsd-ctl:daemon:stdout Initializing daemon...
go-ipfs version: 0.4.23-
Repo version: 7
System version: amd64/windows
Golang version: go1.13.7

2020-04-27T17:43:29.910Z ipfsd-ctl:daemon:stdout Swarm listening on /ip4/127.0.0.1/tcp/51970

2020-04-27T17:43:29.910Z ipfsd-ctl:daemon:stdout Swarm listening on /p2p-circuit

2020-04-27T17:43:29.920Z ipfsd-ctl:daemon:stdout Swarm announcing /ip4/127.0.0.1/tcp/51970

2020-04-27T17:43:29.920Z ipfsd-ctl:daemon:stdout API server listening on /ip4/127.0.0.1/tcp/51971

2020-04-27T17:43:29.953Z ipfsd-ctl:daemon:stdout WebUI: http://127.0.0.1:51971/webui

2020-04-27T17:43:29.989Z ipfsd-ctl:daemon:stdout Gateway (readonly) server listening on /ip4/127.0.0.1/tcp/51972

2020-04-27T17:43:30.026Z ipfsd-ctl:daemon:stdout Daemon is ready

(node:6316) ExperimentalWarning: Readable[Symbol.asyncIterator] is an experimental feature. This feature could change at any time
      √ should run garbage collection (104ms)
      √ should clean up unpinned data (139ms)
      √ should clean up removed MFS files (124ms)
      √ should clean up block only after unpinned and removed from MFS (185ms)
2020-04-27T17:43:30.814Z ipfsd-ctl:daemon:stderr 18:43:30.814 ERROR blockstore: blockstore.AllKeysChan got err: walk failed: open C:\Users\alex\AppData\Local\Temp\go_ipfs_V8bdl8I5cb2u60M8B5gdp\blocks\du-195716584: The process cannot access the file because it is being used by another process. blockstore.go:222

      1) should clean up indirectly pinned data after recursive pin removal


  4 passing (2s)
  1 failing

  1) interface-ipfs-core tests
       .repo.gc
         should clean up indirectly pinned data after recursive pin removal:
     AssertionError: expected [ Array(4) ] to include 'QmYUY5XnbdTH914VW6dfGSvuyMuBXdjaHk2aUKNWQxMMNQ'
      at Context.it (C:\Users\alex\Documents\Workspaces\ipfs\js-ipfs\packages\interface-ipfs-core\src\repo\gc.js:215:43)
      at process._tickCallback (internal/process/next_tick.js:68:7)

@achingbrain
Copy link
Member Author

achingbrain commented Apr 27, 2020 •
edited
Loading

Over http to js-ipfs (similar error though much less frequent):

> [email protected] test:interface:http C:\Users\alex\Documents\Workspaces\ipfs\js-ipfs\packages\ipfs
> cross-env ECHO_SERVER_PORT=37489 aegir test -f test/http-api/interface.js "-t" "node"

Test Node.js


  interface-ipfs-core over ipfs-http-client tests
    .repo.gc
2020-04-27T18:28:09.627Z ipfsd-ctl:daemon:stdout initializing ipfs node at C:\Users\alex\AppData\Local\Temp\js_ipfs_-NxRskDdzvESV3bkN2iEX
generating 1024-bit RSA keypair...
to get started, enter:

        jsipfs cat /ipfs/QmfGBRT6BbWJd7yUc2uYdaUZJBbnEFvTqehPFoSMQ6wgdr/readme

2020-04-27T18:28:09.627Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:08.205Z ipfs:components:init applying profile test
2020-04-27T18:28:08.205Z ipfs:components:init repo exists? false
2020-04-27T18:28:09.158Z ipfs:components:init identity generated
2020-04-27T18:28:09.158Z ipfs:components:init peer identity: QmSBDLTKjji7rrap3sqqX8AJmVusYeAn7tWBneQjH6biSb
2020-04-27T18:28:09.314Z ipfs:components:init repo opened
2020-04-27T18:28:09.314Z ipfs:components:init peer created
2020-04-27T18:28:09.314Z ipfs:preload preload disabled
2020-04-27T18:28:09.314Z ipfs:components:init adding default assets
(node:2072) ExperimentalWarning: Readable[Symbol.asyncIterator] is an experimental feature. This feature could change at any time
2020-04-27T18:28:09.564Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY
2020-04-27T18:28:09.564Z ipfs:components:init initializing IPNS keyspace
2020-04-27T18:28:09.595Z ipfs:ipns:publisher:error NotFoundError: Key not found in database [/F5UXA3TTF4JCAOID2SVMILPLOA4WZSBJSJ2LD456KQZ2TIVK3XJNDXZSLOSD6BBQ]
    at C:\Users\alex\Documents\Workspaces\ipfs\js-ipfs\node_modules\levelup\lib\levelup.js:188:15
    at C:\Users\alex\Documents\Workspaces\ipfs\js-ipfs\node_modules\encoding-down\index.js:75:21
2020-04-27T18:28:09.595Z ipfs:ipns:publisher ipns record for /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn was stored in the datastore
2020-04-27T18:28:09.595Z ipfs:ipns:publisher ipns record for L2lwbnMvEiA5A9SqxC3rcDlsyCmSdLHzvlQzqaKq3dLR3zJbpD8EMA== was stored in the routing
2020-04-27T18:28:09.611Z ipfs:ipns:publisher public key for L3BrLxIgOQPUqsQt63A5bMgpknSx875UM6miqt3S0d8yW6Q/BDA= was stored in the routing
2020-04-27T18:28:09.611Z ipfs:ipns IPNS value /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn was published correctly
2020-04-27T18:28:09.611Z ipfs:ipns IPNS value /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn was cached correctly
2020-04-27T18:28:09.627Z ipfsd-ctl:utils Unable to open api file
2020-04-27T18:28:11.112Z ipfsd-ctl:daemon:stdout Initializing IPFS daemon...

2020-04-27T18:28:11.112Z ipfsd-ctl:daemon:stdout js-ipfs version: 0.43.0

2020-04-27T18:28:11.112Z ipfsd-ctl:daemon:stdout System version: x64/win32
Node.js version: 10.16.3

2020-04-27T18:28:11.893Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:11.893Z ipfs:daemon starting

2020-04-27T18:28:12.018Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:12.018Z ipfs:components:init keychain constructed

2020-04-27T18:28:12.412Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:12.412Z ipfs:components:init Creating "self" key

2020-04-27T18:28:13.393Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.393Z ipfs:components:init peer created

2020-04-27T18:28:13.393Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.393Z ipfs:preload preload disabled

2020-04-27T18:28:13.471Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.471Z ipfs:pin Loaded pins from the datastore

2020-04-27T18:28:13.675Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.674Z ipfs:daemon failed to load optional electron-webrtc dependency

2020-04-27T18:28:13.690Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.689Z ipfs:daemon Using wrtc for webrtc support

2020-04-27T18:28:13.799Z ipfsd-ctl:daemon:stdout Swarm listening on /ip4/127.0.0.1/tcp/53309/p2p/QmSBDLTKjji7rrap3sqqX8AJmVusYeAn7tWBneQjH6biSb

2020-04-27T18:28:13.799Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.799Z ipfs:mfs-preload MFS preload disabled

2020-04-27T18:28:13.799Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:13.799Z ipfs:http-api starting

2020-04-27T18:28:15.205Z ipfsd-ctl:daemon:stdout [1588012095205] INFO  (7136 on ALEXPD16E): server started
    created: 1588012093814
    started: 1588012095205
    host: "127.0.0.1"
    port: 53310
    protocol: "http"
    id: "ALEXPD16E:7136:k9itedme"
    uri: "http://127.0.0.1:53310"
    address: "127.0.0.1"

2020-04-27T18:28:15.252Z ipfsd-ctl:daemon:stdout [1588012095252] INFO  (7136 on ALEXPD16E): server started
    created: 1588012095221
    started: 1588012095252
    host: "127.0.0.1"
    port: 53311
    protocol: "http"
    id: "ALEXPD16E:7136:k9iteeph"
    uri: "http://127.0.0.1:53311"
    address: "127.0.0.1"

2020-04-27T18:28:15.252Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:15.252Z ipfs:http-api started

2020-04-27T18:28:15.331Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:15.331Z ipfs:daemon started

2020-04-27T18:28:15.331Z ipfsd-ctl:daemon:stdout API listening on /ip4/127.0.0.1/tcp/53310/http

2020-04-27T18:28:15.613Z ipfsd-ctl:daemon:stdout Gateway (read only) listening on /ip4/127.0.0.1/tcp/53311/http
Web UI available at http://127.0.0.1:53310/webui
Daemon is ready

2020-04-27T18:28:15.846Z ipfsd-ctl:daemon:stdout [1588012095830] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012095799:ALEXPD16E:7136:k9itedme:10000",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/id",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53312
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 443
      }
    }
    responseTime: 31

2020-04-27T18:28:15.893Z ipfsd-ctl:daemon:stderr (node:7136) ExperimentalWarning: Readable[Symbol.asyncIterator] is an experimental feature. This feature could change at any time

2020-04-27T18:28:16.065Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.064Z ipfs:pin Flushed pins with root: Qmad2ahwDvT77P5BuqfNKZjcBTsbXoHmhJ6N39icgDvcvf

(node:4372) ExperimentalWarning: Readable[Symbol.asyncIterator] is an experimental feature. This feature could change at any time
2020-04-27T18:28:16.080Z ipfsd-ctl:daemon:stdout [1588012096080] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012095846:ALEXPD16E:7136:k9itedme:10001",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/add?stream-channels=true&progress=false",
      "headers": {
        "content-type": "multipart/form-data; boundary=-----------------------------emCfFFE5KPcCAKWAdCEfs",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53313
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "connection": "close"
      }
    }
    responseTime: 234

2020-04-27T18:28:16.128Z ipfsd-ctl:daemon:stdout [1588012096111] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096080:ALEXPD16E:7136:k9itedme:10002",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/ls?stream=true",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53314
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 31

2020-04-27T18:28:16.206Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.205Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY

2020-04-27T18:28:16.206Z ipfsd-ctl:daemon:stdout [1588012096205] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096127:ALEXPD16E:7136:k9itedme:10003",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/rm?arg=QmbDBAiMnfKAdrbTzyiUxXjZH58ZBHpBtZ9WuT9CdtHRBD",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53315
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 59
      }
    }
    responseTime: 78

2020-04-27T18:28:16.221Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.221Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:16.221Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.221Z ipfs:repo:gc No blocks in MFS

2020-04-27T18:28:16.300Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.299Z ipfs:repo:gc Marked set has 15 unique blocks. Blockstore has 19 blocks. Deleted 4 blocks.
2020-04-27T18:28:16.299Z ipfs:repo:gc Complete (78ms)

2020-04-27T18:28:16.300Z ipfsd-ctl:daemon:stdout [1588012096299] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096205:ALEXPD16E:7136:k9itedme:10004",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53316
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 94

      √ should run garbage collection (469ms)
2020-04-27T18:28:16.315Z ipfsd-ctl:daemon:stdout [1588012096314] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096299:ALEXPD16E:7136:k9itedme:10005",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/ls?stream=true",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53317
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 15

2020-04-27T18:28:16.330Z ipfsd-ctl:daemon:stdout [1588012096330] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096314:ALEXPD16E:7136:k9itedme:10006",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53318
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:16.362Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.361Z ipfs:pin Flushed pins with root: Qmad2ahwDvT77P5BuqfNKZjcBTsbXoHmhJ6N39icgDvcvf

2020-04-27T18:28:16.377Z ipfsd-ctl:daemon:stdout [1588012096361] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096330:ALEXPD16E:7136:k9itedme:10007",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/add?stream-channels=true&progress=false",
      "headers": {
        "content-type": "multipart/form-data; boundary=-----------------------------PwjyyisdRHawbOwGb7YMW",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53319
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "connection": "close"
      }
    }
    responseTime: 31

2020-04-27T18:28:16.409Z ipfsd-ctl:daemon:stdout [1588012096408] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096377:ALEXPD16E:7136:k9itedme:10008",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53320
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 31

2020-04-27T18:28:16.409Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.408Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:16.409Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.408Z ipfs:repo:gc No blocks in MFS

2020-04-27T18:28:16.534Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.533Z ipfs:repo:gc Marked set has 16 unique blocks. Blockstore has 18 blocks. Deleted 2 blocks.
2020-04-27T18:28:16.533Z ipfs:repo:gc Complete (125ms)

2020-04-27T18:28:16.534Z ipfsd-ctl:daemon:stdout [1588012096533] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096408:ALEXPD16E:7136:k9itedme:10009",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53321
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 125

2020-04-27T18:28:16.549Z ipfsd-ctl:daemon:stdout [1588012096549] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096533:ALEXPD16E:7136:k9itedme:10010",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53322
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:16.691Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.690Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY

2020-04-27T18:28:16.691Z ipfsd-ctl:daemon:stdout [1588012096690] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096549:ALEXPD16E:7136:k9itedme:10011",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/rm?arg=QmbDBAiMnfKAdrbTzyiUxXjZH58ZBHpBtZ9WuT9CdtHRBD",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53323
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 59
      }
    }
    responseTime: 141

2020-04-27T18:28:16.691Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.690Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:16.705Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.705Z ipfs:repo:gc No blocks in MFS

      √ should clean up unpinned data (469ms)
2020-04-27T18:28:16.799Z ipfsd-ctl:daemon:stdout [1588012096799] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096768:ALEXPD16E:7136:k9itedme:10013",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53325
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 31

2020-04-27T18:28:16.799Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.799Z ipfs:repo:gc Marked set has 15 unique blocks. Blockstore has 18 blocks. Deleted 3 blocks.
2020-04-27T18:28:16.799Z ipfs:repo:gc Complete (109ms)

2020-04-27T18:28:16.799Z ipfsd-ctl:daemon:stdout [1588012096799] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096690:ALEXPD16E:7136:k9itedme:10012",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53324
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 109

2020-04-27T18:28:16.831Z ipfsd-ctl:daemon:stdout [1588012096814] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096799:ALEXPD16E:7136:k9itedme:10014",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53326
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 15

2020-04-27T18:28:16.831Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.830Z ipfs:mfs:write Reading source, destination and parent
2020-04-27T18:28:16.830Z ipfs:mfs:utils:to-async-iterator Content was an async iterator

2020-04-27T18:28:16.831Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.830Z ipfs:mfs:utils:with-mfs-root Creating new MFS root

2020-04-27T18:28:16.846Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.846Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:16.846Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.846Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:16.846Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.846Z ipfs:mfs:write Read source, destination and parent

2020-04-27T18:28:16.846Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.846Z ipfs:mfs:write Writing file offset 0 length Infinity

2020-04-27T18:28:16.877Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.877Z ipfs:mfs:write Wrote QmarTtAABKrjrHMbif1n3hKbaK39g84Nah4F7msPFbPP92

2020-04-27T18:28:16.877Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.877Z ipfs:mfs:stat Fetching stats for /

2020-04-27T18:28:16.877Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.877Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:16.877Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.877Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:16.877Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.877Z ipfs:mfs:utils:to-trail Creating trail for path /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn/

2020-04-27T18:28:16.877Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.877Z ipfs:mfs:core:utils:add-link Adding test (QmarTtAABKrjrHMbif1n3hKbaK39g84Nah4F7msPFbPP92) to regular directory

2020-04-27T18:28:16.893Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.893Z ipfs:mfs:utils:update-tree Trail [ { name: 'QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn',
    cid: CID(QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB),
    size: 4,
    type: 'directory' } ]

2020-04-27T18:28:16.893Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.893Z ipfs:mfs:utils:update-tree Final CID QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB

2020-04-27T18:28:16.893Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.893Z ipfs:mfs:utils:update-mfs-root New MFS root will be QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB

2020-04-27T18:28:16.909Z ipfsd-ctl:daemon:stdout [1588012096908] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096830:ALEXPD16E:7136:k9itedme:10015",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/files/write?stream-channels=true&create=true&arg=%2Ftest",
      "headers": {
        "content-type": "multipart/form-data; boundary=-----------------------------OVGy15y5DfYyo1T8lM8-b",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53327
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 0
      }
    }
    responseTime: 78

2020-04-27T18:28:16.909Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.908Z ipfs:mfs:stat Fetching stats for /test

2020-04-27T18:28:16.909Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.908Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB

2020-04-27T18:28:16.909Z ipfsd-ctl:daemon:stdout [1588012096908] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096908:ALEXPD16E:7136:k9itedme:10016",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/files/stat?arg=%2Ftest",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53328
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 146
      }
    }
    responseTime: 0

2020-04-27T18:28:16.940Z ipfsd-ctl:daemon:stdout [1588012096939] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096908:ALEXPD16E:7136:k9itedme:10017",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53329
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 31

2020-04-27T18:28:16.940Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:16.939Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:17.002Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.002Z ipfs:repo:gc Marked set has 18 unique blocks. Blockstore has 19 blocks. Deleted 1 blocks.

2020-04-27T18:28:17.002Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.002Z ipfs:repo:gc Complete (63ms)

2020-04-27T18:28:17.002Z ipfsd-ctl:daemon:stdout [1588012097002] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012096939:ALEXPD16E:7136:k9itedme:10018",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53330
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 63

2020-04-27T18:28:17.018Z ipfsd-ctl:daemon:stdout [1588012097018] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097002:ALEXPD16E:7136:k9itedme:10019",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53331
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:17.034Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.033Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB

2020-04-27T18:28:17.034Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.033Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB

2020-04-27T18:28:17.049Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.049Z ipfs:mfs:utils:to-trail Creating trail for path /ipfs/QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB/test

2020-04-27T18:28:17.049Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.049Z ipfs:mfs:core:utils:remove-link Loading parent node QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB

2020-04-27T18:28:17.065Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.049Z ipfs:mfs:core:utils:remove-link Removing link test regular directory

2020-04-27T18:28:17.082Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.064Z ipfs:mfs:core:utils:remove-link Updated regular directory QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn
2020-04-27T18:28:17.064Z ipfs:mfs:utils:update-tree Trail [ { name: 'QmSxnLJMK9W2BQxKg6hx676ByL2JK8mu7qkJTBzE5KEwYB',
    cid: CID(QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn),
    size: 115,
    type: 'directory' } ]
2020-04-27T18:28:17.064Z ipfs:mfs:utils:update-tree Final CID QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn
2020-04-27T18:28:17.064Z ipfs:mfs:utils:update-mfs-root New MFS root will be QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:17.097Z ipfsd-ctl:daemon:stdout [1588012097096] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097033:ALEXPD16E:7136:k9itedme:10020",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/files/rm?arg=%2Ftest",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53332
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 0
      }
    }
    responseTime: 63

2020-04-27T18:28:17.114Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.113Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:17.221Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.221Z ipfs:repo:gc Marked set has 16 unique blocks. Blockstore has 19 blocks. Deleted 3 blocks.
2020-04-27T18:28:17.221Z ipfs:repo:gc Complete (108ms)

2020-04-27T18:28:17.221Z ipfsd-ctl:daemon:stdout [1588012097221] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097113:ALEXPD16E:7136:k9itedme:10021",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53333
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 108

      √ should clean up removed MFS files (453ms)
2020-04-27T18:28:17.237Z ipfsd-ctl:daemon:stdout [1588012097237] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097221:ALEXPD16E:7136:k9itedme:10022",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53334
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:17.252Z ipfsd-ctl:daemon:stdout [1588012097252] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097237:ALEXPD16E:7136:k9itedme:10023",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53335
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 15

2020-04-27T18:28:17.252Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.252Z ipfs:mfs:write Reading source, destination and parent
2020-04-27T18:28:17.252Z ipfs:mfs:utils:to-async-iterator Content was an async iterator

2020-04-27T18:28:17.252Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.252Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:17.252Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.252Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:17.252Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.252Z ipfs:mfs:write Read source, destination and parent
2020-04-27T18:28:17.252Z ipfs:mfs:write Writing file offset 0 length Infinity

2020-04-27T18:28:17.284Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.268Z ipfs:mfs:write Wrote Qmcb56BGVoVshkuKHrWniD6G2bP6RaEsfdfbgUqD86gDwA

2020-04-27T18:28:17.284Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.283Z ipfs:mfs:stat Fetching stats for /

2020-04-27T18:28:17.284Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.283Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:17.284Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.283Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:17.284Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.283Z ipfs:mfs:utils:to-trail Creating trail for path /ipfs/QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn/

2020-04-27T18:28:17.299Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.299Z ipfs:mfs:core:utils:add-link Adding test (Qmcb56BGVoVshkuKHrWniD6G2bP6RaEsfdfbgUqD86gDwA) to regular directory

2020-04-27T18:28:17.315Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.299Z ipfs:mfs:utils:update-tree Trail [ { name: 'QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn',
    cid: CID(QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk),
    size: 4,
    type: 'directory' } ]

2020-04-27T18:28:17.315Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.314Z ipfs:mfs:utils:update-tree Final CID QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk

2020-04-27T18:28:17.315Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.314Z ipfs:mfs:utils:update-mfs-root New MFS root will be QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk

2020-04-27T18:28:17.315Z ipfsd-ctl:daemon:stdout [1588012097314] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097252:ALEXPD16E:7136:k9itedme:10024",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/files/write?stream-channels=true&create=true&arg=%2Ftest",
      "headers": {
        "content-type": "multipart/form-data; boundary=-----------------------------LiGL9Kwe-HGo6lqZ7nncV",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53336
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 0
      }
    }
    responseTime: 62

2020-04-27T18:28:17.315Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.314Z ipfs:mfs:stat Fetching stats for /test

2020-04-27T18:28:17.331Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.314Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk

2020-04-27T18:28:17.346Z ipfsd-ctl:daemon:stdout [1588012097346] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097314:ALEXPD16E:7136:k9itedme:10025",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/files/stat?arg=%2Ftest",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53337
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 146
      }
    }
    responseTime: 32

2020-04-27T18:28:17.378Z ipfsd-ctl:daemon:stdout [1588012097346] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097346:ALEXPD16E:7136:k9itedme:10026",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/block/get?arg=Qmcb56BGVoVshkuKHrWniD6G2bP6RaEsfdfbgUqD86gDwA",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53338
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-stream-output": "1",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/octet-stream",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 50
      }
    }
    responseTime: 0

2020-04-27T18:28:17.534Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.533Z ipfs:pin Flushed pins with root: QmfC71Ec22VMp1xa8owm4j5f6ZUkbXX9LZmDaNq6MTE2xa

2020-04-27T18:28:17.534Z ipfsd-ctl:daemon:stdout [1588012097533] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097378:ALEXPD16E:7136:k9itedme:10027",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/add?stream-channels=true&progress=false",
      "headers": {
        "content-type": "multipart/form-data; boundary=------------------------------qqApDKnjvA561FSjAPDL",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53339
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "connection": "close"
      }
    }
    responseTime: 155

2020-04-27T18:28:17.679Z ipfsd-ctl:daemon:stdout [1588012097679] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097533:ALEXPD16E:7136:k9itedme:10028",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53340
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 146

2020-04-27T18:28:17.691Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.679Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:17.784Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.783Z ipfs:repo:gc Marked set has 19 unique blocks. Blockstore has 22 blocks. Deleted 3 blocks.
2020-04-27T18:28:17.783Z ipfs:repo:gc Complete (104ms)

2020-04-27T18:28:17.784Z ipfsd-ctl:daemon:stdout [1588012097783] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097679:ALEXPD16E:7136:k9itedme:10029",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53341
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 104

2020-04-27T18:28:17.799Z ipfsd-ctl:daemon:stdout [1588012097799] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097783:ALEXPD16E:7136:k9itedme:10030",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53342
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:17.799Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.799Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk

2020-04-27T18:28:17.799Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.799Z ipfs:mfs:utils:with-mfs-root Loaded MFS root /ipfs/QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk

2020-04-27T18:28:17.815Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.814Z ipfs:mfs:utils:to-trail Creating trail for path /ipfs/QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk/test

2020-04-27T18:28:17.815Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.814Z ipfs:mfs:core:utils:remove-link Loading parent node QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk

2020-04-27T18:28:17.815Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.814Z ipfs:mfs:core:utils:remove-link Removing link test regular directory

2020-04-27T18:28:17.815Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.814Z ipfs:mfs:core:utils:remove-link Updated regular directory QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn
2020-04-27T18:28:17.814Z ipfs:mfs:utils:update-tree Trail [ { name: 'QmeEvt9Sw8cZunnHFPKzK3vuj2GuZsoSTzofwdidsUw8Wk',
    cid: CID(QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn),
    size: 115,
    type: 'directory' } ]

2020-04-27T18:28:17.815Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.814Z ipfs:mfs:utils:update-tree Final CID QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn
2020-04-27T18:28:17.814Z ipfs:mfs:utils:update-mfs-root New MFS root will be QmUNLLsPACCz1vLxQVkXqqLX5R1X345qqfHbsf67hvA3Nn

2020-04-27T18:28:17.830Z ipfsd-ctl:daemon:stdout [1588012097830] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097799:ALEXPD16E:7136:k9itedme:10031",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/files/rm?arg=%2Ftest",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53343
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 0
      }
    }
    responseTime: 31

2020-04-27T18:28:17.830Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.830Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:17.893Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.893Z ipfs:repo:gc Marked set has 17 unique blocks. Blockstore has 20 blocks. Deleted 3 blocks.
2020-04-27T18:28:17.893Z ipfs:repo:gc Complete (63ms)

2020-04-27T18:28:17.893Z ipfsd-ctl:daemon:stdout [1588012097893] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097830:ALEXPD16E:7136:k9itedme:10032",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53344
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 63

2020-04-27T18:28:17.909Z ipfsd-ctl:daemon:stdout [1588012097908] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097893:ALEXPD16E:7136:k9itedme:10033",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53345
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 15

2020-04-27T18:28:17.940Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.939Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY

2020-04-27T18:28:17.940Z ipfsd-ctl:daemon:stdout [1588012097939] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097908:ALEXPD16E:7136:k9itedme:10034",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/rm?arg=Qmd5KU9SLXMQXjVX2fvCMBqBf47JdFage1R3T153mtXJUZ",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53346
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 59
      }
    }
    responseTime: 31

2020-04-27T18:28:17.940Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:17.939Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:18.002Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.002Z ipfs:repo:gc Marked set has 16 unique blocks. Blockstore has 19 blocks. Deleted 3 blocks.
2020-04-27T18:28:18.002Z ipfs:repo:gc Complete (63ms)

2020-04-27T18:28:18.002Z ipfsd-ctl:daemon:stdout [1588012098002] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012097939:ALEXPD16E:7136:k9itedme:10035",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53347
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 63

      √ should clean up block only after unpinned and removed from MFS (781ms)
2020-04-27T18:28:18.018Z ipfsd-ctl:daemon:stdout [1588012098018] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098002:ALEXPD16E:7136:k9itedme:10036",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53348
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:18.034Z ipfsd-ctl:daemon:stdout [1588012098033] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098018:ALEXPD16E:7136:k9itedme:10037",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53349
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 15

2020-04-27T18:28:18.065Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.064Z ipfs:pin Flushed pins with root: QmeKx1aGgds5JUXJbvBXF8CoKbYJckgJv6HmH7rxrsj59r

2020-04-27T18:28:18.065Z ipfsd-ctl:daemon:stdout [1588012098064] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098033:ALEXPD16E:7136:k9itedme:10038",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/add?stream-channels=true&progress=false",
      "headers": {
        "content-type": "multipart/form-data; boundary=-----------------------------SbG0NkRbNiyrNXQulhpAH",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53350
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache",
        "connection": "close"
      }
    }
    responseTime: 31

2020-04-27T18:28:18.080Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.080Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY

2020-04-27T18:28:18.096Z ipfsd-ctl:daemon:stdout [1588012098080] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098080:ALEXPD16E:7136:k9itedme:10039",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/rm?arg=QmYUY5XnbdTH914VW6dfGSvuyMuBXdjaHk2aUKNWQxMMNQ",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53351
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 59
      }
    }
    responseTime: 0

2020-04-27T18:28:18.112Z ipfsd-ctl:daemon:stdout [1588012098111] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098096:ALEXPD16E:7136:k9itedme:10040",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/object/put",
      "headers": {
        "content-type": "multipart/form-data; boundary=-----------------------------rvYh9UEAnnSnwe6pEPRXz",
        "accept": "*/*",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310",
        "transfer-encoding": "chunked"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53352
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 209
      }
    }
    responseTime: 15

2020-04-27T18:28:18.143Z ipfsd-ctl:daemon:stdout [1588012098143] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098111:ALEXPD16E:7136:k9itedme:10041",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/ls?stream=true",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53353
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 32

2020-04-27T18:28:18.159Z ipfsd-ctl:daemon:stdout [1588012098158] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098143:ALEXPD16E:7136:k9itedme:10042",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53354
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 15

2020-04-27T18:28:18.190Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.189Z ipfs:pin Flushed pins with root: QmRDSso4dTWeXrXpXnVjT3PemHzfrcc2FjBsEJUT6xN5x4

2020-04-27T18:28:18.206Z ipfsd-ctl:daemon:stdout [1588012098205] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098158:ALEXPD16E:7136:k9itedme:10043",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/add?recursive=true&arg=QmaFabL1HsW7nGxYLQ9NorphJm9Lst75fzd1VAkLnDdE7b",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53355
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 59
      }
    }
    responseTime: 47

2020-04-27T18:28:18.221Z ipfsd-ctl:daemon:stdout [1588012098221] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098205:ALEXPD16E:7136:k9itedme:10044",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/ls?stream=true",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53356
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:18.221Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.221Z ipfs:repo:gc Creating set of marked blocks

2020-04-27T18:28:18.300Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.299Z ipfs:repo:gc Marked set has 18 unique blocks. Blockstore has 22 blocks. Deleted 4 blocks.
2020-04-27T18:28:18.299Z ipfs:repo:gc Complete (78ms)

2020-04-27T18:28:18.300Z ipfsd-ctl:daemon:stdout [1588012098299] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098221:ALEXPD16E:7136:k9itedme:10045",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53357
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 78

2020-04-27T18:28:18.315Z ipfsd-ctl:daemon:stdout [1588012098315] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098299:ALEXPD16E:7136:k9itedme:10046",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53358
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 16

2020-04-27T18:28:18.330Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.330Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY

2020-04-27T18:28:18.330Z ipfsd-ctl:daemon:stdout [1588012098330] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098315:ALEXPD16E:7136:k9itedme:10047",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/pin/rm?arg=QmaFabL1HsW7nGxYLQ9NorphJm9Lst75fzd1VAkLnDdE7b",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53359
    }
    res: {
      "statusCode": 200,
      "headers": {
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "content-type": "application/json; charset=utf-8",
        "vary": "origin",
        "cache-control": "no-cache",
        "content-length": 59
      }
    }
    responseTime: 15

2020-04-27T18:28:18.346Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.330Z ipfs:repo:gc Creating set of marked blocks

      1) should clean up indirectly pinned data after recursive pin removal
2020-04-27T18:28:18.393Z ipfsd-ctl:daemon:stdout [1588012098393] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098393:ALEXPD16E:7136:k9itedme:10049",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/refs/local",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53361
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 0
[1588012098393] INFO  (7136 on ALEXPD16E): request completed
    req: {
      "id": "1588012098330:ALEXPD16E:7136:k9itedme:10048",
      "method": "post",
      "url": "http://127.0.0.1:53310/api/v0/repo/gc",
      "headers": {
        "accept": "*/*",
        "content-length": "0",
        "user-agent": "node-fetch/1.0 (+https://github.com/bitinn/node-fetch)",
        "accept-encoding": "gzip,deflate",
        "connection": "close",
        "host": "127.0.0.1:53310"
      },
      "remoteAddress": "127.0.0.1",
      "remotePort": 53360
    }
    res: {
      "statusCode": 200,
      "headers": {
        "x-chunked-output": "1",
        "content-type": "application/json; charset=utf-8",
        "trailer": "X-Stream-Error",
        "access-control-allow-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length",
        "access-control-expose-headers": "X-Stream-Output, X-Chunked-Output, X-Content-Length,WWW-Authenticate,Server-Authorization",
        "vary": "origin",
        "cache-control": "no-cache"
      }
    }
    responseTime: 63

2020-04-27T18:28:18.393Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.393Z ipfs:repo:gc Marked set has 16 unique blocks. Blockstore has 20 blocks. Deleted 4 blocks.
2020-04-27T18:28:18.393Z ipfs:repo:gc Complete (63ms)



  4 passing (30s)
  1 failing

  1) interface-ipfs-core over ipfs-http-client tests
       .repo.gc
         should clean up indirectly pinned data after recursive pin removal:
     AssertionError: expected [ Array(19) ] to not include 'QmYUY5XnbdTH914VW6dfGSvuyMuBXdjaHk2aUKNWQxMMNQ'
      at Context.it (C:\Users\alex\Documents\Workspaces\ipfs\js-ipfs\packages\interface-ipfs-core\src\repo\gc.js:227:41)
      at process._tickCallback (internal/process/next_tick.js:68:7)



Command failed with ENOENT: mocha --ui bdd --timeout 5000 --unhandled-rejections=strict --colors --exit test\http-api\interface.js
spawn mocha ENOENT
npm ERR! code ELIFECYCLE
npm ERR! errno 1
npm ERR! [email protected] test:interface:http: `cross-env ECHO_SERVER_PORT=37489 aegir test -f test/http-api/interface.js "-t" "node"`
npm ERR! Exit status 1
npm ERR!
npm ERR! Failed at the [email protected] test:interface:http script.
npm ERR! This is probably not a problem with npm. There is likely additional logging output above.

npm ERR! A complete log of this run can be found in:
npm ERR!     C:\Users\alex\AppData\Roaming\npm-cache\_logs\2020-04-27T18_28_18_612Z-debug.log

@achingbrain achingbrain mentioned this issue Apr 27, 2020
Closed
@achingbrain
Copy link
Member Author

Removing some of the noise from the previous post to look at the sequence of events:

Test start
POST http://127.0.0.1:53310/api/v0/refs/local
--
2020-04-27T18:28:18.065Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.064Z ipfs:pin Flushed pins with root: QmeKx1aGgds5JUXJbvBXF8CoKbYJckgJv6HmH7rxrsj59r
POST http://127.0.0.1:53310/api/v0/add?stream-channels=true&progress=false
--
2020-04-27T18:28:18.080Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.080Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY
POST http://127.0.0.1:53310/api/v0/pin/rm?arg=QmYUY5XnbdTH914VW6dfGSvuyMuBXdjaHk2aUKNWQxMMNQ
--
POST http://127.0.0.1:53310/api/v0/object/put
--
POST http://127.0.0.1:53310/api/v0/pin/ls?stream=true
--
POST http://127.0.0.1:53310/api/v0/refs/local
--
2020-04-27T18:28:18.190Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.189Z ipfs:pin Flushed pins with root: QmRDSso4dTWeXrXpXnVjT3PemHzfrcc2FjBsEJUT6xN5x4
POST http://127.0.0.1:53310/api/v0/pin/add?recursive=true&arg=QmaFabL1HsW7nGxYLQ9NorphJm9Lst75fzd1VAkLnDdE7b
--
POST http://127.0.0.1:53310/api/v0/pin/ls?stream=true
--
2020-04-27T18:28:18.221Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.221Z ipfs:repo:gc Creating set of marked blocks
2020-04-27T18:28:18.300Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.299Z ipfs:repo:gc Marked set has 18 unique blocks. Blockstore has 22 blocks. Deleted 4 blocks.
2020-04-27T18:28:18.299Z ipfs:repo:gc Complete (78ms)
POST http://127.0.0.1:53310/api/v0/repo/gc
--
http://127.0.0.1:53310/api/v0/refs/local
--
2020-04-27T18:28:18.330Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.330Z ipfs:pin Flushed pins with root: QmZ9ANfh6BMFoeinQU1WQ2BQrRea4UusEikQ1kupx3HtsY
POST http://127.0.0.1:53310/api/v0/pin/rm?arg=QmaFabL1HsW7nGxYLQ9NorphJm9Lst75fzd1VAkLnDdE7b
--
2020-04-27T18:28:18.346Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.330Z ipfs:repo:gc Creating set of marked blocks
-- FAIL MESSAGE HERE --
POST http://127.0.0.1:53310/api/v0/refs/local
POST http://127.0.0.1:53310/api/v0/repo/gc
2020-04-27T18:28:18.393Z ipfsd-ctl:daemon:stderr 2020-04-27T18:28:18.393Z ipfs:repo:gc Marked set has 16 unique blocks. Blockstore has 20 blocks. Deleted 4 blocks.
2020-04-27T18:28:18.393Z ipfs:repo:gc Complete (63ms)

Bearing in mind that the POST ... is shown when the request completes, not when it starts, so log lines preceding a POST ... are caused by that request, it looks like the final gc completes after we read the local refs to see if gc removed the unpinned blocks, so the client is ignoring the end of the response or maybe closing the connection early.

@achingbrain achingbrain mentioned this issue Apr 27, 2020
Merged
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

fix: fix gc tests ipfs/js-ipfs
1 participant
@achingbrain