JetStream went Generally Available in NATS 2.2.0 the documentation is now in the core NATS documentation.
nats-io / jetstream Goto Github PK
View Code? Open in Web Editor NEWJetStream Utilities
License: Apache License 2.0
JetStream Utilities
License: Apache License 2.0
JetStream went Generally Available in NATS 2.2.0 the documentation is now in the core NATS documentation.
The current specification for AckNak states that NAK’d messages will be retried. In addition to this behaviour, it would be beneficial with the option to explicitly terminate the message before the max retries runs out in the scenario where an invalid or unexpected message has been encountered in a service. Instead of acknowledging the message with an error message in the individual service, the termination through the NAK would ensure that an advisory of the occurrence would be published that can be read by a separate service for reporting and alerting purposes for instance.
Is there a dart client ? That's what I am interested in.
Or how would someone make a client ?
Jetstream seems to support pull and push.
So then can I presume that grpc can be used to wrap Jetstream consumer API ?
Grpc would make things reusable for many clients
Since reworking the API many info calls are being done during stream and consumer create:
14:37:23 [Stream Create] X
14:37:23 [JS API] $JS.API.STREAM.CREATE.X $G
14:37:23 [JS API] $JS.API.STREAM.INFO.X $G
14:37:23 [JS API] $JS.API.STREAM.INFO.X $G
14:37:23 [JS API] $JS.API.STREAM.INFO.X $G
14:37:41 [JS API] $JS.API.STREAM.INFO.X $G
14:37:41 [Consumer Create] X > X
14:37:41 [JS API] $JS.API.CONSUMER.DURABLE.CREATE.X.X $G
14:37:41 [JS API] $JS.API.CONSUMER.INFO.X.X $G
14:37:41 [JS API] $JS.API.STREAM.INFO.X $G
14:37:41 [JS API] $JS.API.CONSUMER.INFO.X.X $G
14:37:41 [JS API] $JS.API.CONSUMER.INFO.X.X $G
14:37:41 [JS API] $JS.API.CONSUMER.INFO.X.X $G
I ran into a need for wildcard subject filters on consumers, we also had a user ask:
I was thinking about using the subject names to filter across different dimensions.
For example if we consider a stream structured like that:
ORDERS.(order_id).(order_state)
If I want to display a live audit trail for a particular order, I could create consume
a consumer for ORDERS.1234.>
If I want to have a view of unfulfilled orders I could create a consumer
for ORDERS.*.UNFULFILLED
There are probably other ways to model that, but having these wildcards on the stream
would make it trivial and avoid any filtering on the client.
My use case was:
Since we have no headers it's common to stick some extra data into subjects people
publish to, like logs.<app>.<level> and later subscribe to logs.* and extract the app
and type.
If we consume these into JetStream as things stand we need a Stream per App+Type
since we cannot filter on wildcards in consumers for cases where someone just wanted
messages for a specific app. We could use Templates of course but this seems way
overkill when a single Stream+Filters can solve this.
Running both the server and jsm from the latest docker images, the following item from the readme complains with the following:
f4242d00d098:~# jsm str rmm ORDERS 1 -f
jsm: error: expected command but got "rmm", try --help
The current flags for picking messages predates the nice typed messages where any message can come in on any subject and the right thing will happen.
So we can simplify the message type selectors and make a generic flag to listen on any subject (like a consumer) and should also make listening for jetstream events something that can be disabled
Both produce errors like
Event error: display failed: template: io.nats.server.advisory.v1.client_disconnect:27:6: executing "io.nats.server.advisory.v1.client_disconnect" at <.Stats>: can't evaluate field Stats in
type *advisory.DisconnectEventMsgV1
[13:39:08] [mIzs19giekEzFIInFl1UkZ] Client ConnectionEvent error: display failed: template: io.nats.server.advisory.v1.client_connect:4:7: executing "io.nats.server.advisory.v1.client_connec
t" at <.Reason>: can't evaluate field Reason in type *advisory.ConnectEventMsgV1
I would like to set some arbirtary max RAM for nats-server while allow unlimited disk space.
This would also be useful/needed for kubernetes resource limits and allocations.
Hi there,
Seems like Jetstream doesn't have any work towards clustering yet? Would be good to understand and potentially help towards this. Not sure how usable this could be as a single machine, but loving the concept.
I wonder if you could easily setup a cassandra/druid/san data store for example? Cassandra supports tombstoning so might be a great choice. Though SAN/NAS might work right now esp if the stream is append only (apart from cleanup)?
Thanks
Andrew
I used most recent version.
> nats -s nats://faas:pwd@localhost:4222 consumer add faas-cluster
? Consumer name DURABLE
? Delivery target
? Start policy (all, new, last, 1h, msg sequence) all
? Filter Stream by subject (blank for all) faas-cluster.test
? Maximum Allowed Deliveries -1
nats: error: Consumer creation failed: configuration validation failed: replay_policy: replay_policy must be one of the following: "instant", "original"
>
Before updating and running into this, "ack_wait" seemed to be missing
Currently i am missing NKey but i havent checked the others really.
I would assume NKey could allow seed directly or by file reference
Seems to me that stream templates would be used by a type of application that want to dynamically add bundles of data to itself, but today there is no way other than template info to discover what streams exist.
Asking this info API at start to discover who is there now is fine, but at run time you want to be told when a new Stream managed by a specific template is made. It would be useful then to publish advisories when a template creates a new managed stream.
Published to $JS.EVENT.ADVISORY.STREAM.TEMPLATE.CREATE_STREAM.<template name>
{
"type": "io.nats.jetstream.advisory.v1.template_create_stream",
"id": "....",
"timestamp": "...",
"template":"FOO",
"stream": "FOO_managed_stream"
}
I can then create a stream to receive these advisories, at start I would:
wdyt @derekcollison ?
Consumer next is slow at the moment since it tries to figure out if its a valid stream/consumer, then detects which kind and then does sub or next. This is fine.
But we should create a fast alternative that assumes people know what they're doing, so jsm c sub
should be helpful and jsm c next STREAM CONSUMER
should be quick without all the help
? Maximum Allowed Deliveries 5
jsm: error: could not ask for maximum allowed deliveries: you must pass a pointer as the target of a Write operation
I'm fan of nats and mostly on nats-streaming, now for distributed service coordinator i need to have ability to slit queue not only by messages in queue group, but garantie that messages with some uuid always goes to single consumer. So i need consistent hashing by this uuid to all consumers.
As i know this will be planned on jetstream. Where i an find progress and also track this feature?
Hi there,
I've been investigating working with Jetstream but as it's new I'm interested in what the team would recommend in working with aggregates/and processsing of data. It seems kafka/flink/spark/samza/ray/streamz all have little ecoverses but wondered if anyone had preferences here as to what could work well? Im especially interested in accumulating realtime statistics and sharing them at scale. Thinking something like a distributed dataframe. I was thinking nats, and flink would be good for this - but jetstream and maybe something you'd recommend would be better?
I do like the checkpointing that flink brings to the table.... but keen to hear your thoughts.
Is there any planned work or a roadmap around adding an HTTP Administration API to manage Jetstream remotely? One of the issues that we experience with using NATS Jetstream in a production environment within Kubernetes is that we don't have a good HTTP API to manage it with. Instead, we have to invoke remote exec
functions across pods to make it happen, and the developer experience behind that is just 👎
The current --subject
flag should have an interactive equivelant
There is no prompt for it. Help text does not specify it either (only allows turning it on, which seems to be default anyways)
IMHO the option should not exist. An App is going to wait.
So disabling it here is going to cause issues.
Instead we should only reply when prompted by the app.
./nats -s 0.0.0.0:4222 stream create TOAST
? Subjects to consume toast.>
? Storage backend memory
? Retention Policy Limits
? Message count limit -1
? Message size limit 0
? Maximum message age limit -1
? Maximum individual message size -1
Stream TOAST was created
Information for Stream TOAST
Configuration:
Subjects: toast.>
Acknowledgements: true
Retention: Memory - Limits
Replicas: 1
Maximum Messages: unlimited
Maximum Bytes: unlimited
Maximum Age: 0s
Maximum Message Size: unlimited
Maximum Consumers: unlimited
State:
Messages: 0
Bytes: 0 B
FirstSeq: 0
LastSeq: 0
Active Consumers: 0
./nats -s 0.0.0.0:4222 stream create TOAST2 -h
usage: nats stream create [<flags>] [<stream>]
Create a new Stream
Flags:
...
--ack Acknowledge publishes
...
12:35:36 ~/repos/jetstream/nats master ./nats -s 0.0.0.0:4222 stream create TOAST2 --ack=false
nats: error: unexpected false, try --help
12:35:42 ✘ 1 ~/repos/jetstream/nats master ./nats -s 0.0.0.0:4222 stream create TOAST2 --ack
? Subjects to consume te
? Storage backend file
? Retention Policy Limits
? Message count limit -1
? Message size limit 0
? Maximum message age limit -1
? Maximum individual message size -1
Stream TOAST2 was created
Information for Stream TOAST2
Configuration:
Subjects: te
Acknowledgements: true
Retention: File - Limits
Replicas: 1
Maximum Messages: unlimited
Maximum Bytes: unlimited
Maximum Age: 0s
Maximum Message Size: unlimited
Maximum Consumers: unlimited
State:
Messages: 0
Bytes: 0 B
FirstSeq: 0
LastSeq: 0
Active Consumers: 0
12:35:50 ~/repos/jetstream/nats master
I used nats stream delete --force from bash-scripts to remove a stream before i re-created it.
in 0.0.14 --force allowed me to not stop because is was the first time and it didnt exist (or i re-created nats-server).
in 0.0.16 it shows terminal gui and ask me to select another stream
jetstream/nats/account_command.go
Line 60 in 3bdf310
This is printing stream counts not consumer counts. However consumer counts are not reported so nats-io/nats-server#1322 should expose that and then we can fix this side
The use of jq
as mentioned here fails because jq
is not installed. I was able to download it myself with wget https://github.com/stedolan/jq/releases/download/jq-1.6/jq-linux64
and otherwise run that example.
Errors like these should probably also produce error advisories, what do you think @derekcollison
Hello,
I am running into a strange issue concerning either jsm.go or my go code.
Now it just weirdly hangs while accessing a wrong api.
Make them required and make sure whatever generate the api subject handles empty inputs.
Server consumes 100% cpu and becomes un responsive. (below are two different dumps of go routines)
Version used trunk.
I was investigating an issue when creating a consumer using StartWithLastReceived.
I will continue investigating my original issue and update this one if it turns out they are related.
Filing the issue now so it's not lost...
I am using jsm to create a stream and a consumer.
Consumer creating fails for a reason that I'm currently investigating
But basically it fails whenever I use
Connect: faas-cluster to nats://localhost:4222
Subscribing to: faas-cluster/faas/faas-request at nats://localhost:4222
Error creating consumer faas on nats://localhost:4222: consumer starting position conflict
panic: Error creating consumer faas on nats://localhost:4222: consumer starting position conflict
The code involved works fine when using jsm.DeliverAllAvailable instead of jsm.StartWithLastReceived.
As soon as I use jsm.StartWithLastReceived() it fails with the above issue.
stream, err := jsm.LoadOrNewStream(
q.clusterID,
jsm.Subjects(q.clusterID+".>"),
jsm.MemoryStorage(),
jsm.MaxBytes(1*1024*1024),
jsm.LimitsRetention(),
)
...
opts := []jsm.ConsumerOption{
jsm.StartWithLastReceived(),
jsm.AckWait(q.ackWait),
jsm.AcknowledgeExplicit(),
jsm.FilterStreamBySubject(q.clusterID+"."+q.subject),
}
if q.durable != "" {
opts = append(opts, jsm.DurableName(q.durable))
}
When I then played around creating the consumer manually using nats the tool times out.
./nats -s 0.0.0.0:4222 consumer add faas-cluster TEST --pull --deliver last --filter faas-cluster.faas-reques --max-deliver=-1
nats: error: Consumer creation failed: nats: timeout
Cpu goes up to 100%
Processes: 647 total, 4 running, 643 sleeping, 4191 threads 15:33:13
Load Avg: 3.42, 3.54, 3.30 CPU usage: 10.75% user, 4.1% sys, 85.22% idle SharedLibs: 483M resident, 75M data, 51M linkedit. MemRegions: 613025 total, 15G resident, 201M private, 7838M shared. PhysMem: 48G used (6787M wired), 16G unused.
VM: 4494G vsize, 1879M framework vsize, 125577881(0) swapins, 130489638(0) swapouts. Networks: packets: 134618199/133G in, 165927956/128G out. Disks: 12699283/700G read, 28240367/920G written.
PID COMMAND %CPU TIME #TH #WQ #POR MEM PURG CMPR PGRP PPID STATE BOOSTS %CPU_ME %CPU_OTHRS UID FAUL COW MSGS MSGR SYSBSD SYSM CSW PAGE IDLE POWER INSTRS CYCLES USER #MRE RPRV VPRV VSIZ KPRV KSHR
13034 nats-server 99.8 05:20.68 10/1 0 36 4112K 0B 0B 13034 592 running *0[1] 0.00000 0.00000 501 4560 737 71 27 59097+ 138 97540+ 0 0 99.8 5959340410 3132506637 matthiashanel N/A N/A N/A N/A N/A N/A
ctrl c seems to not work anymore either.
Below are two traces: first one with ctrl+\ to dump the stacks
The second one I do ctrl+c before ctrl+, there the stack seems a little more interesting. (waiting for a lock?)
rm -rf test ; ./nats-server -js -DVV -sd ./test
[13034] 2020/04/08 15:27:45.437728 [INF] Starting nats-server version 2.2.0-beta.7
[13034] 2020/04/08 15:27:45.437812 [DBG] Go build version go1.14.1
[13034] 2020/04/08 15:27:45.437815 [INF] Git commit [not set]
[13034] 2020/04/08 15:27:45.437825 [INF] Starting JetStream
[13034] 2020/04/08 15:27:45.437838 [DBG] JetStream creating dynamic configuration - 75% of system memory, 1.00 TB disk
[13034] 2020/04/08 15:27:45.438066 [DBG] Created system account: "$SYS"
[13034] 2020/04/08 15:27:45.438148 [TRC] SYSTEM - <<- [SUB $SYS._INBOX.WWMR0d.* 2]
[13034] 2020/04/08 15:27:45.438175 [TRC] SYSTEM - <<- [SUB $SYS.SERVER.ACCOUNT.*.CONNS 3]
[13034] 2020/04/08 15:27:45.438188 [TRC] SYSTEM - <<- [SUB $SYS._INBOX_.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP 4]
[13034] 2020/04/08 15:27:45.438193 [TRC] SYSTEM - <<- [SUB $SYS.REQ.ACCOUNT.*.CONNS 5]
[13034] 2020/04/08 15:27:45.438198 [TRC] SYSTEM - <<- [SUB $SYS.REQ.ACCOUNT.NSUBS 6]
[13034] 2020/04/08 15:27:45.438201 [TRC] SYSTEM - <<- [SUB $SYS.SERVER.*.SHUTDOWN 7]
[13034] 2020/04/08 15:27:45.438205 [TRC] SYSTEM - <<- [SUB $SYS.ACCOUNT.*.CLAIMS.UPDATE 8]
[13034] 2020/04/08 15:27:45.438212 [TRC] SYSTEM - <<- [SUB $SYS.REQ.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 9]
[13034] 2020/04/08 15:27:45.438219 [TRC] SYSTEM - <<- [SUB $SYS.REQ.SERVER.PING 10]
[13034] 2020/04/08 15:27:45.438227 [TRC] SYSTEM - <<- [SUB $SYS.ACCOUNT.*.LEAFNODE.CONNECT 11]
[13034] 2020/04/08 15:27:45.438232 [TRC] SYSTEM - <<- [SUB $SYS.LATENCY.M2.WWMR0d 12]
[13034] 2020/04/08 15:27:45.438239 [TRC] SYSTEM - <<- [SUB $SYS.DEBUG.SUBSCRIBERS 13]
[13034] 2020/04/08 15:27:45.438259 [TRC] SYSTEM - <<- [SUB $JS.ENABLED 14]
[13034] 2020/04/08 15:27:45.438266 [TRC] SYSTEM - <<- [SUB $JS.INFO 15]
[13034] 2020/04/08 15:27:45.438272 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.*.CREATE 16]
[13034] 2020/04/08 15:27:45.438276 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.LIST 17]
[13034] 2020/04/08 15:27:45.438279 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.*.INFO 18]
[13034] 2020/04/08 15:27:45.438283 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.*.DELETE 19]
[13034] 2020/04/08 15:27:45.438286 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CREATE 20]
[13034] 2020/04/08 15:27:45.438290 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.UPDATE 21]
[13034] 2020/04/08 15:27:45.438294 [TRC] SYSTEM - <<- [SUB $JS.STREAM.LIST 22]
[13034] 2020/04/08 15:27:45.438297 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.INFO 23]
[13034] 2020/04/08 15:27:45.438301 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.DELETE 24]
[13034] 2020/04/08 15:27:45.438304 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.PURGE 25]
[13034] 2020/04/08 15:27:45.438308 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.MSG.DELETE 26]
[13034] 2020/04/08 15:27:45.438314 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMER.*.CREATE 27]
[13034] 2020/04/08 15:27:45.444681 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.EPHEMERAL.CONSUMER.CREATE 28]
[13034] 2020/04/08 15:27:45.438386 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.ACCOUNT.$SYS.CONNS 366]
[13034] 2020/04/08 15:27:45.444695 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMERS 29]
[13034] 2020/04/08 15:27:45.444707 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMER.*.INFO 30]
[13034] 2020/04/08 15:27:45.444712 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMER.*.DELETE 31]
[13034] 2020/04/08 15:27:45.444719 [INF] ----------- JETSTREAM (Beta) -----------
[13034] 2020/04/08 15:27:45.444725 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 2,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:27:45.438145-04:00\"\n },\n \"acc\": \"$SYS\",\n \"conns\": 0,\n \"leafnodes\": 0,\n \"total_conns\": 0\n}"]
[13034] 2020/04/08 15:27:45.444726 [INF] Max Memory: 48.00 GB
[13034] 2020/04/08 15:27:45.444758 [INF] Max Storage: 1.00 TB
[13034] 2020/04/08 15:27:45.444760 [INF] Store Directory: "test/jetstream"
[13034] 2020/04/08 15:27:45.444765 [DBG] Exports:
[13034] 2020/04/08 15:27:45.444766 [DBG] $JS.ENABLED
[13034] 2020/04/08 15:27:45.444768 [DBG] $JS.INFO
[13034] 2020/04/08 15:27:45.444770 [DBG] $JS.TEMPLATE.*.CREATE
[13034] 2020/04/08 15:27:45.444772 [DBG] $JS.TEMPLATE.LIST
[13034] 2020/04/08 15:27:45.445121 [DBG] $JS.TEMPLATE.*.INFO
[13034] 2020/04/08 15:27:45.445125 [DBG] $JS.TEMPLATE.*.DELETE
[13034] 2020/04/08 15:27:45.445127 [DBG] $JS.STREAM.*.CREATE
[13034] 2020/04/08 15:27:45.445129 [DBG] $JS.STREAM.*.UPDATE
[13034] 2020/04/08 15:27:45.445132 [DBG] $JS.STREAM.LIST
[13034] 2020/04/08 15:27:45.445133 [DBG] $JS.STREAM.*.INFO
[13034] 2020/04/08 15:27:45.445135 [DBG] $JS.STREAM.*.DELETE
[13034] 2020/04/08 15:27:45.445137 [DBG] $JS.STREAM.*.PURGE
[13034] 2020/04/08 15:27:45.445138 [DBG] $JS.STREAM.*.MSG.DELETE
[13034] 2020/04/08 15:27:45.445141 [DBG] $JS.STREAM.*.CONSUMER.*.CREATE
[13034] 2020/04/08 15:27:45.445142 [DBG] $JS.STREAM.*.EPHEMERAL.CONSUMER.CREATE
[13034] 2020/04/08 15:27:45.445144 [DBG] $JS.STREAM.*.CONSUMERS
[13034] 2020/04/08 15:27:45.445146 [DBG] $JS.STREAM.*.CONSUMER.*.INFO
[13034] 2020/04/08 15:27:45.450960 [DBG] $JS.STREAM.*.CONSUMER.*.DELETE
[13034] 2020/04/08 15:27:45.450969 [INF] ----------------------------------------
[13034] 2020/04/08 15:27:45.451066 [DBG] Enabled JetStream for account "$G"
[13034] 2020/04/08 15:27:45.451074 [DBG] Max Memory: 48.00 GB
[13034] 2020/04/08 15:27:45.451076 [DBG] Max Storage: 1.00 TB
[13034] 2020/04/08 15:27:45.451110 [INF] Upgrading storage directory structure for "$G"
[13034] 2020/04/08 15:27:45.451278 [INF] Recovering JetStream state for account "$G"
[13034] 2020/04/08 15:27:45.451375 [INF] JetStream state for account "$G" recovered
[13034] 2020/04/08 15:27:45.451578 [INF] Listening for client connections on 0.0.0.0:4222
[13034] 2020/04/08 15:27:45.451582 [INF] Server id is NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP
[13034] 2020/04/08 15:27:45.451584 [INF] Server is ready
[13034] 2020/04/08 15:27:45.451588 [DBG] Get non local IPs for "0.0.0.0"
[13034] 2020/04/08 15:27:45.451780 [DBG] ip=2604:2000:1201:a4ca:c01:aab0:cbd4:cdee
[13034] 2020/04/08 15:27:45.451783 [DBG] ip=2604:2000:1201:a4ca:ccd:e38c:b660:51eb
[13034] 2020/04/08 15:27:45.451785 [DBG] ip=2604:2000:1201:a4ca::3fb
[13034] 2020/04/08 15:27:45.451787 [DBG] ip=192.168.1.111
[13034] 2020/04/08 15:27:45.451789 [DBG] ip=2604:2000:1201:a4ca:98a:277c:af08:fc99
[13034] 2020/04/08 15:27:45.451792 [DBG] ip=2604:2000:1201:a4ca:8909:e45e:1d2e:1f03
[13034] 2020/04/08 15:27:45.454751 [DBG] ip=2604:2000:1201:a4ca:4144:f953:6c7b:4d4
[13034] 2020/04/08 15:27:45.454757 [DBG] ip=2604:2000:1201:a4ca:e4ac:2fe5:737f:f213
[13034] 2020/04/08 15:27:45.454901 [DBG] ip=192.168.64.1
[13034] 2020/04/08 15:27:45.454907 [DBG] ip=fd8a:db99:b964:cc77:14f0:15d0:3624:cc8e
[13034] 2020/04/08 15:27:45.454909 [DBG] ip=fd8a:db99:b964:cc77:6163:e37f:e697:263
[13034] 2020/04/08 15:27:45.454911 [DBG] ip=fd8a:db99:b964:cc77:ec83:59b9:fd49:cfa5
[13034] 2020/04/08 15:27:45.454913 [DBG] ip=fd8a:db99:b964:cc77:285b:585a:fa66:b3a9
[13034] 2020/04/08 15:27:45.454915 [DBG] ip=fd8a:db99:b964:cc77:c0fb:dc20:efe5:a2a5
[13034] 2020/04/08 15:27:45.454917 [DBG] ip=fd8a:db99:b964:cc77:3d36:1b5f:ba53:baa5
[13034] 2020/04/08 15:27:48.361664 [DBG] [::1]:55505 - cid:3 - Client connection created
[13034] 2020/04/08 15:27:48.362437 [TRC] [::1]:55505 - cid:3 - <<- [CONNECT {"verbose":false,"pedantic":false,"tls_required":false,"name":"faas-worker-MacBook-Pro_local","lang":"go","version":"1.9.2","protocol":1,"echo":true}]
[13034] 2020/04/08 15:27:48.362577 [TRC] [::1]:55505 - cid:3 - <<- [PING]
[13034] 2020/04/08 15:27:48.362582 [TRC] [::1]:55505 - cid:3 - ->> [PONG]
[13034] 2020/04/08 15:27:48.362889 [TRC] [::1]:55505 - cid:3 - <<- [SUB _INBOX.wvmQ7Wep77kx4INmQCwtyR 1]
[13034] 2020/04/08 15:27:48.362946 [TRC] [::1]:55505 - cid:3 - <<- [UNSUB 1 1]
[13034] 2020/04/08 15:27:48.362976 [TRC] [::1]:55505 - cid:3 - <<- [PUB $JS.ENABLED _INBOX.wvmQ7Wep77kx4INmQCwtyR 0]
[13034] 2020/04/08 15:27:48.362980 [TRC] [::1]:55505 - cid:3 - <<- MSG_PAYLOAD: [""]
[13034] 2020/04/08 15:27:48.363164 [TRC] SYSTEM - <<- [PUB _INBOX.wvmQ7Wep77kx4INmQCwtyR 3]
[13034] 2020/04/08 15:27:48.363173 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["+OK"]
[13034] 2020/04/08 15:27:48.363184 [DBG] [::1]:55505 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '1'
[13034] 2020/04/08 15:27:48.363189 [TRC] [::1]:55505 - cid:3 - ->> [MSG _INBOX.wvmQ7Wep77kx4INmQCwtyR 1 3]
[13034] 2020/04/08 15:27:48.363192 [TRC] [::1]:55505 - cid:3 - <-> [DELSUB 1]
[13034] 2020/04/08 15:27:48.363438 [TRC] [::1]:55505 - cid:3 - <<- [SUB _INBOX.wvmQ7Wep77kx4INmQCwu17 2]
[13034] 2020/04/08 15:27:48.363442 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 436]
[13034] 2020/04/08 15:27:48.363467 [TRC] [::1]:55505 - cid:3 - <<- [UNSUB 2 1]
[13034] 2020/04/08 15:27:48.363503 [TRC] [::1]:55505 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.INFO _INBOX.wvmQ7Wep77kx4INmQCwu17 0]
[13034] 2020/04/08 15:27:48.363507 [TRC] [::1]:55505 - cid:3 - <<- MSG_PAYLOAD: [""]
[13034] 2020/04/08 15:27:48.363512 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydCqC\",\n \"timestamp\": \"2020-04-08T19:27:48.363086Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55505,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.ENABLED\",\n \"response\": \"+OK\"\n}"]
[13034] 2020/04/08 15:27:48.363595 [TRC] SYSTEM - <<- [PUB _INBOX.wvmQ7Wep77kx4INmQCwu17 23]
[13034] 2020/04/08 15:27:48.363616 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["-ERR 'stream not found'"]
[13034] 2020/04/08 15:27:48.363623 [DBG] [::1]:55505 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '2'
[13034] 2020/04/08 15:27:48.363654 [TRC] [::1]:55505 - cid:3 - ->> [MSG _INBOX.wvmQ7Wep77kx4INmQCwu17 2 23]
[13034] 2020/04/08 15:27:48.363657 [TRC] [::1]:55505 - cid:3 - <-> [DELSUB 2]
[13034] 2020/04/08 15:27:48.363666 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 473]
[13034] 2020/04/08 15:27:48.363680 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydCt7\",\n \"timestamp\": \"2020-04-08T19:27:48.363549Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55505,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.INFO\",\n \"response\": \"-ERR 'stream not found'\"\n}"]
[13034] 2020/04/08 15:27:48.363970 [TRC] [::1]:55505 - cid:3 - <<- [SUB _INBOX.wvmQ7Wep77kx4INmQCwu3n 3]
[13034] 2020/04/08 15:27:48.363982 [TRC] [::1]:55505 - cid:3 - <<- [UNSUB 3 1]
[13034] 2020/04/08 15:27:48.363986 [TRC] [::1]:55505 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.CREATE _INBOX.wvmQ7Wep77kx4INmQCwu3n 214]
[13034] 2020/04/08 15:27:48.364017 [TRC] [::1]:55505 - cid:3 - <<- MSG_PAYLOAD: ["{\"name\":\"faas-cluster\",\"subjects\":[\"faas-cluster.\\u003e\"],\"retention\":\"limits\",\"max_consumers\":-1,\"max_msgs\":-1,\"max_bytes\":1048576,\"max_age\":31536000000000000,\"max_msg_size\":-1,\"storage\":\"memory\",\"num_replicas\":1}"]
[13034] 2020/04/08 15:27:48.364176 [TRC] SYSTEM - <<- [PUB _INBOX.wvmQ7Wep77kx4INmQCwu3n 3]
[13034] 2020/04/08 15:27:48.364182 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["+OK"]
[13034] 2020/04/08 15:27:48.364188 [DBG] [::1]:55505 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '3'
[13034] 2020/04/08 15:27:48.364191 [TRC] [::1]:55505 - cid:3 - ->> [MSG _INBOX.wvmQ7Wep77kx4INmQCwu3n 3 3]
[13034] 2020/04/08 15:27:48.364194 [TRC] [::1]:55505 - cid:3 - <-> [DELSUB 3]
[13034] 2020/04/08 15:27:48.364201 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 715]
[13034] 2020/04/08 15:27:48.364216 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydCw2\",\n \"timestamp\": \"2020-04-08T19:27:48.364142Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55505,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.CREATE\",\n \"request\": \"{\\\"name\\\":\\\"faas-cluster\\\",\\\"subjects\\\":[\\\"faas-cluster.\\\\u003e\\\"],\\\"retention\\\":\\\"limits\\\",\\\"max_consumers\\\":-1,\\\"max_msgs\\\":-1,\\\"max_bytes\\\":1048576,\\\"max_age\\\":31536000000000000,\\\"max_msg_size\\\":-1,\\\"storage\\\":\\\"memory\\\",\\\"num_replicas\\\":1}\",\n \"response\": \"+OK\"\n}"]
[13034] 2020/04/08 15:27:48.364335 [TRC] [::1]:55505 - cid:3 - <<- [SUB _INBOX.wvmQ7Wep77kx4INmQCwu6T 4]
[13034] 2020/04/08 15:27:48.364347 [TRC] [::1]:55505 - cid:3 - <<- [UNSUB 4 1]
[13034] 2020/04/08 15:27:48.364351 [TRC] [::1]:55505 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.INFO _INBOX.wvmQ7Wep77kx4INmQCwu6T 0]
[13034] 2020/04/08 15:27:48.364354 [TRC] [::1]:55505 - cid:3 - <<- MSG_PAYLOAD: [""]
[13034] 2020/04/08 15:27:48.364477 [TRC] SYSTEM - <<- [PUB _INBOX.wvmQ7Wep77kx4INmQCwu6T 421]
[13034] 2020/04/08 15:27:48.364523 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"config\": {\n \"name\": \"faas-cluster\",\n \"subjects\": [\n \"faas-cluster.\\u003e\"\n ],\n \"retention\": \"limits\",\n \"max_consumers\": -1,\n \"max_msgs\": -1,\n \"max_bytes\": 1048576,\n \"max_age\": 31536000000000000,\n \"max_msg_size\": -1,\n \"storage\": \"memory\",\n \"num_replicas\": 1\n },\n \"state\": {\n \"messages\": 0,\n \"bytes\": 0,\n \"first_seq\": 0,\n \"last_seq\": 0,\n \"consumer_count\": 0\n }\n}"]
[13034] 2020/04/08 15:27:48.364529 [DBG] [::1]:55505 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '4'
[13034] 2020/04/08 15:27:48.364549 [TRC] [::1]:55505 - cid:3 - ->> [MSG _INBOX.wvmQ7Wep77kx4INmQCwu6T 4 421]
[13034] 2020/04/08 15:27:48.364551 [TRC] [::1]:55505 - cid:3 - <-> [DELSUB 4]
[13034] 2020/04/08 15:27:48.364560 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 936]
[13034] 2020/04/08 15:27:48.364583 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydCyx\",\n \"timestamp\": \"2020-04-08T19:27:48.364433Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55505,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.INFO\",\n \"response\": \"{\\n \\\"config\\\": {\\n \\\"name\\\": \\\"faas-cluster\\\",\\n \\\"subjects\\\": [\\n \\\"faas-cluster.\\\\u003e\\\"\\n ],\\n \\\"retention\\\": \\\"limits\\\",\\n \\\"max_consumers\\\": -1,\\n \\\"max_msgs\\\": -1,\\n \\\"max_bytes\\\": 1048576,\\n \\\"max_age\\\": 31536000000000000,\\n \\\"max_msg_size\\\": -1,\\n \\\"storage\\\": \\\"memory\\\",\\n \\\"num_replicas\\\": 1\\n },\\n \\\"state\\\": {\\n \\\"messages\\\": 0,\\n \\\"bytes\\\": 0,\\n \\\"first_seq\\\": 0,\\n \\\"last_seq\\\": 0,\\n \\\"consumer_count\\\": 0\\n }\\n}\"\n}"]
[13034] 2020/04/08 15:27:48.364726 [TRC] [::1]:55505 - cid:3 - <<- [SUB _INBOX.wvmQ7Wep77kx4INmQCwu99 5]
[13034] 2020/04/08 15:27:48.364735 [TRC] [::1]:55505 - cid:3 - <<- [UNSUB 5 1]
[13034] 2020/04/08 15:27:48.364742 [TRC] [::1]:55505 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.CONSUMER.faas.INFO _INBOX.wvmQ7Wep77kx4INmQCwu99 0]
[13034] 2020/04/08 15:27:48.364745 [TRC] [::1]:55505 - cid:3 - <<- MSG_PAYLOAD: [""]
[13034] 2020/04/08 15:27:48.364786 [TRC] SYSTEM - <<- [PUB _INBOX.wvmQ7Wep77kx4INmQCwu99 25]
[13034] 2020/04/08 15:27:48.364790 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["-ERR 'consumer not found'"]
[13034] 2020/04/08 15:27:48.364798 [DBG] [::1]:55505 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '5'
[13034] 2020/04/08 15:27:48.364801 [TRC] [::1]:55505 - cid:3 - ->> [MSG _INBOX.wvmQ7Wep77kx4INmQCwu99 5 25]
[13034] 2020/04/08 15:27:48.364803 [TRC] [::1]:55505 - cid:3 - <-> [DELSUB 5]
[13034] 2020/04/08 15:27:48.364814 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 489]
[13034] 2020/04/08 15:27:48.364823 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydD1s\",\n \"timestamp\": \"2020-04-08T19:27:48.364765Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55505,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.CONSUMER.faas.INFO\",\n \"response\": \"-ERR 'consumer not found'\"\n}"]
[13034] 2020/04/08 15:27:48.364978 [TRC] [::1]:55505 - cid:3 - <<- [SUB _INBOX.wvmQ7Wep77kx4INmQCwuBp 6]
[13034] 2020/04/08 15:27:48.364989 [TRC] [::1]:55505 - cid:3 - <<- [UNSUB 6 1]
[13034] 2020/04/08 15:27:48.364999 [TRC] [::1]:55505 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.CONSUMER.faas.CREATE _INBOX.wvmQ7Wep77kx4INmQCwuBp 278]
[13034] 2020/04/08 15:27:48.365010 [TRC] [::1]:55505 - cid:3 - <<- MSG_PAYLOAD: ["{\"stream_name\":\"faas-cluster\",\"config\":{\"delivery_subject\":\"\",\"durable_name\":\"faas\",\"start_time\":\"0001-01-01T00:00:00Z\",\"deliver_all\":true,\"deliver_last\":true,\"ack_policy\":\"explicit\",\"ack_wait\":30000000000,\"filter_subject\":\"faas-cluster.faas-request\",\"replay_policy\":\"instant\"}}"]
[13034] 2020/04/08 15:27:48.365155 [TRC] SYSTEM - <<- [PUB _INBOX.wvmQ7Wep77kx4INmQCwuBp 42]
[13034] 2020/04/08 15:27:48.365163 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["-ERR 'consumer starting position conflict'"]
[13034] 2020/04/08 15:27:48.365172 [DBG] [::1]:55505 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '6'
[13034] 2020/04/08 15:27:48.365176 [TRC] [::1]:55505 - cid:3 - ->> [MSG _INBOX.wvmQ7Wep77kx4INmQCwuBp 6 42]
[13034] 2020/04/08 15:27:48.365180 [TRC] [::1]:55505 - cid:3 - <-> [DELSUB 6]
[13034] 2020/04/08 15:27:48.365187 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 838]
[13034] 2020/04/08 15:27:48.365209 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydD4n\",\n \"timestamp\": \"2020-04-08T19:27:48.36512Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55505,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.CONSUMER.faas.CREATE\",\n \"request\": \"{\\\"stream_name\\\":\\\"faas-cluster\\\",\\\"config\\\":{\\\"delivery_subject\\\":\\\"\\\",\\\"durable_name\\\":\\\"faas\\\",\\\"start_time\\\":\\\"0001-01-01T00:00:00Z\\\",\\\"deliver_all\\\":true,\\\"deliver_last\\\":true,\\\"ack_policy\\\":\\\"explicit\\\",\\\"ack_wait\\\":30000000000,\\\"filter_subject\\\":\\\"faas-cluster.faas-request\\\",\\\"replay_policy\\\":\\\"instant\\\"}}\",\n \"response\": \"-ERR 'consumer starting position conflict'\"\n}"]
[13034] 2020/04/08 15:27:48.368015 [DBG] [::1]:55505 - cid:3 - Client connection closed
[13034] 2020/04/08 15:27:52.668169 [DBG] 127.0.0.1:55510 - cid:6 - Client connection created
[13034] 2020/04/08 15:27:52.668637 [TRC] 127.0.0.1:55510 - cid:6 - <<- [CONNECT {"verbose":false,"pedantic":false,"tls_required":false,"name":"NATS CLI","lang":"go","version":"1.9.1","protocol":1,"echo":true}]
[13034] 2020/04/08 15:27:52.668665 [TRC] 127.0.0.1:55510 - cid:6 - <<- [PING]
[13034] 2020/04/08 15:27:52.668672 [TRC] 127.0.0.1:55510 - cid:6 - ->> [PONG]
[13034] 2020/04/08 15:27:52.668854 [TRC] 127.0.0.1:55510 - cid:6 - <<- [SUB _INBOX.J7eVraDHR9wJP3hNybVEgs 1]
[13034] 2020/04/08 15:27:52.668871 [TRC] 127.0.0.1:55510 - cid:6 - <<- [UNSUB 1 1]
[13034] 2020/04/08 15:27:52.668881 [TRC] 127.0.0.1:55510 - cid:6 - <<- [PUB $JS.STREAM.LIST _INBOX.J7eVraDHR9wJP3hNybVEgs 0]
[13034] 2020/04/08 15:27:52.668885 [TRC] 127.0.0.1:55510 - cid:6 - <<- MSG_PAYLOAD: [""]
[13034] 2020/04/08 15:27:52.668983 [TRC] SYSTEM - <<- [PUB _INBOX.J7eVraDHR9wJP3hNybVEgs 20]
[13034] 2020/04/08 15:27:52.668995 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["[\n \"faas-cluster\"\n]"]
[13034] 2020/04/08 15:27:52.669012 [DBG] 127.0.0.1:55510 - cid:6 - Auto-unsubscribe limit of 1 reached for sid '1'
[13034] 2020/04/08 15:27:52.669021 [TRC] 127.0.0.1:55510 - cid:6 - ->> [MSG _INBOX.J7eVraDHR9wJP3hNybVEgs 1 20]
[13034] 2020/04/08 15:27:52.669025 [TRC] 127.0.0.1:55510 - cid:6 - <-> [DELSUB 1]
[13034] 2020/04/08 15:27:52.669039 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 446]
[13034] 2020/04/08 15:27:52.669049 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"wGC1NOc2rFowaApa3ydD7i\",\n \"timestamp\": \"2020-04-08T19:27:52.668922Z\",\n \"server\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"client\": {\n \"host\": \"127.0.0.1\",\n \"port\": 55510,\n \"cid\": 6,\n \"account\": \"$G\",\n \"name\": \"NATS CLI\",\n \"lang\": \"go\",\n \"version\": \"1.9.1\"\n },\n \"subject\": \"$JS.STREAM.LIST\",\n \"response\": \"[\\n \\\"faas-cluster\\\"\\n]\"\n}"]
[13034] 2020/04/08 15:27:52.669434 [TRC] 127.0.0.1:55510 - cid:6 - <<- [SUB _INBOX.J7eVraDHR9wJP3hNybVEiR 2]
[13034] 2020/04/08 15:27:52.669456 [TRC] 127.0.0.1:55510 - cid:6 - <<- [UNSUB 2 1]
[13034] 2020/04/08 15:27:52.669470 [TRC] 127.0.0.1:55510 - cid:6 - <<- [PUB $JS.STREAM.faas-cluster.CONSUMER.TEST.CREATE _INBOX.J7eVraDHR9wJP3hNybVEiR 252]
[13034] 2020/04/08 15:27:52.669484 [TRC] 127.0.0.1:55510 - cid:6 - <<- MSG_PAYLOAD: ["{\"stream_name\":\"faas-cluster\",\"config\":{\"delivery_subject\":\"\",\"durable_name\":\"TEST\",\"start_time\":\"0001-01-01T00:00:00Z\",\"deliver_last\":true,\"ack_policy\":\"explicit\",\"max_deliver\":-1,\"filter_subject\":\"faas-cluster.faas-reques\",\"replay_policy\":\"instant\"}}"]
[13034] 2020/04/08 15:27:54.947608 [DBG] 127.0.0.1:55510 - cid:6 - Client Ping Timer
[13034] 2020/04/08 15:27:54.947654 [TRC] 127.0.0.1:55510 - cid:6 - ->> [PING]
[13034] 2020/04/08 15:28:15.445822 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 662]
[13034] 2020/04/08 15:28:15.445871 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 3,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:28:15.445612-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 8871936,\n \"cores\": 16,\n \"cpu\": 99.2,\n \"connections\": 1,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 59,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:28:45.446677 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 663]
[13034] 2020/04/08 15:28:45.446751 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 4,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:28:45.446629-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9109504,\n \"cores\": 16,\n \"cpu\": 100.1,\n \"connections\": 1,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 59,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:29:15.449158 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 662]
[13034] 2020/04/08 15:29:15.449263 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 5,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:29:15.449021-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9187328,\n \"cores\": 16,\n \"cpu\": 99.2,\n \"connections\": 1,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 59,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:29:45.452298 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 662]
[13034] 2020/04/08 15:29:45.452332 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 6,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:29:45.452246-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9371648,\n \"cores\": 16,\n \"cpu\": 98.8,\n \"connections\": 1,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 59,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:29:54.951463 [DBG] 127.0.0.1:55510 - cid:6 - Client Ping Timer
[13034] 2020/04/08 15:29:54.951491 [TRC] 127.0.0.1:55510 - cid:6 - ->> [PING]
[13034] 2020/04/08 15:29:54.951552 [DBG] 127.0.0.1:55510 - cid:6 - Error flushing: writev tcp 127.0.0.1:4222->127.0.0.1:55510: writev: broken pipe
[13034] 2020/04/08 15:29:54.951570 [DBG] 127.0.0.1:55510 - cid:6 - Client connection closed
[13034] 2020/04/08 15:29:54.951664 [TRC] 127.0.0.1:55510 - cid:6 - <-> [DELSUB 2]
[13034] 2020/04/08 15:30:15.457741 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 662]
[13034] 2020/04/08 15:30:15.457767 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 7,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:30:15.457692-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9449472,\n \"cores\": 16,\n \"cpu\": 99.5,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:30:45.460380 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 663]
[13034] 2020/04/08 15:30:45.460453 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 8,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:30:45.460314-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9490432,\n \"cores\": 16,\n \"cpu\": 100.1,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:31:15.464184 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 663]
[13034] 2020/04/08 15:31:15.464205 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 9,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:31:15.464142-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9572352,\n \"cores\": 16,\n \"cpu\": 100.1,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:31:45.468377 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 663]
[13034] 2020/04/08 15:31:45.468403 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 10,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:31:45.468332-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9646080,\n \"cores\": 16,\n \"cpu\": 99.5,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:32:15.470393 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 663]
[13034] 2020/04/08 15:32:15.470463 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 11,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:32:15.470307-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9707520,\n \"cores\": 16,\n \"cpu\": 98.8,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:32:45.474783 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 664]
[13034] 2020/04/08 15:32:45.474805 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 12,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:32:45.474727-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9801728,\n \"cores\": 16,\n \"cpu\": 100.1,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
[13034] 2020/04/08 15:33:15.482697 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP.STATSZ 663]
[13034] 2020/04/08 15:33:15.482724 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NAKMI4V4HHW5XAXHAZY4IE5X2EG7VAGSS3LNPTH2E4KUQO7VIKRNZGHP\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 13,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:33:15.482529-04:00\"\n },\n \"statsz\": {\n \"start\": \"2020-04-08T15:27:45.437541-04:00\",\n \"mem\": 9834496,\n \"cores\": 16,\n \"cpu\": 99.1,\n \"connections\": 0,\n \"total_connections\": 2,\n \"active_accounts\": 2,\n \"subscriptions\": 58,\n \"sent\": {\n \"msgs\": 7,\n \"bytes\": 537\n },\n \"received\": {\n \"msgs\": 7,\n \"bytes\": 492\n },\n \"slow_consumers\": 0\n }\n}"]
^\SIGQUIT: quit
PC=0x7fff66ca6ce6 m=0 sigcode=0
goroutine 0 [idle]:
runtime.pthread_cond_wait(0x1a35908, 0x1a358c8, 0x7ffe00000000)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/sys_darwin.go:390 +0x39
runtime.semasleep(0xffffffffffffffff, 0x7ffeefbff420)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/os_darwin.go:63 +0x85
runtime.notesleep(0x1a356c8)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/lock_sema.go:173 +0xe0
runtime.stoplockedm()
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/proc.go:1971 +0x88
runtime.schedule()
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/proc.go:2454 +0x4a6
runtime.park_m(0xc000001b00)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/proc.go:2690 +0x9d
runtime.mcall(0x1065ea6)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/asm_amd64.s:318 +0x5b
goroutine 1 [IO wait]:
internal/poll.runtime_pollWait(0x2675f18, 0x72, 0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/netpoll.go:203 +0x55
internal/poll.(*pollDesc).wait(0xc000032798, 0x72, 0x0, 0x0, 0x15d244e)
/usr/local/Cellar/go/1.14.1/libexec/src/internal/poll/fd_poll_runtime.go:87 +0x45
internal/poll.(*pollDesc).waitRead(...)
/usr/local/Cellar/go/1.14.1/libexec/src/internal/poll/fd_poll_runtime.go:92
internal/poll.(*FD).Accept(0xc000032780, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/internal/poll/fd_unix.go:384 +0x1d4
net.(*netFD).accept(0xc000032780, 0x104010e, 0xc0000efc18, 0x10653f0)
/usr/local/Cellar/go/1.14.1/libexec/src/net/fd_unix.go:238 +0x42
net.(*TCPListener).accept(0xc00000ff20, 0xc0000efc70, 0x1499ced, 0xc000000000)
/usr/local/Cellar/go/1.14.1/libexec/src/net/tcpsock_posix.go:139 +0x32
net.(*TCPListener).Accept(0xc00000ff20, 0xc000198a01, 0xc0001860f0, 0x0, 0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/net/tcpsock.go:261 +0x64
github.com/nats-io/nats-server/v2/server.(*Server).AcceptLoop(0xc0000f8800, 0x0)
/Users/matthiashanel/repos/nats-server/server/server.go:1509 +0x841
github.com/nats-io/nats-server/v2/server.(*Server).Start(0xc0000f8800)
/Users/matthiashanel/repos/nats-server/server/server.go:1305 +0x95f
github.com/nats-io/nats-server/v2/server.Run(...)
/Users/matthiashanel/repos/nats-server/server/service.go:21
main.main()
/Users/matthiashanel/repos/nats-server/main.go:114 +0x141
goroutine 7 [syscall]:
os/signal.signal_recv(0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/sigqueue.go:144 +0x96
os/signal.loop()
/usr/local/Cellar/go/1.14.1/libexec/src/os/signal/signal_unix.go:23 +0x22
created by os/signal.Notify.func1
/usr/local/Cellar/go/1.14.1/libexec/src/os/signal/signal.go:127 +0x44
goroutine 9 [select]:
github.com/nats-io/nats-server/v2/server.(*Server).handleSignals.func1(0xc00008a780, 0xc0000f8800)
/Users/matthiashanel/repos/nats-server/server/signal.go:47 +0xbc
created by github.com/nats-io/nats-server/v2/server.(*Server).handleSignals
/Users/matthiashanel/repos/nats-server/server/signal.go:45 +0x11a
goroutine 10 [select]:
github.com/nats-io/nats-server/v2/server.(*Server).startGWReplyMapExpiration.func1()
/Users/matthiashanel/repos/nats-server/server/gateway.go:2973 +0x15b
created by github.com/nats-io/nats-server/v2/server.(*Server).startGoRoutine
/Users/matthiashanel/repos/nats-server/server/server.go:2252 +0xad
goroutine 11 [select]:
github.com/nats-io/nats-server/v2/server.(*Server).internalSendLoop(0xc0000f8800, 0xc0000ba1f8)
/Users/matthiashanel/repos/nats-server/server/events.go:242 +0x2d8
created by github.com/nats-io/nats-server/v2/server.(*Server).setSystemAccount
/Users/matthiashanel/repos/nats-server/server/server.go:896 +0x2ab
goroutine 15 [select]:
github.com/nats-io/nats-server/v2/server.(*Stream).internalSendLoop(0xc00027c000)
/Users/matthiashanel/repos/nats-server/server/stream.go:634 +0x1b3
created by github.com/nats-io/nats-server/v2/server.(*Stream).setupSendCapabilities
/Users/matthiashanel/repos/nats-server/server/stream.go:602 +0xad
goroutine 34 [runnable]:
github.com/nats-io/nats-server/v2/server.(*Consumer).selectSubjectLast(0xc00042a000)
/Users/matthiashanel/repos/nats-server/server/consumer.go:1313 +0x152
github.com/nats-io/nats-server/v2/server.(*Consumer).selectStartingSeqNo(0xc00042a000)
/Users/matthiashanel/repos/nats-server/server/consumer.go:1334 +0xff
github.com/nats-io/nats-server/v2/server.(*Stream).AddConsumer(0xc00027c000, 0xc000426010, 0x4, 0xc000408101, 0x4)
/Users/matthiashanel/repos/nats-server/server/consumer.go:323 +0x612
github.com/nats-io/nats-server/v2/server.(*Server).jsCreateConsumerRequest(0xc0000f8800, 0xc0000bbef0, 0xc0001cd300, 0xc0004081b0, 0x2c, 0xc0004041c0, 0x1d, 0xc000302285, 0xfc, 0x17b)
/Users/matthiashanel/repos/nats-server/server/jetstream_api.go:580 +0x62b
github.com/nats-io/nats-server/v2/server.(*client).deliverMsg(0xc0001cd300, 0xc0000bbef0, 0xc000408180, 0x2c, 0x30, 0xc0001cd5e9, 0x4b, 0x3ff, 0xc000302285, 0xfe, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:2503 +0x2f4
github.com/nats-io/nats-server/v2/server.(*client).processMsgResults(0xc0001cd300, 0xc0002181c0, 0xc000414210, 0xc000302285, 0xfe, 0x17b, 0x0, 0x0, 0x0, 0xc000408180, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:3150 +0x720
github.com/nats-io/nats-server/v2/server.(*client).processServiceImport(0xc0001cd300, 0xc00008be60, 0xc000218000, 0xc000302285, 0xfe, 0x17b)
/Users/matthiashanel/repos/nats-server/server/client.go:3016 +0x5ee
github.com/nats-io/nats-server/v2/server.(*Account).addServiceImportSub.func1(0xc00023d440, 0xc0001cd300, 0xc000408120, 0x2c, 0xc000404100, 0x1d, 0xc000302285, 0xfe, 0x17b)
/Users/matthiashanel/repos/nats-server/server/accounts.go:1047 +0x5e
github.com/nats-io/nats-server/v2/server.(*client).deliverMsg(0xc0001cd300, 0xc00023d440, 0xc000302235, 0x2c, 0x1cb, 0xc0001cd5e9, 0x57, 0x3ff, 0xc000302285, 0xfe, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:2501 +0x3fa
github.com/nats-io/nats-server/v2/server.(*client).processMsgResults(0xc0001cd300, 0xc000218000, 0xc000414150, 0xc000302285, 0xfe, 0x17b, 0x0, 0x0, 0x0, 0xc000302235, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:3150 +0x720
github.com/nats-io/nats-server/v2/server.(*client).processInboundClientMsg(0xc0001cd300, 0xc000302285, 0xfe, 0x17b, 0xc000400140)
/Users/matthiashanel/repos/nats-server/server/client.go:2876 +0x520
github.com/nats-io/nats-server/v2/server.(*client).processInboundMsg(0xc0001cd300, 0xc000302285, 0xfe, 0x17b)
/Users/matthiashanel/repos/nats-server/server/client.go:2755 +0x95
github.com/nats-io/nats-server/v2/server.(*client).parse(0xc0001cd300, 0xc000302200, 0x183, 0x200, 0x183, 0x0)
/Users/matthiashanel/repos/nats-server/server/parser.go:288 +0x17dc
github.com/nats-io/nats-server/v2/server.(*client).readLoop(0xc0001cd300)
/Users/matthiashanel/repos/nats-server/server/client.go:908 +0x333
github.com/nats-io/nats-server/v2/server.(*Server).createClient.func2()
/Users/matthiashanel/repos/nats-server/server/server.go:1896 +0x2a
created by github.com/nats-io/nats-server/v2/server.(*Server).startGoRoutine
/Users/matthiashanel/repos/nats-server/server/server.go:2252 +0xad
rax 0x104
rbx 0x2
rcx 0x7ffeefbff248
rdx 0x1b00
rdi 0x1a35908
rsi 0x260100002700
rbp 0x7ffeefbff2e0
rsp 0x7ffeefbff248
r8 0x0
r9 0xa0
r10 0x0
r11 0x202
r12 0x1a35908
r13 0x16
r14 0x260100002700
r15 0x28b7dc0
rip 0x7fff66ca6ce6
rflags 0x203
cs 0x7
fs 0x0
gs 0x0
---------- Second try with ctrl c before dumping go routines
rm -rf test ; ./nats-server -js -DVV -sd ./test
[13453] 2020/04/08 15:35:39.857073 [INF] Starting nats-server version 2.2.0-beta.7
[13453] 2020/04/08 15:35:39.857171 [DBG] Go build version go1.14.1
[13453] 2020/04/08 15:35:39.857174 [INF] Git commit [not set]
[13453] 2020/04/08 15:35:39.857184 [INF] Starting JetStream
[13453] 2020/04/08 15:35:39.857197 [DBG] JetStream creating dynamic configuration - 75% of system memory, 1.00 TB disk
[13453] 2020/04/08 15:35:39.857362 [DBG] Created system account: "$SYS"
[13453] 2020/04/08 15:35:39.857484 [TRC] SYSTEM - <<- [SUB $SYS._INBOX.2tAN4W.* 2]
[13453] 2020/04/08 15:35:39.857513 [TRC] SYSTEM - <<- [SUB $SYS.SERVER.ACCOUNT.*.CONNS 3]
[13453] 2020/04/08 15:35:39.857524 [TRC] SYSTEM - <<- [SUB $SYS._INBOX_.NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB 4]
[13453] 2020/04/08 15:35:39.857531 [TRC] SYSTEM - <<- [SUB $SYS.REQ.ACCOUNT.*.CONNS 5]
[13453] 2020/04/08 15:35:39.857536 [TRC] SYSTEM - <<- [SUB $SYS.REQ.ACCOUNT.NSUBS 6]
[13453] 2020/04/08 15:35:39.857540 [TRC] SYSTEM - <<- [SUB $SYS.SERVER.*.SHUTDOWN 7]
[13453] 2020/04/08 15:35:39.857544 [TRC] SYSTEM - <<- [SUB $SYS.ACCOUNT.*.CLAIMS.UPDATE 8]
[13453] 2020/04/08 15:35:39.857549 [TRC] SYSTEM - <<- [SUB $SYS.REQ.SERVER.NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB.STATSZ 9]
[13453] 2020/04/08 15:35:39.857556 [TRC] SYSTEM - <<- [SUB $SYS.REQ.SERVER.PING 10]
[13453] 2020/04/08 15:35:39.857564 [TRC] SYSTEM - <<- [SUB $SYS.ACCOUNT.*.LEAFNODE.CONNECT 11]
[13453] 2020/04/08 15:35:39.857569 [TRC] SYSTEM - <<- [SUB $SYS.LATENCY.M2.2tAN4W 12]
[13453] 2020/04/08 15:35:39.857573 [TRC] SYSTEM - <<- [SUB $SYS.DEBUG.SUBSCRIBERS 13]
[13453] 2020/04/08 15:35:39.857592 [TRC] SYSTEM - <<- [SUB $JS.ENABLED 14]
[13453] 2020/04/08 15:35:39.857604 [TRC] SYSTEM - <<- [SUB $JS.INFO 15]
[13453] 2020/04/08 15:35:39.857609 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.*.CREATE 16]
[13453] 2020/04/08 15:35:39.857613 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.LIST 17]
[13453] 2020/04/08 15:35:39.857617 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.*.INFO 18]
[13453] 2020/04/08 15:35:39.857621 [TRC] SYSTEM - <<- [SUB $JS.TEMPLATE.*.DELETE 19]
[13453] 2020/04/08 15:35:39.857624 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CREATE 20]
[13453] 2020/04/08 15:35:39.857663 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.UPDATE 21]
[13453] 2020/04/08 15:35:39.857676 [TRC] SYSTEM - <<- [SUB $JS.STREAM.LIST 22]
[13453] 2020/04/08 15:35:39.857684 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.INFO 23]
[13453] 2020/04/08 15:35:39.873109 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.DELETE 24]
[13453] 2020/04/08 15:35:39.857716 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.ACCOUNT.$SYS.CONNS 365]
[13453] 2020/04/08 15:35:39.873127 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.PURGE 25]
[13453] 2020/04/08 15:35:39.873136 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.MSG.DELETE 26]
[13453] 2020/04/08 15:35:39.873144 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMER.*.CREATE 27]
[13453] 2020/04/08 15:35:39.873149 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"server\": {\n \"name\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"host\": \"0.0.0.0\",\n \"id\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"ver\": \"2.2.0-beta.7\",\n \"seq\": 2,\n \"jetstream\": true,\n \"time\": \"2020-04-08T15:35:39.85748-04:00\"\n },\n \"acc\": \"$SYS\",\n \"conns\": 0,\n \"leafnodes\": 0,\n \"total_conns\": 0\n}"]
[13453] 2020/04/08 15:35:39.873149 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.EPHEMERAL.CONSUMER.CREATE 28]
[13453] 2020/04/08 15:35:39.873176 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMERS 29]
[13453] 2020/04/08 15:35:39.873188 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMER.*.INFO 30]
[13453] 2020/04/08 15:35:39.873194 [TRC] SYSTEM - <<- [SUB $JS.STREAM.*.CONSUMER.*.DELETE 31]
[13453] 2020/04/08 15:35:39.873199 [INF] ----------- JETSTREAM (Beta) -----------
[13453] 2020/04/08 15:35:39.873205 [INF] Max Memory: 48.00 GB
[13453] 2020/04/08 15:35:39.873207 [INF] Max Storage: 1.00 TB
[13453] 2020/04/08 15:35:39.873209 [INF] Store Directory: "test/jetstream"
[13453] 2020/04/08 15:35:39.873211 [DBG] Exports:
[13453] 2020/04/08 15:35:39.873213 [DBG] $JS.ENABLED
[13453] 2020/04/08 15:35:39.873215 [DBG] $JS.INFO
[13453] 2020/04/08 15:35:39.873216 [DBG] $JS.TEMPLATE.*.CREATE
[13453] 2020/04/08 15:35:39.873218 [DBG] $JS.TEMPLATE.LIST
[13453] 2020/04/08 15:35:39.873220 [DBG] $JS.TEMPLATE.*.INFO
[13453] 2020/04/08 15:35:39.873222 [DBG] $JS.TEMPLATE.*.DELETE
[13453] 2020/04/08 15:35:39.873224 [DBG] $JS.STREAM.*.CREATE
[13453] 2020/04/08 15:35:39.873226 [DBG] $JS.STREAM.*.UPDATE
[13453] 2020/04/08 15:35:39.873235 [DBG] $JS.STREAM.LIST
[13453] 2020/04/08 15:35:39.873237 [DBG] $JS.STREAM.*.INFO
[13453] 2020/04/08 15:35:39.873239 [DBG] $JS.STREAM.*.DELETE
[13453] 2020/04/08 15:35:39.873240 [DBG] $JS.STREAM.*.PURGE
[13453] 2020/04/08 15:35:39.873242 [DBG] $JS.STREAM.*.MSG.DELETE
[13453] 2020/04/08 15:35:39.873251 [DBG] $JS.STREAM.*.CONSUMER.*.CREATE
[13453] 2020/04/08 15:35:39.873253 [DBG] $JS.STREAM.*.EPHEMERAL.CONSUMER.CREATE
[13453] 2020/04/08 15:35:39.873254 [DBG] $JS.STREAM.*.CONSUMERS
[13453] 2020/04/08 15:35:39.873256 [DBG] $JS.STREAM.*.CONSUMER.*.INFO
[13453] 2020/04/08 15:35:39.873258 [DBG] $JS.STREAM.*.CONSUMER.*.DELETE
[13453] 2020/04/08 15:35:39.873259 [INF] ----------------------------------------
[13453] 2020/04/08 15:35:39.873333 [DBG] Enabled JetStream for account "$G"
[13453] 2020/04/08 15:35:39.873957 [DBG] Max Memory: 48.00 GB
[13453] 2020/04/08 15:35:39.873963 [DBG] Max Storage: 1.00 TB
[13453] 2020/04/08 15:35:39.873982 [INF] Upgrading storage directory structure for "$G"
[13453] 2020/04/08 15:35:39.874152 [INF] Recovering JetStream state for account "$G"
[13453] 2020/04/08 15:35:39.874243 [INF] JetStream state for account "$G" recovered
[13453] 2020/04/08 15:35:39.874406 [INF] Listening for client connections on 0.0.0.0:4222
[13453] 2020/04/08 15:35:39.874411 [INF] Server id is NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB
[13453] 2020/04/08 15:35:39.874412 [INF] Server is ready
[13453] 2020/04/08 15:35:39.874417 [DBG] Get non local IPs for "0.0.0.0"
[13453] 2020/04/08 15:35:39.874605 [DBG] ip=2604:2000:1201:a4ca:c01:aab0:cbd4:cdee
[13453] 2020/04/08 15:35:39.874608 [DBG] ip=2604:2000:1201:a4ca:ccd:e38c:b660:51eb
[13453] 2020/04/08 15:35:39.874610 [DBG] ip=2604:2000:1201:a4ca::3fb
[13453] 2020/04/08 15:35:39.874613 [DBG] ip=192.168.1.111
[13453] 2020/04/08 15:35:39.874614 [DBG] ip=2604:2000:1201:a4ca:98a:277c:af08:fc99
[13453] 2020/04/08 15:35:39.874616 [DBG] ip=2604:2000:1201:a4ca:8909:e45e:1d2e:1f03
[13453] 2020/04/08 15:35:39.874618 [DBG] ip=2604:2000:1201:a4ca:4144:f953:6c7b:4d4
[13453] 2020/04/08 15:35:39.874620 [DBG] ip=2604:2000:1201:a4ca:e4ac:2fe5:737f:f213
[13453] 2020/04/08 15:35:39.874726 [DBG] ip=192.168.64.1
[13453] 2020/04/08 15:35:39.874730 [DBG] ip=fd8a:db99:b964:cc77:14f0:15d0:3624:cc8e
[13453] 2020/04/08 15:35:39.874732 [DBG] ip=fd8a:db99:b964:cc77:6163:e37f:e697:263
[13453] 2020/04/08 15:35:39.874734 [DBG] ip=fd8a:db99:b964:cc77:ec83:59b9:fd49:cfa5
[13453] 2020/04/08 15:35:39.874736 [DBG] ip=fd8a:db99:b964:cc77:285b:585a:fa66:b3a9
[13453] 2020/04/08 15:35:39.874738 [DBG] ip=fd8a:db99:b964:cc77:c0fb:dc20:efe5:a2a5
[13453] 2020/04/08 15:35:39.874740 [DBG] ip=fd8a:db99:b964:cc77:3d36:1b5f:ba53:baa5
[13453] 2020/04/08 15:35:44.208672 [DBG] [::1]:55647 - cid:3 - Client connection created
[13453] 2020/04/08 15:35:44.209510 [TRC] [::1]:55647 - cid:3 - <<- [CONNECT {"verbose":false,"pedantic":false,"tls_required":false,"name":"faas-worker-MacBook-Pro_local","lang":"go","version":"1.9.2","protocol":1,"echo":true}]
[13453] 2020/04/08 15:35:44.209652 [TRC] [::1]:55647 - cid:3 - <<- [PING]
[13453] 2020/04/08 15:35:44.209662 [TRC] [::1]:55647 - cid:3 - ->> [PONG]
[13453] 2020/04/08 15:35:44.209927 [TRC] [::1]:55647 - cid:3 - <<- [SUB _INBOX.d2Usk0lAaxqk1iAcJPwFaq 1]
[13453] 2020/04/08 15:35:44.209951 [TRC] [::1]:55647 - cid:3 - <<- [UNSUB 1 1]
[13453] 2020/04/08 15:35:44.209958 [TRC] [::1]:55647 - cid:3 - <<- [PUB $JS.ENABLED _INBOX.d2Usk0lAaxqk1iAcJPwFaq 0]
[13453] 2020/04/08 15:35:44.209963 [TRC] [::1]:55647 - cid:3 - <<- MSG_PAYLOAD: [""]
[13453] 2020/04/08 15:35:44.210143 [TRC] SYSTEM - <<- [PUB _INBOX.d2Usk0lAaxqk1iAcJPwFaq 3]
[13453] 2020/04/08 15:35:44.210152 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["+OK"]
[13453] 2020/04/08 15:35:44.210171 [DBG] [::1]:55647 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '1'
[13453] 2020/04/08 15:35:44.210176 [TRC] [::1]:55647 - cid:3 - ->> [MSG _INBOX.d2Usk0lAaxqk1iAcJPwFaq 1 3]
[13453] 2020/04/08 15:35:44.210179 [TRC] [::1]:55647 - cid:3 - <-> [DELSUB 1]
[13453] 2020/04/08 15:35:44.210357 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 436]
[13453] 2020/04/08 15:35:44.210382 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbCS\",\n \"timestamp\": \"2020-04-08T19:35:44.210089Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55647,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.ENABLED\",\n \"response\": \"+OK\"\n}"]
[13453] 2020/04/08 15:35:44.210391 [TRC] [::1]:55647 - cid:3 - <<- [SUB _INBOX.d2Usk0lAaxqk1iAcJPwFbk 2]
[13453] 2020/04/08 15:35:44.210419 [TRC] [::1]:55647 - cid:3 - <<- [UNSUB 2 1]
[13453] 2020/04/08 15:35:44.210426 [TRC] [::1]:55647 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.INFO _INBOX.d2Usk0lAaxqk1iAcJPwFbk 0]
[13453] 2020/04/08 15:35:44.210431 [TRC] [::1]:55647 - cid:3 - <<- MSG_PAYLOAD: [""]
[13453] 2020/04/08 15:35:44.210506 [TRC] SYSTEM - <<- [PUB _INBOX.d2Usk0lAaxqk1iAcJPwFbk 23]
[13453] 2020/04/08 15:35:44.210517 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["-ERR 'stream not found'"]
[13453] 2020/04/08 15:35:44.210526 [DBG] [::1]:55647 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '2'
[13453] 2020/04/08 15:35:44.210532 [TRC] [::1]:55647 - cid:3 - ->> [MSG _INBOX.d2Usk0lAaxqk1iAcJPwFbk 2 23]
[13453] 2020/04/08 15:35:44.210535 [TRC] [::1]:55647 - cid:3 - <-> [DELSUB 2]
[13453] 2020/04/08 15:35:44.210554 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 472]
[13453] 2020/04/08 15:35:44.210589 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbEB\",\n \"timestamp\": \"2020-04-08T19:35:44.21047Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55647,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.INFO\",\n \"response\": \"-ERR 'stream not found'\"\n}"]
[13453] 2020/04/08 15:35:44.210858 [TRC] [::1]:55647 - cid:3 - <<- [SUB _INBOX.d2Usk0lAaxqk1iAcJPwFce 3]
[13453] 2020/04/08 15:35:44.210871 [TRC] [::1]:55647 - cid:3 - <<- [UNSUB 3 1]
[13453] 2020/04/08 15:35:44.210881 [TRC] [::1]:55647 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.CREATE _INBOX.d2Usk0lAaxqk1iAcJPwFce 214]
[13453] 2020/04/08 15:35:44.210898 [TRC] [::1]:55647 - cid:3 - <<- MSG_PAYLOAD: ["{\"name\":\"faas-cluster\",\"subjects\":[\"faas-cluster.\\u003e\"],\"retention\":\"limits\",\"max_consumers\":-1,\"max_msgs\":-1,\"max_bytes\":1048576,\"max_age\":31536000000000000,\"max_msg_size\":-1,\"storage\":\"memory\",\"num_replicas\":1}"]
[13453] 2020/04/08 15:35:44.211116 [TRC] SYSTEM - <<- [PUB _INBOX.d2Usk0lAaxqk1iAcJPwFce 3]
[13453] 2020/04/08 15:35:44.211125 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["+OK"]
[13453] 2020/04/08 15:35:44.211144 [DBG] [::1]:55647 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '3'
[13453] 2020/04/08 15:35:44.211150 [TRC] [::1]:55647 - cid:3 - ->> [MSG _INBOX.d2Usk0lAaxqk1iAcJPwFce 3 3]
[13453] 2020/04/08 15:35:44.211155 [TRC] [::1]:55647 - cid:3 - <-> [DELSUB 3]
[13453] 2020/04/08 15:35:44.211167 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 715]
[13453] 2020/04/08 15:35:44.211194 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbFu\",\n \"timestamp\": \"2020-04-08T19:35:44.211078Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55647,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.CREATE\",\n \"request\": \"{\\\"name\\\":\\\"faas-cluster\\\",\\\"subjects\\\":[\\\"faas-cluster.\\\\u003e\\\"],\\\"retention\\\":\\\"limits\\\",\\\"max_consumers\\\":-1,\\\"max_msgs\\\":-1,\\\"max_bytes\\\":1048576,\\\"max_age\\\":31536000000000000,\\\"max_msg_size\\\":-1,\\\"storage\\\":\\\"memory\\\",\\\"num_replicas\\\":1}\",\n \"response\": \"+OK\"\n}"]
[13453] 2020/04/08 15:35:44.211314 [TRC] [::1]:55647 - cid:3 - <<- [SUB _INBOX.d2Usk0lAaxqk1iAcJPwFdY 4]
[13453] 2020/04/08 15:35:44.211328 [TRC] [::1]:55647 - cid:3 - <<- [UNSUB 4 1]
[13453] 2020/04/08 15:35:44.211334 [TRC] [::1]:55647 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.INFO _INBOX.d2Usk0lAaxqk1iAcJPwFdY 0]
[13453] 2020/04/08 15:35:44.211339 [TRC] [::1]:55647 - cid:3 - <<- MSG_PAYLOAD: [""]
[13453] 2020/04/08 15:35:44.211486 [TRC] SYSTEM - <<- [PUB _INBOX.d2Usk0lAaxqk1iAcJPwFdY 421]
[13453] 2020/04/08 15:35:44.211502 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"config\": {\n \"name\": \"faas-cluster\",\n \"subjects\": [\n \"faas-cluster.\\u003e\"\n ],\n \"retention\": \"limits\",\n \"max_consumers\": -1,\n \"max_msgs\": -1,\n \"max_bytes\": 1048576,\n \"max_age\": 31536000000000000,\n \"max_msg_size\": -1,\n \"storage\": \"memory\",\n \"num_replicas\": 1\n },\n \"state\": {\n \"messages\": 0,\n \"bytes\": 0,\n \"first_seq\": 0,\n \"last_seq\": 0,\n \"consumer_count\": 0\n }\n}"]
[13453] 2020/04/08 15:35:44.211509 [DBG] [::1]:55647 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '4'
[13453] 2020/04/08 15:35:44.211513 [TRC] [::1]:55647 - cid:3 - ->> [MSG _INBOX.d2Usk0lAaxqk1iAcJPwFdY 4 421]
[13453] 2020/04/08 15:35:44.211516 [TRC] [::1]:55647 - cid:3 - <-> [DELSUB 4]
[13453] 2020/04/08 15:35:44.211524 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 936]
[13453] 2020/04/08 15:35:44.211571 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbHd\",\n \"timestamp\": \"2020-04-08T19:35:44.211445Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55647,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.INFO\",\n \"response\": \"{\\n \\\"config\\\": {\\n \\\"name\\\": \\\"faas-cluster\\\",\\n \\\"subjects\\\": [\\n \\\"faas-cluster.\\\\u003e\\\"\\n ],\\n \\\"retention\\\": \\\"limits\\\",\\n \\\"max_consumers\\\": -1,\\n \\\"max_msgs\\\": -1,\\n \\\"max_bytes\\\": 1048576,\\n \\\"max_age\\\": 31536000000000000,\\n \\\"max_msg_size\\\": -1,\\n \\\"storage\\\": \\\"memory\\\",\\n \\\"num_replicas\\\": 1\\n },\\n \\\"state\\\": {\\n \\\"messages\\\": 0,\\n \\\"bytes\\\": 0,\\n \\\"first_seq\\\": 0,\\n \\\"last_seq\\\": 0,\\n \\\"consumer_count\\\": 0\\n }\\n}\"\n}"]
[13453] 2020/04/08 15:35:44.211742 [TRC] [::1]:55647 - cid:3 - <<- [SUB _INBOX.d2Usk0lAaxqk1iAcJPwFeS 5]
[13453] 2020/04/08 15:35:44.211765 [TRC] [::1]:55647 - cid:3 - <<- [UNSUB 5 1]
[13453] 2020/04/08 15:35:44.211772 [TRC] [::1]:55647 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.CONSUMER.faas.INFO _INBOX.d2Usk0lAaxqk1iAcJPwFeS 0]
[13453] 2020/04/08 15:35:44.211776 [TRC] [::1]:55647 - cid:3 - <<- MSG_PAYLOAD: [""]
[13453] 2020/04/08 15:35:44.211843 [TRC] SYSTEM - <<- [PUB _INBOX.d2Usk0lAaxqk1iAcJPwFeS 25]
[13453] 2020/04/08 15:35:44.211852 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["-ERR 'consumer not found'"]
[13453] 2020/04/08 15:35:44.211858 [DBG] [::1]:55647 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '5'
[13453] 2020/04/08 15:35:44.211862 [TRC] [::1]:55647 - cid:3 - ->> [MSG _INBOX.d2Usk0lAaxqk1iAcJPwFeS 5 25]
[13453] 2020/04/08 15:35:44.211867 [TRC] [::1]:55647 - cid:3 - <-> [DELSUB 5]
[13453] 2020/04/08 15:35:44.211880 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 489]
[13453] 2020/04/08 15:35:44.211914 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbJM\",\n \"timestamp\": \"2020-04-08T19:35:44.211811Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55647,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.CONSUMER.faas.INFO\",\n \"response\": \"-ERR 'consumer not found'\"\n}"]
[13453] 2020/04/08 15:35:44.212089 [TRC] [::1]:55647 - cid:3 - <<- [SUB _INBOX.d2Usk0lAaxqk1iAcJPwFfM 6]
[13453] 2020/04/08 15:35:44.212105 [TRC] [::1]:55647 - cid:3 - <<- [UNSUB 6 1]
[13453] 2020/04/08 15:35:44.212117 [TRC] [::1]:55647 - cid:3 - <<- [PUB $JS.STREAM.faas-cluster.CONSUMER.faas.CREATE _INBOX.d2Usk0lAaxqk1iAcJPwFfM 278]
[13453] 2020/04/08 15:35:44.212134 [TRC] [::1]:55647 - cid:3 - <<- MSG_PAYLOAD: ["{\"stream_name\":\"faas-cluster\",\"config\":{\"delivery_subject\":\"\",\"durable_name\":\"faas\",\"start_time\":\"0001-01-01T00:00:00Z\",\"deliver_all\":true,\"deliver_last\":true,\"ack_policy\":\"explicit\",\"ack_wait\":30000000000,\"filter_subject\":\"faas-cluster.faas-request\",\"replay_policy\":\"instant\"}}"]
[13453] 2020/04/08 15:35:44.212286 [TRC] SYSTEM - <<- [PUB _INBOX.d2Usk0lAaxqk1iAcJPwFfM 42]
[13453] 2020/04/08 15:35:44.212298 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["-ERR 'consumer starting position conflict'"]
[13453] 2020/04/08 15:35:44.212306 [DBG] [::1]:55647 - cid:3 - Auto-unsubscribe limit of 1 reached for sid '6'
[13453] 2020/04/08 15:35:44.212311 [TRC] [::1]:55647 - cid:3 - ->> [MSG _INBOX.d2Usk0lAaxqk1iAcJPwFfM 6 42]
[13453] 2020/04/08 15:35:44.212316 [TRC] [::1]:55647 - cid:3 - <-> [DELSUB 6]
[13453] 2020/04/08 15:35:44.212327 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 839]
[13453] 2020/04/08 15:35:44.212371 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbL5\",\n \"timestamp\": \"2020-04-08T19:35:44.212243Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"::1\",\n \"port\": 55647,\n \"cid\": 3,\n \"account\": \"$G\",\n \"name\": \"faas-worker-MacBook-Pro_local\",\n \"lang\": \"go\",\n \"version\": \"1.9.2\"\n },\n \"subject\": \"$JS.STREAM.faas-cluster.CONSUMER.faas.CREATE\",\n \"request\": \"{\\\"stream_name\\\":\\\"faas-cluster\\\",\\\"config\\\":{\\\"delivery_subject\\\":\\\"\\\",\\\"durable_name\\\":\\\"faas\\\",\\\"start_time\\\":\\\"0001-01-01T00:00:00Z\\\",\\\"deliver_all\\\":true,\\\"deliver_last\\\":true,\\\"ack_policy\\\":\\\"explicit\\\",\\\"ack_wait\\\":30000000000,\\\"filter_subject\\\":\\\"faas-cluster.faas-request\\\",\\\"replay_policy\\\":\\\"instant\\\"}}\",\n \"response\": \"-ERR 'consumer starting position conflict'\"\n}"]
[13453] 2020/04/08 15:35:44.215799 [DBG] [::1]:55647 - cid:3 - Client connection closed
[13453] 2020/04/08 15:35:50.220530 [DBG] 127.0.0.1:55651 - cid:6 - Client connection created
[13453] 2020/04/08 15:35:50.221005 [TRC] 127.0.0.1:55651 - cid:6 - <<- [CONNECT {"verbose":false,"pedantic":false,"tls_required":false,"name":"NATS CLI","lang":"go","version":"1.9.1","protocol":1,"echo":true}]
[13453] 2020/04/08 15:35:50.221030 [TRC] 127.0.0.1:55651 - cid:6 - <<- [PING]
[13453] 2020/04/08 15:35:50.221033 [TRC] 127.0.0.1:55651 - cid:6 - ->> [PONG]
[13453] 2020/04/08 15:35:50.221206 [TRC] 127.0.0.1:55651 - cid:6 - <<- [SUB _INBOX.dsgQQtgbY65PMqSNclq2rz 1]
[13453] 2020/04/08 15:35:50.221226 [TRC] 127.0.0.1:55651 - cid:6 - <<- [UNSUB 1 1]
[13453] 2020/04/08 15:35:50.221230 [TRC] 127.0.0.1:55651 - cid:6 - <<- [PUB $JS.STREAM.LIST _INBOX.dsgQQtgbY65PMqSNclq2rz 0]
[13453] 2020/04/08 15:35:50.221234 [TRC] 127.0.0.1:55651 - cid:6 - <<- MSG_PAYLOAD: [""]
[13453] 2020/04/08 15:35:50.221309 [TRC] SYSTEM - <<- [PUB _INBOX.dsgQQtgbY65PMqSNclq2rz 20]
[13453] 2020/04/08 15:35:50.221317 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["[\n \"faas-cluster\"\n]"]
[13453] 2020/04/08 15:35:50.221325 [DBG] 127.0.0.1:55651 - cid:6 - Auto-unsubscribe limit of 1 reached for sid '1'
[13453] 2020/04/08 15:35:50.221330 [TRC] 127.0.0.1:55651 - cid:6 - ->> [MSG _INBOX.dsgQQtgbY65PMqSNclq2rz 1 20]
[13453] 2020/04/08 15:35:50.221336 [TRC] 127.0.0.1:55651 - cid:6 - <-> [DELSUB 1]
[13453] 2020/04/08 15:35:50.221346 [TRC] SYSTEM - <<- [PUB $JS.EVENT.ADVISORY.API 446]
[13453] 2020/04/08 15:35:50.221355 [TRC] SYSTEM - <<- MSG_PAYLOAD: ["{\n \"schema\": \"io.nats.jetstream.advisory.v1.api_audit\",\n \"id\": \"a4pfmPBgQ04FzzdcvKdbMo\",\n \"timestamp\": \"2020-04-08T19:35:50.221267Z\",\n \"server\": \"NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB\",\n \"client\": {\n \"host\": \"127.0.0.1\",\n \"port\": 55651,\n \"cid\": 6,\n \"account\": \"$G\",\n \"name\": \"NATS CLI\",\n \"lang\": \"go\",\n \"version\": \"1.9.1\"\n },\n \"subject\": \"$JS.STREAM.LIST\",\n \"response\": \"[\\n \\\"faas-cluster\\\"\\n]\"\n}"]
[13453] 2020/04/08 15:35:50.221598 [TRC] 127.0.0.1:55651 - cid:6 - <<- [SUB _INBOX.dsgQQtgbY65PMqSNclq2u2 2]
[13453] 2020/04/08 15:35:50.221610 [TRC] 127.0.0.1:55651 - cid:6 - <<- [UNSUB 2 1]
[13453] 2020/04/08 15:35:50.221614 [TRC] 127.0.0.1:55651 - cid:6 - <<- [PUB $JS.STREAM.faas-cluster.CONSUMER.TEST.CREATE _INBOX.dsgQQtgbY65PMqSNclq2u2 252]
[13453] 2020/04/08 15:35:50.221622 [TRC] 127.0.0.1:55651 - cid:6 - <<- MSG_PAYLOAD: ["{\"stream_name\":\"faas-cluster\",\"config\":{\"delivery_subject\":\"\",\"durable_name\":\"TEST\",\"start_time\":\"0001-01-01T00:00:00Z\",\"deliver_last\":true,\"ack_policy\":\"explicit\",\"max_deliver\":-1,\"filter_subject\":\"faas-cluster.faas-reques\",\"replay_policy\":\"instant\"}}"]
[13453] 2020/04/08 15:35:52.532969 [DBG] 127.0.0.1:55651 - cid:6 - Client Ping Timer
[13453] 2020/04/08 15:35:52.532999 [TRC] 127.0.0.1:55651 - cid:6 - ->> [PING]
^C[13453] 2020/04/08 15:35:54.961196 [DBG] Trapped "interrupt" signal
[13453] 2020/04/08 15:35:54.961226 [TRC] SYSTEM - <<- [PUB $SYS.SERVER.NCUOB4Z4XWXZ3XUG35G4BA7STA3DZUKENBSUOIGU5DFLD6BEQR3YU7NB.SHUTDOWN 0]
[13453] 2020/04/08 15:35:54.961232 [TRC] SYSTEM - <<- MSG_PAYLOAD: [""]
^\SIGQUIT: quit
PC=0x7fff66ca6ce6 m=0 sigcode=0
goroutine 0 [idle]:
runtime.pthread_cond_wait(0x1a35908, 0x1a358c8, 0x7ffe00000000)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/sys_darwin.go:390 +0x39
runtime.semasleep(0xffffffffffffffff, 0x7ffeefbff420)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/os_darwin.go:63 +0x85
runtime.notesleep(0x1a356c8)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/lock_sema.go:173 +0xe0
runtime.stoplockedm()
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/proc.go:1971 +0x88
runtime.schedule()
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/proc.go:2454 +0x4a6
runtime.park_m(0xc000001680)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/proc.go:2690 +0x9d
runtime.mcall(0x1065ea6)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/asm_amd64.s:318 +0x5b
goroutine 1 [IO wait]:
internal/poll.runtime_pollWait(0x7c39f18, 0x72, 0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/netpoll.go:203 +0x55
internal/poll.(*pollDesc).wait(0xc000204198, 0x72, 0x0, 0x0, 0x15d244e)
/usr/local/Cellar/go/1.14.1/libexec/src/internal/poll/fd_poll_runtime.go:87 +0x45
internal/poll.(*pollDesc).waitRead(...)
/usr/local/Cellar/go/1.14.1/libexec/src/internal/poll/fd_poll_runtime.go:92
internal/poll.(*FD).Accept(0xc000204180, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/internal/poll/fd_unix.go:384 +0x1d4
net.(*netFD).accept(0xc000204180, 0x104010e, 0xc000185c18, 0x10653f0)
/usr/local/Cellar/go/1.14.1/libexec/src/net/fd_unix.go:238 +0x42
net.(*TCPListener).accept(0xc000206c40, 0xc000185c70, 0x1499ced, 0xc000000000)
/usr/local/Cellar/go/1.14.1/libexec/src/net/tcpsock_posix.go:139 +0x32
net.(*TCPListener).Accept(0xc000206c40, 0xc000129101, 0xc000130168, 0x0, 0x0)
/usr/local/Cellar/go/1.14.1/libexec/src/net/tcpsock.go:261 +0x64
github.com/nats-io/nats-server/v2/server.(*Server).AcceptLoop(0xc0000ba000, 0x0)
/Users/matthiashanel/repos/nats-server/server/server.go:1509 +0x841
github.com/nats-io/nats-server/v2/server.(*Server).Start(0xc0000ba000)
/Users/matthiashanel/repos/nats-server/server/server.go:1305 +0x95f
github.com/nats-io/nats-server/v2/server.Run(...)
/Users/matthiashanel/repos/nats-server/server/service.go:21
main.main()
/Users/matthiashanel/repos/nats-server/main.go:114 +0x141
goroutine 37 [select]:
github.com/nats-io/nats-server/v2/server.(*Stream).internalSendLoop(0xc000328000)
/Users/matthiashanel/repos/nats-server/server/stream.go:634 +0x1b3
created by github.com/nats-io/nats-server/v2/server.(*Stream).setupSendCapabilities
/Users/matthiashanel/repos/nats-server/server/stream.go:602 +0xad
goroutine 5 [syscall]:
os/signal.signal_recv(0x16a22e0)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/sigqueue.go:144 +0x96
os/signal.loop()
/usr/local/Cellar/go/1.14.1/libexec/src/os/signal/signal_unix.go:23 +0x22
created by os/signal.Notify.func1
/usr/local/Cellar/go/1.14.1/libexec/src/os/signal/signal.go:127 +0x44
goroutine 7 [semacquire]:
sync.runtime_SemacquireMutex(0xc000328004, 0x0, 0x1)
/usr/local/Cellar/go/1.14.1/libexec/src/runtime/sema.go:71 +0x47
sync.(*Mutex).lockSlow(0xc000328000)
/usr/local/Cellar/go/1.14.1/libexec/src/sync/mutex.go:138 +0xfc
sync.(*Mutex).Lock(...)
/usr/local/Cellar/go/1.14.1/libexec/src/sync/mutex.go:81
sync.(*RWMutex).Lock(0xc000328000)
/usr/local/Cellar/go/1.14.1/libexec/src/sync/rwmutex.go:98 +0x97
github.com/nats-io/nats-server/v2/server.(*Stream).stop(0xc000328000, 0x0, 0xc000182b88, 0x0)
/Users/matthiashanel/repos/nats-server/server/stream.go:666 +0x42
github.com/nats-io/nats-server/v2/server.(*jsAccount).delete(0xc000262000)
/Users/matthiashanel/repos/nats-server/server/jetstream.go:720 +0x30a
github.com/nats-io/nats-server/v2/server.(*jetStream).disableJetStream(0xc00008a5a0, 0xc000262000, 0xc000182cb8, 0x0)
/Users/matthiashanel/repos/nats-server/server/jetstream.go:619 +0xa7
github.com/nats-io/nats-server/v2/server.(*Server).shutdownJetStream(0xc0000ba000)
/Users/matthiashanel/repos/nats-server/server/jetstream.go:198 +0x1e9
github.com/nats-io/nats-server/v2/server.(*Server).Shutdown(0xc0000ba000)
/Users/matthiashanel/repos/nats-server/server/server.go:1318 +0x54
github.com/nats-io/nats-server/v2/server.(*Server).handleSignals.func1(0xc00008a480, 0xc0000ba000)
/Users/matthiashanel/repos/nats-server/server/signal.go:52 +0x30f
created by github.com/nats-io/nats-server/v2/server.(*Server).handleSignals
/Users/matthiashanel/repos/nats-server/server/signal.go:45 +0x11a
goroutine 8 [select]:
github.com/nats-io/nats-server/v2/server.(*Server).startGWReplyMapExpiration.func1()
/Users/matthiashanel/repos/nats-server/server/gateway.go:2973 +0x15b
created by github.com/nats-io/nats-server/v2/server.(*Server).startGoRoutine
/Users/matthiashanel/repos/nats-server/server/server.go:2252 +0xad
goroutine 38 [runnable]:
github.com/nats-io/nats-server/v2/server.(*memStore).LoadMsg(0xc0003280e0, 0xffffffffb2ee08cd, 0xc000076440, 0x0, 0x0, 0x0, 0x0, 0x0, 0x169ce00, 0xc000076450)
/Users/matthiashanel/repos/nats-server/server/memstore.go:239 +0x1a2
github.com/nats-io/nats-server/v2/server.(*Consumer).selectSubjectLast(0xc0001da000)
/Users/matthiashanel/repos/nats-server/server/consumer.go:1312 +0xae
github.com/nats-io/nats-server/v2/server.(*Consumer).selectStartingSeqNo(0xc0001da000)
/Users/matthiashanel/repos/nats-server/server/consumer.go:1334 +0xff
github.com/nats-io/nats-server/v2/server.(*Stream).AddConsumer(0xc000328000, 0xc00013f0f0, 0x4, 0xc000136b01, 0x4)
/Users/matthiashanel/repos/nats-server/server/consumer.go:323 +0x612
github.com/nats-io/nats-server/v2/server.(*Server).jsCreateConsumerRequest(0xc0000ba000, 0xc0002385a0, 0xc0001a5300, 0xc000136b40, 0x2c, 0xc0001411c0, 0x1d, 0xc000318685, 0xfc, 0x17b)
/Users/matthiashanel/repos/nats-server/server/jetstream_api.go:580 +0x62b
github.com/nats-io/nats-server/v2/server.(*client).deliverMsg(0xc0001a5300, 0xc0002385a0, 0xc000136b10, 0x2c, 0x30, 0xc0001a55e9, 0x4b, 0x3ff, 0xc000318685, 0xfe, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:2503 +0x2f4
github.com/nats-io/nats-server/v2/server.(*client).processMsgResults(0xc0001a5300, 0xc0000d41c0, 0xc0001ca960, 0xc000318685, 0xfe, 0x17b, 0x0, 0x0, 0x0, 0xc000136b10, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:3150 +0x720
github.com/nats-io/nats-server/v2/server.(*client).processServiceImport(0xc0001a5300, 0xc00021cf00, 0xc0000d4000, 0xc000318685, 0xfe, 0x17b)
/Users/matthiashanel/repos/nats-server/server/client.go:3016 +0x5ee
github.com/nats-io/nats-server/v2/server.(*Account).addServiceImportSub.func1(0xc000239a70, 0xc0001a5300, 0xc000136ab0, 0x2c, 0xc000141100, 0x1d, 0xc000318685, 0xfe, 0x17b)
/Users/matthiashanel/repos/nats-server/server/accounts.go:1047 +0x5e
github.com/nats-io/nats-server/v2/server.(*client).deliverMsg(0xc0001a5300, 0xc000239a70, 0xc000318635, 0x2c, 0x1cb, 0xc0001a55e9, 0x57, 0x3ff, 0xc000318685, 0xfe, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:2501 +0x3fa
github.com/nats-io/nats-server/v2/server.(*client).processMsgResults(0xc0001a5300, 0xc0000d4000, 0xc0001ca8a0, 0xc000318685, 0xfe, 0x17b, 0x0, 0x0, 0x0, 0xc000318635, ...)
/Users/matthiashanel/repos/nats-server/server/client.go:3150 +0x720
github.com/nats-io/nats-server/v2/server.(*client).processInboundClientMsg(0xc0001a5300, 0xc000318685, 0xfe, 0x17b, 0xc000129440)
/Users/matthiashanel/repos/nats-server/server/client.go:2876 +0x520
github.com/nats-io/nats-server/v2/server.(*client).processInboundMsg(0xc0001a5300, 0xc000318685, 0xfe, 0x17b)
/Users/matthiashanel/repos/nats-server/server/client.go:2755 +0x95
github.com/nats-io/nats-server/v2/server.(*client).parse(0xc0001a5300, 0xc000318600, 0x183, 0x200, 0x183, 0x0)
/Users/matthiashanel/repos/nats-server/server/parser.go:288 +0x17dc
github.com/nats-io/nats-server/v2/server.(*client).readLoop(0xc0001a5300)
/Users/matthiashanel/repos/nats-server/server/client.go:908 +0x333
github.com/nats-io/nats-server/v2/server.(*Server).createClient.func2()
/Users/matthiashanel/repos/nats-server/server/server.go:1896 +0x2a
created by github.com/nats-io/nats-server/v2/server.(*Server).startGoRoutine
/Users/matthiashanel/repos/nats-server/server/server.go:2252 +0xad
goroutine 39 [select]:
github.com/nats-io/nats-server/v2/server.(*client).writeLoop(0xc0001a5300)
/Users/matthiashanel/repos/nats-server/server/client.go:797 +0x303
github.com/nats-io/nats-server/v2/server.(*Server).createClient.func3()
/Users/matthiashanel/repos/nats-server/server/server.go:1899 +0x2a
created by github.com/nats-io/nats-server/v2/server.(*Server).startGoRoutine
/Users/matthiashanel/repos/nats-server/server/server.go:2252 +0xad
rax 0x104
rbx 0x2
rcx 0x7ffeefbff248
rdx 0x1b00
rdi 0x1a35908
rsi 0x1c0100001d00
rbp 0x7ffeefbff2e0
rsp 0x7ffeefbff248
r8 0x0
r9 0xa0
r10 0x0
r11 0x202
r12 0x1a35908
r13 0x16
r14 0x1c0100001d00
r15 0x7df8dc0
rip 0x7fff66ca6ce6
rflags 0x203
cs 0x7
fs 0x0
gs 0x0
Please check stream subject in json and what got created...
cat faas-cluster.json
{
"config": {
"name": "faas-cluster",
"subjects": [
"faas-cluster.>"
],
"retention": "limits",
"max_consumers": -1,
"max_msgs": -1,
"max_bytes": 1048576,
"max_age": 31536000000000000,
"max_msg_size": -1,
"storage": "memory",
"num_replicas": 1
},
"state": {
"messages": 0,
"bytes": 0,
"first_seq": 0,
"last_seq": 0,
"consumer_count": 0
}
}
> ./nats -s 0.0.0.0:4222 stream add faas-cluster --config=faas-cluster.json
Stream faas-cluster was created
Information for Stream faas-cluster
Configuration:
Subjects: faas-cluster
Acknowledgements: true
Retention: Memory - Limits
Replicas: 1
Maximum Messages: unlimited
Maximum Bytes: unlimited
Maximum Age: 0s
Maximum Message Size: unlimited
Maximum Consumers: unlimited
State:
Messages: 0
Bytes: 0 B
FirstSeq: 0
LastSeq: 0
Active Consumers: 0
> ./nats -s 0.0.0.0:4222 consumer add faas-cluster TEST --pull --deliver last --filter=faas-cluster.faas-reques --max-deliver=-1
nats: error: Consumer creation failed: consumer filter subject is not a valid subset of the interest subjects
Setting up a push consumer:
nats consumer info ORDERS MONITOR --json
{
"name": "MONITOR",
"config": {
"delivery_subject": "monitor.ORDERS",
"durable_name": "MONITOR",
"start_time": "0001-01-01T00:00:00Z",
"deliver_all": true,
"ack_policy": "all",
"max_deliver": -1,
"replay_policy": "instant"
},
"state": {
"delivered": {
"consumer_seq": 11,
"stream_seq": 11
},
"ack_floor": {
"consumer_seq": 4,
"stream_seq": 4
},
"pending": null,
"redelivered": null
}
}
If I subscribe to this with a queue subscriber I get no messages delivered to any queue subscriber
Should queue subscribers be supported on a push consumer output subject @derekcollison? seems to me like they should be
Hi..
we are using docker image synadia/jsm:nightly means nats-server version 2.2.0-beta.15
and Git commit [bfe52fdb]
we are able to create stream, consumer and consume the the stream by using jsm.go utility in golang source code .
But we are not able to send req/publish data to stream through publisher.
Is there any code examples are there so that we can publish our data to subject.
we are publishing data by using nats go client natsConn.Publish("abc.p0.6, []byte(line.Text));
and stream subject is configured for abc.*
from jetstream cli we are able to send request nats req abc.scratch hello
Hello,
I am running a strange issue concerning either jsm.go, either my Go code.
I a trying to publish some messages into a stream. It does work very well when i call stream.State()
at the end of my little piece of code.
However, if i remove this stream.State()
, it does not work anymore. conn.Publish(...)
is not throwing any errors whereas i don't see any messages incoming into the stream (i am doing a nats str info mystream
on the server and the Messages property stays at 0.
Thanks for your support.
Versions:
package main
import (
"flag"
"log"
"math/rand"
"github.com/nats-io/jsm.go"
)
const (
streamName = "mystream"
subjectName = "mysubject"
)
func main() {
nMsgs := flag.Int("n", 1, "number of messages")
flag.Parse()
jsm.Connect("localhost:4222")
conn := jsm.Connection()
stream, err := jsm.LoadOrNewStream(streamName, jsm.FileStorage(), jsm.Subjects(subjectName))
if err != nil {
log.Fatal("error loading or creating stream: ", err)
}
msg := make([]byte, 64)
rand.Read(msg)
for i := 0; i < *nMsgs; i++ {
err = conn.Publish(stream.Subjects()[0], msg)
if err != nil {
log.Fatalf("error publishing into %s stream: %v", streamName, err)
}
}
// If this is not called, the publish does not work and throw no error
stream.State()
}
$ ./nats-server -js
[96250] 2020/01/03 01:58:35.983540 [INF] Starting nats-server version 2.2.0-beta
[96250] 2020/01/03 01:58:35.983626 [INF] Git commit [not set]
[96250] 2020/01/03 01:58:35.983641 [INF] Starting JetStream
[96250] 2020/01/03 01:58:35.983972 [INF] ----------- JETSTREAM (Beta) -----------
[96250] 2020/01/03 01:58:35.983980 [INF] Max Memory: 12.00 GB
[96250] 2020/01/03 01:58:35.983983 [INF] Max Storage: 1.00 TB
[96250] 2020/01/03 01:58:35.983988 [INF] Store Directory: "/var/folders/y2/5b329bg156dghq4hd48m301w0000gn/T/jetstream"
[96250] 2020/01/03 01:58:35.983995 [INF] ----------------------------------------
[96250] 2020/01/03 01:58:35.984846 [INF] Listening for client connections on 0.0.0.0:4222
[96250] 2020/01/03 01:58:35.984852 [INF] Server id is NA26V75FBEUZVASGKV4FFUB5OT3TLC547LF3ZHYLP6BCTJSAIO2J47VQ
[96250] 2020/01/03 01:58:35.984854 [INF] Server is ready
$ jsm ms add derek
? Subjects to consume sub1 sub2 other.* <-- here's some topics set
? Storage backend file <-- I select file
? Retention Policy Stream
? Message count limit -1
? Message size limit -1
? Maximum message age limit -1
Message set derek was created
Information for message set derek
Configuration:
Subjects: <-- no subjects
No Acknowledgements: false
Retention: Memory - Limits <-- here is Memory
Replicas: 0
Maximum Messages: 0
Maximum Bytes: 0
Maximum Age: 0s
Maximum Observables: 0
Statistics:
Messages: 0
Bytes: 0 B
FirstSeq: 0
LastSeq: 0
Active Observables: 0
I'm running both the latest server and jsm from docker.
A few differences I noticed between expected results as shown in the README vs what I encountered, some positive (in my opinion), others which may be attributable to out of date documentation, or changed or broken behavior. My apologies for not splitting these out into separate issues though, to be fair, they may just all be documentation issues:
after creating a stream jsm str add ORDERS
, the documentation indicates the configuration will report No Acknowledgements: false
but actually reports (the improved) Acknowledgements: true
(PR here probably not comprehensive)
this section says that executing nats-pub ORDERS.scratch hello
will return/display Published [sub1] : 'hello'
but in fact nothing is displayed. (jsm str info ORDERS
does show there is now a message in the stream)
the README next demo's using nats-req with nats-req ORDERS.scratch hello
and shows we should receive a +OK
but, instead I receive a usage message:
Usage: nats-req [-s server] [-creds file] [-t] <subject> <request> -creds string User Credentials File -h Show help message -s string The NATS System (default "connect.ngs.global") -t Display timestamps -v Show version
The example which begins with jsm con add --sample 100
shows a configuration output with an entry of Deliver Last: false
after Deliver All: true
, but the Deliver Last
entry is not present in the actual run.
Similar to the note two points up, nats-req '$JS.NEXT.ORDERS.DISPATCH' ''
returns a nats-req usage message rather than Published [$JS.NEXT.ORDERS.DISPATCH] : '' Received [ORDERS.processed] : 'order 3'
as indicated
A stream with acknowledgement enabled that consumes topics >
will cause havoc, it's +OK responses to JS API requests can come before API replies and cause responses to be invalid.
We should not allow stream subs that overlaps with the API - and if we choose to do so it should be without Ack
reported by @matthiashanel
If someone sends foo.bar.
as a subject when creating a stream the server panics.
panic: runtime error: invalid memory address or nil pointer dereference
[signal SIGSEGV: segmentation violation code=0x1 addr=0x0 pc=0x14a210c]
goroutine 118 [running]:
github.com/nats-io/nats-server/v2/server.(*Stream).subscribeInternal(0xc0000c0000, 0xc0000d2100, 0xc, 0xc000286150, 0xc0000ba8f8, 0x8, 0x4080900)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/stream.go:385 +0x18c
github.com/nats-io/nats-server/v2/server.(*Stream).subscribeToStream(0xc0000c0000, 0xc0000baa28, 0x0)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/stream.go:350 +0xd2
github.com/nats-io/nats-server/v2/server.(*Account).AddStreamWithStore(0xc00014c000, 0xc000288100, 0x0, 0xc000118201, 0xc, 0x0)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/stream.go:135 +0x44c
github.com/nats-io/nats-server/v2/server.(*Account).AddStream(...)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/stream.go:69
github.com/nats-io/nats-server/v2/server.(*Server).jsCreateStreamRequest(0xc000130000, 0xc0002d3560, 0xc0002bcc80, 0xc000118240, 0x1e, 0xc000242120, 0x26, 0xc003f0a477, 0xc8, 0x189)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/jetstream_api.go:374 +0x241
github.com/nats-io/nats-server/v2/server.(*client).deliverMsg(0xc0002bcc80, 0xc0002d3560, 0xc0001f9378, 0x1e, 0x20, 0xc0002bcf69, 0x3d, 0x3ff, 0xc003f0a477, 0xca, ...)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:2501 +0x2f4
github.com/nats-io/nats-server/v2/server.(*client).processMsgResults(0xc0002bcc80, 0xc0002b4000, 0xc00010b2c0, 0xc003f0a477, 0xca, 0x189, 0x0, 0x0, 0x0, 0xc0000bb378, ...)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:3148 +0x720
github.com/nats-io/nats-server/v2/server.(*client).processServiceImport(0xc0002bcc80, 0xc000281200, 0xc00014c000, 0xc003f0a477, 0xca, 0x189)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:3014 +0x5ee
github.com/nats-io/nats-server/v2/server.(*Account).addServiceImportSub.func1(0xc0002e0ab0, 0xc0002bcc80, 0xc000118160, 0x1e, 0xc0002420c0, 0x26, 0xc003f0a477, 0xca, 0x189)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/accounts.go:1047 +0x5e
github.com/nats-io/nats-server/v2/server.(*client).deliverMsg(0xc0002bcc80, 0xc0002e0ab0, 0xc003f0a42c, 0x1e, 0x1d4, 0xc0002bcf69, 0x51, 0x3ff, 0xc003f0a477, 0xca, ...)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:2499 +0x3fa
github.com/nats-io/nats-server/v2/server.(*client).processMsgResults(0xc0002bcc80, 0xc00014c000, 0xc00010b1d0, 0xc003f0a477, 0xca, 0x189, 0x0, 0x0, 0x0, 0xc003f0a42c, ...)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:3148 +0x720
github.com/nats-io/nats-server/v2/server.(*client).processInboundClientMsg(0xc0002bcc80, 0xc003f0a477, 0xca, 0x189, 0x18e)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:2874 +0x520
github.com/nats-io/nats-server/v2/server.(*client).processInboundMsg(0xc0002bcc80, 0xc003f0a477, 0xca, 0x189)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:2753 +0x95
github.com/nats-io/nats-server/v2/server.(*client).parse(0xc0002bcc80, 0xc003f0a400, 0x141, 0x200, 0x141, 0x0)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/parser.go:288 +0x17dc
github.com/nats-io/nats-server/v2/server.(*client).readLoop(0xc0002bcc80)
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/client.go:907 +0x333
github.com/nats-io/nats-server/v2/server.(*Server).createClient.func2()
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/server.go:1896 +0x2a
created by github.com/nats-io/nats-server/v2/server.(*Server).startGoRoutine
/Users/rip/go/pkg/mod/github.com/nats-io/nats-server/[email protected]/server/server.go:2252 +0xad
previously it was supported but had no name and so was kind of unreachable, now DeliverNew
is new
case len(msg) == 0, bytes.Equal(msg, AckAck):
o.ackMsg(sseq, dseq, dcount)
case bytes.Equal(msg, AckNext):
o.ackMsg(sseq, dseq, dcount)
o.processNextMsgReq(nil, nil, subject, reply, nil)
case bytes.Equal(msg, AckNak):
o.processNak(sseq, dseq)
case bytes.Equal(msg, AckProgress):
o.progressUpdate(sseq)
}
I wouldn't expect issues but we should test all command line tools on multiple platforms.
Help text for Message size limit specifies -1. but won't take it... should say 0
12:16:17 ✘ 1 ~/repos/jetstream/nats master ./nats -s 0.0.0.0:4222 stream create TOAST
? Subjects to consume toast.>
? Storage backend memory
? Retention Policy Limits
? Message count limit 5
? Message size limit -1
nats: error: invalid input: strconv.ParseFloat: parsing "": invalid syntax
12:18:28 ✘ 1 ~/repos/jetstream/nats master ./nats -s 0.0.0.0:4222 stream create TOAST
? Subjects to consume toast.>
? Storage backend memory
? Retention Policy Limits
? Message count limit 5
? Defines the combined size of all messages in a Stream, when exceeded oldest messages are removed, -1 for unlimited. Settable using --max-bytes
? Message size limit (0)
my config requires authentication
11:36:51 ~/repos/nats-server jetstream *16 ?1 nats-server -c acc.cfg &
[1] 56782
[56782] 2020/04/16 11:36:51.299846 [INF] Starting nats-server version 2.2.0-beta.9
...
[56782] 2020/04/16 11:36:51.300651 [INF] Server is ready
11:37:00 ~/repos/nats-server jetstream *16 ?1 nats -s localhost:4222 stream ls
[56782] 2020/04/16 11:37:00.684708 [ERR] 127.0.0.1:50532 - cid:5 - authentication error - User ""
nats: error: could not list Streams: nats connection is not set, use SetConnection()
11:37:01 ✘ 1 ~/repos/nats-server jetstream *16 ?1
When a push consumer disconnects from the network due to bad network that consumer will just stop working and the client will have no way to determine this happened, there's no way to confirm it's valid and no way to recover from that scenario. The same scenario that led to https://github.com/nats-io/stan.go#connection-status
We need a concept of a heartbeat so the consumer can get messages telling them things went bad, something like a nil
body with a Header indicating heartbeat count or similar.
What I don't know is what kind of callback we'll fire or what we'll do in the absence of that heartbeat?
sub, err := nc.Subscribe(nats.NewInbox(), handler)
how does that communicate this failure and what happens when that failure happens? It has to be subscription specific, we don't want every user to (badly) implement the handling of this, I imagine we'll need some helper that:
But the recreation is very problematic since we can't know about out of order deliveries due to redeliveries and so the simple scheme or subscribing to last acked+1 will cause duplicates. I can't think of a good design with what we have.
But remembering how really painful this was in STAN to retrofit to existing code bases we need an answer for this during tech preview timeline
Fluentd is use as a log forwarder for many different outputs like kafka, ES, S3, etc it would be very nice to have a nats (jetstream) output.
It would be great to be able to have a stream per namespace in k8s as an option, so when a new namespace is added it will create the stream and ship logs from workload in that namespace to that stream.
I am thinking that having a nats cluster running inside k8s and have a leafnode with jetstream that will persist the logs or that other consumers can subscribe to.
also review docs etc for terminology use
Many of the config flags allow environment variables, but --tls* does not.
It would help a lot to allow them also to be defined by environment variables to make it simpe set up environment with NATS_URL and TLS to allow command line without a long list of parms.
In all retention modes limits should be asked as they are upper bounds that are always present, the work queue and interest modes are ways to evict messages earlier than limits.
A declarative, efficient, and flexible JavaScript library for building user interfaces.
🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.
TypeScript is a superset of JavaScript that compiles to clean JavaScript output.
An Open Source Machine Learning Framework for Everyone
The Web framework for perfectionists with deadlines.
A PHP framework for web artisans
Bring data to life with SVG, Canvas and HTML. 📊📈🎉
JavaScript (JS) is a lightweight interpreted programming language with first-class functions.
Some thing interesting about web. New door for the world.
A server is a program made to process requests and deliver data to clients.
Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.
Some thing interesting about visualization, use data art
Some thing interesting about game, make everyone happy.
We are working to build community through open source technology. NB: members must have two-factor auth.
Open source projects and samples from Microsoft.
Google ❤️ Open Source for everyone.
Alibaba Open Source for everyone
Data-Driven Documents codes.
China tencent open source team.