Good morning all,
I am new to Storj. My particularity is to have installed my storjnode on a remote VPS, on a Linux Ubuntu 20.04 LTS. With the VPS, I got a static IP address (82.x.x.x). Therefore , there is normally no router and no forwarding port. The node’s hostname is: “aaa.bbb.fr”, but I didn’t use it to launch the container. Despite my best efforts, port 28967 unfortunately remains closed and my storjnode remains OFFLINE in the dashboard. I tried to enable UFW by granting permissions, but nothing helped. So I disabled UFW. I am giving you the launch routine that I am currently using. It certainly contains errors. Could you, based on your experience, tell me?
Thank you in advance for your suggestions and best regards,
Alain
With the open port check tool, I see that only the port 22 is open ! Surprising !
About my VPS provider (AlphaVPS), I don’t know if there is a firewall. I have chosen a “storage VPS”. No settings about this in their dashboard…
Seems you need to contact them and ask how to allow the access to your node’s port.
But you can try to figure out it yourself, perhaps the OS does have a firewall installed.
Hello Alain,
We do not do any port blocks on our side. Are you sure that you have something listening on this port?
You can confirm via:
netstat -tulpn
This command gives :
Please note : Actually, the docker container is stopped and removed.
And the port 28967 is always closed :
The problem does not seem to come from the provider ?
Hello,
If container not running port isnt active.
Its your first time you run storagenode?
Did you use -e SETUP=“true” ? For first run?
If yes please see storagenode container logs
I ran the SN several times, trying multiple modifications on the run command…
Sorry, I misunderstand “-e SETUP=“true””
Where can I read container logs ?
There is beginning of my container logs. I hope it will be sufficient for diagnostic :
xxx@storj:~$ sudo docker logs storagenode
2021-01-24T17:58:45.644Z INFO Configuration loaded {“Location”: “/app/config/config.yaml”}
2021-01-24T17:58:45.670Z INFO Operator email {“Address”: “”}
2021-01-24T17:58:45.670Z INFO Operator wallet {“Address”: “”}
2021-01-24T17:58:46.377Z INFO Telemetry enabled {“instance ID”: “1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxY LpvPaX9m6pE3pt”}
2021-01-24T17:58:46.445Z INFO db.migration Database Version {“version”: 47}
2021-01-24T17:59:34.183Z INFO preflight:localtime start checking local system clock with trusted satell ites’ system clock.
2021-01-24T17:59:35.110Z INFO preflight:localtime local system clock is in sync with trusted satellites ’ system clock.
2021-01-24T17:59:35.111Z INFO bandwidth Performing bandwidth usage rollups
2021-01-24T17:59:35.113Z INFO trust Scheduling next refresh {“after”: “5h6m42.682049151s”}
2021-01-24T17:59:35.112Z INFO Node 1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxYLpvPaX9m6pE3pt started
2021-01-24T17:59:35.119Z INFO Public server started on [::]:28967
2021-01-24T17:59:35.119Z INFO Private server started on 127.0.0.1:7778
2021-01-24T17:59:35.115Z WARN piecestore:monitor Disk space is less than requested. Allocated space is {“bytes”: 1122492416}
2021-01-24T17:59:35.122Z ERROR piecestore:monitor Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T17:59:35.122Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not met\n\tstorj.io/storj/storagenode/monitor.(*Service).Run:123\n\tstorj.io/storj/private/lifecycle.(*Group) .Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync /errgroup.(*Group).Go.func1:57”}
2021-01-24T17:59:35.124Z ERROR nodestats:cache Get pricing-model/join date failed {“error”: “context ca nceled”}
2021-01-24T17:59:35.124Z ERROR gracefulexit:blobscleaner couldn’t receive satellite’s GE status {“err or”: “context canceled”}
Error: piecestore monitor: disk space requirement not met
2021-01-24T17:59:37.035Z INFO Configuration loaded {“Location”: “/app/config/config.yaml”}
2021-01-24T17:59:37.071Z INFO Operator email {“Address”: “”}
2021-01-24T17:59:37.072Z INFO Operator wallet {“Address”: “”}
2021-01-24T17:59:37.736Z INFO Telemetry enabled {“instance ID”: “1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxY LpvPaX9m6pE3pt”}
2021-01-24T17:59:37.791Z INFO db.migration Database Version {“version”: 47}
2021-01-24T17:59:47.195Z INFO preflight:localtime start checking local system clock with trusted satell ites’ system clock.
2021-01-24T17:59:48.117Z INFO preflight:localtime local system clock is in sync with trusted satellites ’ system clock.
2021-01-24T17:59:48.118Z INFO bandwidth Performing bandwidth usage rollups
2021-01-24T17:59:48.119Z WARN piecestore:monitor Disk space is less than requested. Allocated space is {“bytes”: 1122484224}
2021-01-24T17:59:48.124Z ERROR piecestore:monitor Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T17:59:48.119Z INFO Node 1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxYLpvPaX9m6pE3pt started
2021-01-24T17:59:48.120Z INFO trust Scheduling next refresh {“after”: “3h0m54.14296033s”}
2021-01-24T17:59:48.125Z INFO Public server started on [::]:28967
2021-01-24T17:59:48.125Z INFO Private server started on 127.0.0.1:7778
2021-01-24T17:59:48.125Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not met\n\tstorj.io/storj/storagenode/monitor.(*Service).Run:123\n\tstorj.io/storj/private/lifecycle.(*Group) .Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync /errgroup.(*Group).Go.func1:57”}
2021-01-24T17:59:48.127Z ERROR nodestats:cache Get pricing-model/join date failed {“error”: “context ca nceled”}
Error: piecestore monitor: disk space requirement not met
2021-01-24T17:59:49.774Z INFO Configuration loaded {“Location”: “/app/config/config.yaml”}
2021-01-24T17:59:49.802Z INFO Operator email {“Address”: “”}
2021-01-24T17:59:49.802Z INFO Operator wallet {“Address”: “”}
2021-01-24T17:59:50.516Z INFO Telemetry enabled {“instance ID”: “1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxY LpvPaX9m6pE3pt”}
2021-01-24T17:59:50.574Z INFO db.migration Database Version {“version”: 47}
2021-01-24T18:00:14.214Z INFO preflight:localtime start checking local system clock with trusted satell ites’ system clock.
2021-01-24T18:00:15.127Z INFO preflight:localtime local system clock is in sync with trusted satellites ’ system clock.
2021-01-24T18:00:15.128Z INFO bandwidth Performing bandwidth usage rollups
2021-01-24T18:00:15.129Z WARN piecestore:monitor Disk space is less than requested. Allocated space is {“bytes”: 1122471936}
2021-01-24T18:00:15.129Z ERROR piecestore:monitor Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T18:00:15.130Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not met\n\tstorj.io/storj/storagenode/monitor.(*Service).Run:123\n\tstorj.io/storj/private/lifecycle.(*Group) .Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync /errgroup.(*Group).Go.func1:57”}
2021-01-24T18:00:15.131Z ERROR nodestats:cache Get pricing-model/join date failed {“error”: “context ca nceled”}
2021-01-24T18:00:15.132Z INFO Node 1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxYLpvPaX9m6pE3pt started
2021-01-24T18:00:15.134Z INFO Public server started on [::]:28967
2021-01-24T18:00:15.135Z INFO Private server started on 127.0.0.1:7778
2021-01-24T18:00:15.136Z INFO trust Scheduling next refresh {“after”: “4h49m28.926079642s”}
2021-01-24T18:00:15.132Z ERROR gracefulexit:blobscleaner couldn’t receive satellite’s GE status {“err or”: “context canceled”}
2021-01-24T18:00:15.132Z ERROR gracefulexit:chore error retrieving satellites. {“error”: “satellites db error: context canceled”, “errorVerbose”: “satellitesdb error: context canceled\n\tstorj.io/storj/storagenode/stor agenodedb.(*satellitesDB).ListGracefulExits:100\n\tstorj.io/storj/storagenode/gracefulexit.(*service).ListPendingExit s:89\n\tstorj.io/storj/storagenode/gracefulexit.(*Chore).Run.func1:53\n\tstorj.io/common/sync2.(*Cycle).Run:92\n\tsto rj.io/storj/storagenode/gracefulexit.(*Chore).Run:50\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2.1:81\n\tr untime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).G o.func1:57”}
2021-01-24T18:00:15.133Z ERROR collector error during collecting pieces: {“error”: “piece expi ration error: context canceled”, “errorVerbose”: “piece expiration error: context canceled\n\tstorj.io/storj/storagen ode/storagenodedb.(*pieceExpirationDB).GetExpired:39\n\tstorj.io/storj/storagenode/pieces.(*Store).GetExpired:520\n\t storj.io/storj/storagenode/collector.(*Service).Collect:88\n\tstorj.io/storj/storagenode/collector.(*Service).Run.fun c1:57\n\tstorj.io/common/sync2.(*Cycle).Run:92\n\tstorj.io/storj/storagenode/collector.(*Service).Run:53\n\tstorj.io/ storj/private/lifecycle.(*Group).Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).R un.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).Go.func1:57”}
2021-01-24T18:00:15.134Z ERROR bandwidth Could not rollup bandwidth usage {“error”: “sql: trans action has already been committed or rolled back”}
2021-01-24T18:00:15.140Z ERROR piecestore:cache error during init space usage db: {“error”: “pi ece space used error: context canceled”, “errorVerbose”: “piece space used error: context canceled\n\tstorj.io/storj/ storagenode/storagenodedb.(*pieceSpaceUsedDB).Init:73\n\tstorj.io/storj/storagenode/pieces.(*CacheService).Run:75\n\t storj.io/storj/private/lifecycle.(*Group).Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.( *Group).Run.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).Go.func1:57”}
Error: piecestore monitor: disk space requirement not met
2021-01-24T18:00:16.720Z INFO Configuration loaded {“Location”: “/app/config/config.yaml”}
2021-01-24T18:00:16.748Z INFO Operator email {“Address”: “”}
2021-01-24T18:00:16.749Z INFO Operator wallet {“Address”: “”}
2021-01-24T18:00:17.427Z INFO Telemetry enabled {“instance ID”: “1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxY LpvPaX9m6pE3pt”}
2021-01-24T18:00:17.489Z INFO db.migration Database Version {“version”: 47}
2021-01-24T18:00:18.231Z INFO preflight:localtime start checking local system clock with trusted satell ites’ system clock.
2021-01-24T18:00:19.138Z INFO preflight:localtime local system clock is in sync with trusted satellites ’ system clock.
2021-01-24T18:00:19.141Z INFO bandwidth Performing bandwidth usage rollups
2021-01-24T18:00:19.142Z INFO Node 1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxYLpvPaX9m6pE3pt started
2021-01-24T18:00:19.143Z INFO Public server started on [::]:28967
2021-01-24T18:00:19.143Z INFO Private server started on 127.0.0.1:7778
2021-01-24T18:00:19.144Z WARN piecestore:monitor Disk space is less than requested. Allocated space is {“bytes”: 1122463744}
2021-01-24T18:00:19.145Z ERROR piecestore:monitor Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T18:00:19.145Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not met\n\tstorj.io/storj/storagenode/monitor.(*Service).Run:123\n\tstorj.io/storj/private/lifecycle.(*Group) .Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync /errgroup.(*Group).Go.func1:57”}
2021-01-24T18:00:19.145Z ERROR nodestats:cache Get pricing-model/join date failed {“error”: “context ca nceled”}
2021-01-24T18:00:19.148Z ERROR gracefulexit:blobscleaner couldn’t receive satellite’s GE status {“err or”: “context canceled”}
2021-01-24T18:00:19.150Z ERROR gracefulexit:chore error retrieving satellites. {“error”: “satellites db error: context canceled”, “errorVerbose”: “satellitesdb error: context canceled\n\tstorj.io/storj/storagenode/stor agenodedb.(*satellitesDB).ListGracefulExits:100\n\tstorj.io/storj/storagenode/gracefulexit.(*service).ListPendingExit s:89\n\tstorj.io/storj/storagenode/gracefulexit.(*Chore).Run.func1:53\n\tstorj.io/common/sync2.(*Cycle).Run:92\n\tstorj.io/storj/storagenode/gracefulexit.(*Chore).Run:50\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2.1:81\n\tr untime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).G o.func1:57”}
2021-01-24T18:00:19.150Z INFO trust Scheduling next refresh {“after”: “7h36m9.827509112s”}
2021-01-24T18:00:19.152Z ERROR collector error during collecting pieces: {“error”: “piece expi ration error: context canceled”, “errorVerbose”: “piece expiration error: context canceled\n\tstorj.io/storj/storagen ode/storagenodedb.(*pieceExpirationDB).GetExpired:39\n\tstorj.io/storj/storagenode/pieces.(*Store).GetExpired:520\n\t storj.io/storj/storagenode/collector.(*Service).Collect:88\n\tstorj.io/storj/storagenode/collector.(*Service).Run.fun c1:57\n\tstorj.io/common/sync2.(*Cycle).Run:92\n\tstorj.io/storj/storagenode/collector.(*Service).Run:53\n\tstorj.io/ storj/private/lifecycle.(*Group).Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).R un.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).Go.func1:57”}
2021-01-24T18:00:19.153Z ERROR piecestore:cache error during init space usage db: {“error”: “pi ece space used error: context canceled”, “errorVerbose”: “piece space used error: context canceled\n\tstorj.io/storj/ storagenode/storagenodedb.(*pieceSpaceUsedDB).Init:73\n\tstorj.io/storj/storagenode/pieces.(*CacheService).Run:75\n\t storj.io/storj/private/lifecycle.(*Group).Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.( *Group).Run.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).Go.func1:57”}
Error: piecestore monitor: disk space requirement not met
2021-01-24T18:00:20.974Z INFO Configuration loaded {“Location”: “/app/config/config.yaml”}
2021-01-24T18:00:21.009Z INFO Operator email {“Address”: “”}
2021-01-24T18:00:21.010Z INFO Operator wallet {“Address”: “”}
2021-01-24T18:00:21.705Z INFO Telemetry enabled {“instance ID”: “1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxY LpvPaX9m6pE3pt”}
2021-01-24T18:00:21.758Z INFO db.migration Database Version {“version”: 47}
2021-01-24T18:00:22.404Z INFO preflight:localtime start checking local system clock with trusted satell ites’ system clock.
2021-01-24T18:00:23.292Z INFO preflight:localtime local system clock is in sync with trusted satellites ’ system clock.
2021-01-24T18:00:23.292Z INFO Node 1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxYLpvPaX9m6pE3pt started
2021-01-24T18:00:23.292Z INFO Public server started on [::]:28967
2021-01-24T18:00:23.292Z INFO Private server started on 127.0.0.1:7778
2021-01-24T18:00:23.293Z INFO trust Scheduling next refresh {“after”: “7h51m4.03322419s”}
2021-01-24T18:00:23.296Z WARN piecestore:monitor Disk space is less than requested. Allocated space is {“bytes”: 1122451456}
2021-01-24T18:00:23.296Z ERROR piecestore:monitor Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T18:00:23.296Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not met\n\tstorj.io/storj/storagenode/monitor.(*Service).Run:123\n\tstorj.io/storj/private/lifecycle.(*Group) .Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync /errgroup.(*Group).Go.func1:57”}
2021-01-24T18:00:23.297Z INFO bandwidth Performing bandwidth usage rollups
2021-01-24T18:00:23.298Z ERROR nodestats:cache Get pricing-model/join date failed {“error”: “context ca nceled”}
2021-01-24T18:00:23.298Z ERROR gracefulexit:chore error retrieving satellites. {“error”: “satellites db error: context canceled”, “errorVerbose”: “satellitesdb error: context canceled\n\tstorj.io/storj/storagenode/stor agenodedb.(*satellitesDB).ListGracefulExits:100\n\tstorj.io/storj/storagenode/gracefulexit.(*service).ListPendingExit s:89\n\tstorj.io/storj/storagenode/gracefulexit.(*Chore).Run.func1:53\n\tstorj.io/common/sync2.(*Cycle).Run:92\n\tsto rj.io/storj/storagenode/gracefulexit.(*Chore).Run:50\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2.1:81\n\tr untime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).G o.func1:57”}
2021-01-24T18:00:23.298Z ERROR gracefulexit:blobscleaner couldn’t receive satellite’s GE status {“err or”: “context canceled”}
2021-01-24T18:00:23.299Z ERROR collector error during collecting pieces: {“error”: “piece expi ration error: context canceled”, “errorVerbose”: “piece expiration error: context canceled\n\tstorj.io/storj/storagen ode/storagenodedb.(*pieceExpirationDB).GetExpired:39\n\tstorj.io/storj/storagenode/pieces.(*Store).GetExpired:520\n\t storj.io/storj/storagenode/collector.(*Service).Collect:88\n\tstorj.io/storj/storagenode/collector.(*Service).Run.fun c1:57\n\tstorj.io/common/sync2.(*Cycle).Run:92\n\tstorj.io/storj/storagenode/collector.(*Service).Run:53\n\tstorj.io/ storj/private/lifecycle.(*Group).Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).R un.func2:80\n\tgolang.org/x/sync/errgroup.(*Group).Go.func1:57”}
2021-01-24T18:00:23.297Z ERROR bandwidth Could not rollup bandwidth usage {“error”: “bandwidthd b error: context canceled”, “errorVerbose”: “bandwidthdb error: context canceled\n\tstorj.io/storj/storagenode/storag enodedb.(*bandwidthDB).Rollup:301\n\tstorj.io/storj/storagenode/bandwidth.(*Service).Rollup:53\n\tstorj.io/common/syn c2.(*Cycle).Run:92\n\tstorj.io/storj/storagenode/bandwidth.(*Service).Run:45\n\tstorj.io/storj/private/lifecycle.(*Gr oup).Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/ sync/errgroup.(*Group).Go.func1:57”}
Error: piecestore monitor: disk space requirement not met
2021-01-24T18:00:25.160Z INFO Configuration loaded {“Location”: “/app/config/config.yaml”}
2021-01-24T18:00:25.188Z INFO Operator email {“Address”: “”}
2021-01-24T18:00:25.188Z INFO Operator wallet {“Address”: “”}
2021-01-24T18:00:25.843Z INFO Telemetry enabled {“instance ID”: “1VVPr7ZXRKQwF6kEQZ3iYGRQRhUckLH4waxY LpvPaX9m6pE3pt”}
2021-01-24T18:00:25.896Z INFO db.migration Database Version {“version”: 47}
2021-01-24T18:00:26.536Z INFO preflight:localtime start checking local system clock with trusted satell ites’ system clock.
2021-01-24T18:00:27.427Z INFO preflight:localtime local system clock is in sync with trusted satellites ’ system clock.
2021-01-24T18:00:27.428Z INFO bandwidth Performing bandwidth usage rollups
2021-01-24T18:00:27.429Z INFO trust Scheduling next refresh {“after”: “7h44m20.883626868s”}
2021-01-24T18:00:27.428Z WARN piecestore:monitor Disk space is less than requested. Allocated space is {“bytes”: 1122435072}
2021-01-24T18:00:27.435Z ERROR piecestore:monitor Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T18:00:27.436Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not met\n\tstorj.io/storj/storagenode/monitor.(*Service).Run:123\n\tstorj.io/storj/private/lifecycle.(*Group) .Run.func2.1:81\n\truntime/pprof.Do:40\n\tstorj.io/storj/private/lifecycle.(*Group).Run.func2:80\n\tgolang.org/x/sync /errgroup.(*Group).Go.func1:57”}
Etc…
Total disk space is less than required minimum {“byt es”: 500000000000}
2021-01-24T17:59:35.122Z ERROR services unexpected shutdown of a runner {“name”: “piecestore:monitor” , “error”: “piecestore monitor: disk space requirement not met”, “errorVerbose”: “piecestore monitor: disk space requ irement not me
Network is OK…
Do you have free space on this machine?
Run
df -H
