grep -i catchup node.log | tail -n 50

node.log

{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).sync","level":"info","line":620,"msg":"Catchup Service: finished catching up, now at round 14730113 (previously 14720024). Total time catching up 1h35m41.119504425s.","name":"","time":"2022-01-23T02:26:42.062789+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).periodicSync","level":"info","line":548,"msg":"It's been too long since our ledger advanced; resyncing","name":"","time":"2022-01-23T02:27:08.429415+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).sync","level":"info","line":581,"msg":"resuming previous sync from 1641410164566485271 (now=1642901228429442353)","name":"","time":"2022-01-23T02:27:08.429454+01:00"}
{"Context":"sync","details":{"StartRound":14730113},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStart","name":"","session":"","time":"2022-01-23T02:27:08.429489+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).fetchAndWrite","level":"info","line":255,"msg":"fetchAndWrite(14734800): Aborted while waiting for lookback block to ledger after failing once : Get \"http://r-pd.algorand-mainnet.network:4160/v1/mainnet-v1.0/block/8rtg0\": context canceled","name":"","time":"2022-01-23T04:46:16.827456+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734792","name":"","time":"2022-01-23T04:46:16.827499+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734800","name":"","time":"2022-01-23T04:46:16.827511+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734786","name":"","time":"2022-01-23T04:46:16.827477+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).fetchAndWrite","level":"warning","line":294,"msg":"fetchAndWrite(14734789): lookback block doesn't exist, cannot authenticate new block","name":"","time":"2022-01-23T04:46:16.827568+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734799","name":"","time":"2022-01-23T04:46:16.827492+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734789","name":"","time":"2022-01-23T04:46:16.827719+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734798","name":"","time":"2022-01-23T04:46:16.827513+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734793","name":"","time":"2022-01-23T04:46:16.827516+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734796","name":"","time":"2022-01-23T04:46:16.827524+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734791","name":"","time":"2022-01-23T04:46:16.827535+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).fetchAndWrite","level":"warning","line":294,"msg":"fetchAndWrite(14734788): lookback block doesn't exist, cannot authenticate new block","name":"","time":"2022-01-23T04:46:16.827537+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734788","name":"","time":"2022-01-23T04:46:16.828077+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734787","name":"","time":"2022-01-23T04:46:16.827537+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734795","name":"","time":"2022-01-23T04:46:16.827537+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734794","name":"","time":"2022-01-23T04:46:16.827460+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734797","name":"","time":"2022-01-23T04:46:16.827547+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":390,"msg":"failed to fetch block 14734790","name":"","time":"2022-01-23T04:46:16.827497+01:00"}
{"Context":"sync","details":{"StartRound":14730113,"EndRound":14734785,"Time":8348756944381,"InitSync":true},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStop","name":"","session":"","time":"2022-01-23T04:46:17.186413+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).sync","level":"info","line":620,"msg":"Catchup Service: finished catching up, now at round 14734785 (previously 14730113). Total time catching up 2h19m8.756944381s.","name":"","time":"2022-01-23T04:46:17.222473+01:00"}
{"Context":"sync","details":{"StartRound":14734484},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStart","name":"","session":"","time":"2022-01-23T05:02:25.434834+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737229): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392799+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737237): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392844+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737232): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392849+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737238): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392900+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737242): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392909+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).fetchAndWrite","level":"warning","line":296,"msg":"fetchAndWrite(14737234): lookback block doesn't exist, cannot authenticate new block","name":"","time":"2022-01-23T12:11:08.392866+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737234): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.393009+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).fetchAndWrite","level":"warning","line":296,"msg":"fetchAndWrite(14737235): lookback block doesn't exist, cannot authenticate new block","name":"","time":"2022-01-23T12:11:08.392876+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737235): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.393051+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737230): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392877+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737241): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392878+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).fetchAndWrite","level":"warning","line":296,"msg":"fetchAndWrite(14737239): lookback block doesn't exist, cannot authenticate new block","name":"","time":"2022-01-23T12:11:08.392880+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737239): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.393095+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737236): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392892+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737228): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392892+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737233): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392855+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737240): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392895+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelineCallback.func1","level":"info","line":394,"msg":"pipelineCallback(14737231): did not fetch or write the block","name":"","time":"2022-01-23T12:11:08.392862+01:00"}
{"Context":"sync","details":{"StartRound":14734484,"EndRound":14737227,"Time":25723052678619,"InitSync":true},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStop","name":"","session":"","time":"2022-01-23T12:11:08.487521+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).sync","level":"info","line":624,"msg":"Catchup Service: finished catching up, now at round 14737227 (previously 14734484). Total time catching up 7h8m43.052678619s.","name":"","time":"2022-01-23T12:11:08.510131+01:00"}
{"Context":"sync","details":{"StartRound":14737227},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStart","name":"","session":"","time":"2022-01-23T12:13:20.949805+01:00"}
{"Context":"sync","details":{"StartRound":14737356},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStart","name":"","session":"","time":"2022-01-23T12:37:00.356696+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).pipelinedFetch","level":"info","line":487,"msg":"Catchup is stopping due to catchpoint file being written","name":"","time":"2022-01-23T15:51:22.036041+01:00"}
{"Context":"sync","details":{"StartRound":14737356,"EndRound":14740128,"Time":11665847976702,"InitSync":false},"file":"telemetry.go","function":"github.com/algorand/go-algorand/logging.(*telemetryState).logTelemetry","instanceName":"qf49VARlyWKUWZiN","level":"info","line":259,"msg":"/ApplicationState/CatchupStop","name":"","session":"","time":"2022-01-23T15:51:26.204650+01:00"}
{"Context":"sync","file":"service.go","function":"github.com/algorand/go-algorand/catchup.(*Service).sync","level":"info","line":624,"msg":"Catchup Service: finished catching up, now at round 14740128 (previously 14737356). Total time catching up 3h14m25.847976702s.","name":"","time":"2022-01-23T15:51:26.204764+01:00"}