Skip to content

Instantly share code, notes, and snippets.

@weilliu

weilliu/gist:c4aa25930b4947c94af7

Created January 29, 2015 21:21
Show Gist options
  • Save weilliu/c4aa25930b4947c94af7 to your computer and use it in GitHub Desktop.
Save weilliu/c4aa25930b4947c94af7 to your computer and use it in GitHub Desktop.
Download ZIP
n1al log
Raw
gistfile1.txt
Wei-Lis-MacBook-Pro:sdkdclient-ng wei-li$ ./brun -A S3Creds_tmp -I ../weili-vm.ini -I ../sdkd-cluster.args --T "passthrough" --workload N1QLWorkloadGroup -d all:debug
[0.10 INFO] (BRun run:441) Initializing S3
[0.37 INFO] (BRun run:446) Initializing history database
[0.61 DEBUG] (Nodelist <init>:355) Number of active nodes 1
============================================================
Running passthrough-KV
basic/wait=4
testcase=BasicScenario
Logging to /Users/wei-li/repo/couchbase/sdkd-2.0/sdkdclient-ng/log/SDK-SDK/CB-3.5.0-1049/passthrough-KV/01-29-15/070010/0c2ec4728ffa9937e2fc1c74d56bd710
To re-run the test, copy/paste the following into the shell.
You may also copy/paste (except the first line) into an argfile
8<----------------------------------------
./stester \
--basic-wait 4 --testcase BasicScenario -C share/rexec \
--rexec_path \
/Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/run-sdkd-java \
--rexec_port 8050 --cluster_node=172.23.107.176 \
--cluster_ssh-username=root --cluster_ssh-password=couchbase \
--workload N1QLWorkloadGroup
---------------------------------------->8
[0.82 WARN] (Drivers getDriver:76) 'rexec' is now mapped to *local* execution only. Use RemoteExecutingDriver for remote execution
[0.89 DEBUG] (Nodelist <init>:355) Number of active nodes 1
[0.96 INFO] (RunContext run:102) Configure the cluster and run the workload for 4 seconds. This secneario does not change the cluster
[0.97 INFO] (RunContext run:124) Starting cluster and driver
[0.97 INFO] (CBCluster startCluster:363) Node http://172.23.107.176:8091 is master now
[0.97 INFO] (HostPortDriver launch:32) Invoking SDKD as '/Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/run-sdkd-java'
[0.97 DEBUG] (CBCluster startCluster:369) Stopping any existing rebalance operations..
[0.98 INFO] (SDKD log:137) ++ pgrep -f 'java.+-jar.*sdkd-java'
[0.98 INFO] (SDKD log:137) ++ dirname /Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/run-sdkd-java
[0.99 INFO] (SDKD log:137) + SDKD_ROOT=/Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java
[0.99 INFO] (SDKD log:137) + cd /Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java
[0.99 INFO] (SDKD log:137) + JAR=
[0.99 INFO] (SDKD log:137) + JAR_DEFAULT=
[0.99 INFO] (SDKD log:137) + '[' -z '' -o '' '!=' jar ']'
[0.99 INFO] (SDKD log:137) + JAR_DEFAULT=1
[0.99 INFO] (SDKD log:137) ++ dirname /Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/run-sdkd-java
[0.99 INFO] (SDKD log:137) + JAR=/Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/../sdkd_exec.jar
[0.99 INFO] (SDKD log:137) + '[' '!' -e /Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/../sdkd_exec.jar ']'
[0.99 INFO] (SDKD log:137) + '[' '!' -e /Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/../sdkd_exec.jar ']'
[0.99 INFO] (SDKD log:137) + JAR_ARGS=
[0.99 INFO] (SDKD log:137) + '[' 1 == 1 ']'
[0.99 INFO] (SDKD log:137) + JAR_ARGS=
[0.99 INFO] (SDKD log:137) + '[' -z '' ']'
[0.99 INFO] (SDKD log:137) + JAR_ARGS='-l 8050 -shared 100 -sync true'
[0.99 INFO] (SDKD log:137) + java -ea -jar /Users/wei-li/repo/couchbase/sdkd-2.0/sdkd-java/../sdkd_exec.jar -l 8050 -shared 100 -sync true
[1.49 DEBUG] (Handle sendMessageAsync:183) > INFO@0.0
[1.54 DEBUG] (Handle receiveMessage:158) < INFO@0.0 => {"COMPONENTS":{"Core_VERSION":"couchbase-jvm-core/1.1.0-SNAPSHOT (git: 1.1.0-dp2-6-g94fe30e)","SDK_VERSION":"couchbase-java-client/2.1.0-SNAPSHOT (git: 2.1.0-dp2-5-g7347b7a) (Mac OS X/10.9.5 x86_64; Java HotSpot(TM) 64-Bit Server VM 1.8.0_05-b13)"},"CAPS":{"VIEWS":true,"OBS":true,"DS_SHARED":true,"CANCEL":true,"CONTINUOUS":true,"TTL":true,"PREAMBLE":false}}
[3.30 DEBUG] (SSHConnection initUserKeys:79) Loaded indentity /Users/wei-li/.ssh/id_rsa
[3.30 DEBUG] (SSHConnection connect:99) Connecting with User[root] Pass[HASH=3b8cf05627127baaf3808913209aac84]
[4.01 INFO] (NodeHost createSSH:154) SSH Initialized for http://172.23.107.176:8091
[4.02 DEBUG] (SSHCommand execute:75) Running /etc/init.d/couchbase-server start && pkill -CONT -f memcached && pkill -CONT -f beam.smp && iptables -F && iptables -t nat -F on 172.23.107.176
[4.65 DEBUG] (SSHCommand close:147) Closing channel com.jcraft.jsch.ChannelExec@34cb9119
[4.65 DEBUG] (CBCluster setupNewCluster:273) Provisioning initial node com.couchbase.cbadmin.client.CouchbaseAdmin@369ef7f4
[4.84 INFO] (CBCluster setupNewCluster:295) All nodes added. Will rebalance
[5.11 INFO] (RebalanceWaiter sweepOnce:33) Rebalance complete
[5.11 DEBUG] (CBCluster setupServerGroups:224) Not creating any groups
[5.19 INFO] (CBCluster setupMainBucket:211) Creating bucket default
[5.27 INFO] (CBCluster setupMainBucket:213) Bucket creation submitted
[10.13 INFO] (CBCluster waitForBucketReady:205) Bucket creation done
[10.13 INFO] (RunContext run:143) Driver and cluster initialized
[10.21 INFO] (RunContext call:167) Running scenario..
[10.22 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@101.1 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[10.23 INFO] (SDKD log:137) Jan 29, 2015 11:27:00 AM com.couchbase.client.core.CouchbaseCore <init>
[10.23 INFO] (SDKD log:137) INFO: CoreEnvironment: {sslEnabled=false, sslKeystoreFile='cacerts', sslKeystorePassword='couchbase', queryEnabled=true, queryPort=8093, bootstrapHttpEnabled=true, bootstrapCarrierEnabled=true, bootstrapHttpDirectPort=8091, bootstrapHttpSslPort=18091, bootstrapCarrierDirectPort=11210, bootstrapCarrierSslPort=11207, ioPoolSize=8, computationPoolSize=8, responseBufferSize=16384, requestBufferSize=16384, kvServiceEndpoints=1, viewServiceEndpoints=1, queryServiceEndpoints=1, ioPool=NioEventLoopGroup, coreScheduler=CoreScheduler, eventBus=DefaultEventBus, packageNameAndVersion=couchbase-java-client/2.1.0-SNAPSHOT (git: 2.1.0-dp2-5-g7347b7a), dcpEnabled=false, retryStrategy=BestEffort, maxRequestLifetime=75000, retryDelay=com.couchbase.client.core.time.ExponentialDelay@6c2fc00, reconnectDelay=com.couchbase.client.core.time.ExponentialDelay@f8e1d5c, observeIntervalDelay=com.couchbase.client.core.time.ExponentialDelay@1e2ab518}
[10.78 INFO] (SDKD log:137) Jan 29, 2015 11:27:00 AM com.couchbase.client.core.node.CouchbaseNode$5 call
[10.78 INFO] (SDKD log:137) INFO: Connected to Node 172.23.107.176
[11.06 INFO] (SDKD log:137) Jan 29, 2015 11:27:01 AM com.couchbase.client.core.config.DefaultConfigurationProvider$6 call
[11.06 INFO] (SDKD log:137) INFO: Opened bucket default
[11.08 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@101.1
[11.08 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_LOAD@101.2 => {Options={DelayMin=0, ReplicateTo=1, TimeRes=0, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=0}, N1QLSchema={InflateLevel=35, InflateContent=meh}, DSType=DSTYPE_SEEDED, DS={KSize=12, KSeed=N1QLFillerSeed, VSize=512, VSeed=N1QLFillerSeed, Continuous=false, Repeat=rep, Count=1000}}
[176.52 DEBUG] (Handle receiveMessage:158) < CB_N1QL_LOAD@101.2 => {[OK]: 1000}
[176.53 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@101.3
[176.53 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@102.4 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.53 INFO] (SDKD log:137) Jan 29, 2015 11:29:46 AM com.couchbase.sdkd.server.SdkServer shutdown
[176.53 INFO] (SDKD log:137) WARNING: Shutting Down..
[176.53 INFO] (SDKD log:137) Jan 29, 2015 11:29:46 AM com.couchbase.client.core.CouchbaseCore <init>
[176.53 INFO] (SDKD log:137) INFO: CoreEnvironment: {sslEnabled=false, sslKeystoreFile='cacerts', sslKeystorePassword='couchbase', queryEnabled=true, queryPort=8093, bootstrapHttpEnabled=true, bootstrapCarrierEnabled=true, bootstrapHttpDirectPort=8091, bootstrapHttpSslPort=18091, bootstrapCarrierDirectPort=11210, bootstrapCarrierSslPort=11207, ioPoolSize=8, computationPoolSize=8, responseBufferSize=16384, requestBufferSize=16384, kvServiceEndpoints=1, viewServiceEndpoints=1, queryServiceEndpoints=1, ioPool=NioEventLoopGroup, coreScheduler=CoreScheduler, eventBus=DefaultEventBus, packageNameAndVersion=couchbase-java-client/2.1.0-SNAPSHOT (git: 2.1.0-dp2-5-g7347b7a), dcpEnabled=false, retryStrategy=BestEffort, maxRequestLifetime=75000, retryDelay=com.couchbase.client.core.time.ExponentialDelay@6c2fc00, reconnectDelay=com.couchbase.client.core.time.ExponentialDelay@f8e1d5c, observeIntervalDelay=com.couchbase.client.core.time.ExponentialDelay@1e2ab518}
[176.85 INFO] (SDKD log:137) Jan 29, 2015 11:29:46 AM com.couchbase.client.core.node.CouchbaseNode$5 call
[176.85 INFO] (SDKD log:137) INFO: Connected to Node 172.23.107.176
[176.94 INFO] (SDKD log:137) Jan 29, 2015 11:29:46 AM com.couchbase.client.core.config.DefaultConfigurationProvider$6 call
[176.94 INFO] (SDKD log:137) INFO: Opened bucket default
[176.94 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@102.4
[176.94 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@102.5 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.94 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@103.6 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.94 INFO] (SDKD log:137) Jan 29, 2015 11:29:46 AM com.couchbase.sdkd.server.SdkServer shutdown
[176.94 INFO] (SDKD log:137) WARNING: Shutting Down..
[176.94 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@103.6
[176.94 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@103.7 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.95 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.95 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.95 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@104.8 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.95 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.95 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.95 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@104.8
[176.95 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@104.9 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.95 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@105.10 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.95 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.95 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.96 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@105.10
[176.96 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@105.11 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.96 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@106.12 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.96 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.96 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.96 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@106.12
[176.96 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@106.13 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.96 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@107.14 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.96 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.96 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.96 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@107.14
[176.96 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@107.15 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.97 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@108.16 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.97 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.97 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.97 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@108.16
[176.97 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@108.17 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.97 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@109.18 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.97 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.97 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.97 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@109.18
[176.97 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@109.19 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.98 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@110.20 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.98 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.98 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.98 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@110.20
[176.98 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@110.21 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.98 DEBUG] (Handle sendMessageAsync:183) > NEWHANDLE@111.22 => {Options={OtherNodes=[], Username=default, ClusterCertificate=, SSL=false, Password=}, Bucket=default, Port=8091, Hostname=172.23.107.176}
[176.98 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.98 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[176.98 DEBUG] (Handle receiveMessage:158) < NEWHANDLE@111.22
[176.98 DEBUG] (Handle sendMessageAsync:183) > CB_N1QL_QUERY@111.23 => {Options={DelayMin=1, ReplicateTo=1, N1QLQueryDelay=0, TimeRes=1, N1QLQueryCount=-1, PersistTo=1, ReplicaRead=true, IterWait=1, DelayMax=10}, N1QLQuery=SELECT * from default WHERE META(default).id = 'N1QLFillerSeed', N1QLParameters={consistency=not_bounded, timeout=15}, DSType=DSTYPE_SEEDED, DS={}}
[176.98 INFO] (SDKD log:137) Jan 29, 2015 11:29:47 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext execIter
[176.98 INFO] (SDKD log:137) INFO: Running n1ql query: SELECT * from default WHERE META(default).id = 'N1QLFillerSeed'
[180.98 DEBUG] (Handle sendMessageAsync:183) > CANCEL@102.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@102.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@103.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@103.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@104.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@104.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@105.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@105.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@106.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@106.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@107.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@107.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@108.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@108.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@109.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@109.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@110.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@110.23
[180.99 DEBUG] (Handle sendMessageAsync:183) > CANCEL@111.23
[180.99 DEBUG] (Handle receiveMessage:158) < CANCEL@111.23
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) {"msg":"Primary index already exists","code":5000}
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.91 INFO] (SDKD log:137) parameters are passsed correctly: *:default:META(default).id:N1QLFillerSeed
[182.99 INFO] (SDKD log:137) []
[183.00 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.00 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.00 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.01 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.01 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.01 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.03 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.03 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.03 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.04 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.04 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.04 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.04 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@102.5 => {[OK]: 2} (tms: 1s)
[183.05 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@103.7 => {[OK]: 2} (tms: 1s)
[183.05 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.05 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.05 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.07 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.07 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.07 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.07 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.07 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.07 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.08 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.08 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.08 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.08 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@104.9 => {[OK]: 2} (tms: 1s)
[183.09 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@105.11 => {[OK]: 2} (tms: 1s)
[183.09 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@106.13 => {[OK]: 2} (tms: 1s)
[183.09 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@107.15 => {[OK]: 2} (tms: 1s)
[183.09 INFO] (SDKD log:137) [{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}]
[183.09 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.cbclient.N1QLQueryCommandContext scanSingleRow
[183.09 INFO] (SDKD log:137) INFO: QueryRow :{"default":{"KVSequence":999,"InflateContent":"meh","KIdent":"N1QLFillerSeed","InflateLevel":35}}
[183.10 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@108.17 => {[OK]: 2} (tms: 1s)
[183.10 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@109.19 => {[OK]: 1} (tms: 1s)
[183.10 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@110.21 => {[OK]: 2} (tms: 1s)
[183.10 DEBUG] (Handle receiveMessage:158) < CB_N1QL_QUERY@111.23 => {[OK]: 2} (tms: 1s)
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@102.24
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@103.25
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@104.26
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@105.27
[183.10 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@106.28
[183.10 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@107.29
[183.10 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.10 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@108.30
[183.10 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@109.31
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@110.32
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@111.33
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (RunContext run:215) Closing SDKD Handles
[183.11 DEBUG] (Handle sendMessageAsync:183) > GOODBYE@0.34
[183.11 DEBUG] (Handle sendMessageAsync:183) > CLOSEHANDLE@100.35
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.ControlServer run
[183.11 INFO] (SDKD log:137) INFO: ioLoop returned false. Returning..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.11 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.11 INFO] (HostPortDriver stop:123) SDKD is not yet terminated. Terminating..
[183.11 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.12 INFO] (HostPortDriver terminate:44) Waiting for process termination..
[183.12 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.12 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.12 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.12 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.12 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.12 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.12 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.12 INFO] (SDKD log:137) Jan 29, 2015 11:29:53 AM com.couchbase.sdkd.server.SdkServer shutdown
[183.12 INFO] (SDKD log:137) WARNING: Shutting Down..
[183.12 ERROR] (LineGobbler err:160) Stream Error
java.io.IOException: Stream closed
at java.io.BufferedInputStream.getBufIfOpen(BufferedInputStream.java:170) ~[na:1.8.0_05]
at java.io.BufferedInputStream.read(BufferedInputStream.java:336) ~[na:1.8.0_05]
at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284) ~[na:1.8.0_05]
at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326) ~[na:1.8.0_05]
at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178) ~[na:1.8.0_05]
at java.io.InputStreamReader.read(InputStreamReader.java:184) ~[na:1.8.0_05]
at java.io.BufferedReader.fill(BufferedReader.java:161) ~[na:1.8.0_05]
at java.io.BufferedReader.readLine(BufferedReader.java:324) ~[na:1.8.0_05]
at java.io.BufferedReader.readLine(BufferedReader.java:389) ~[na:1.8.0_05]
at com.couchbase.sdkdclient.util.LineGobbler.run(LineGobbler.java:76) ~[sdkdclient-1.0-SNAPSHOT.jar:na]
[183.12 ERROR] (HostPortDriver stop:135) SDKD terminated with error 143
[184.25 INFO] (BRun uploadFile:136) Uploaded HTML => http://sdk-testresults.couchbase.com.s3.amazonaws.com/SDK-SDK/CB-3.5.0-1049/passthrough-KV/01-29-15/070010/0c2ec4728ffa9937e2fc1c74d56bd710-MC.html
[184.43 INFO] (BRun uploadFile:136) Uploaded TEXT => http://sdk-testresults.couchbase.com.s3.amazonaws.com/SDK-SDK/CB-3.5.0-1049/passthrough-KV/01-29-15/070010/0c2ec4728ffa9937e2fc1c74d56bd710-MC.txt
[184.64 INFO] (BRun uploadFile:136) Uploaded RAW => http://sdk-testresults.couchbase.com.s3.amazonaws.com/SDK-SDK/CB-3.5.0-1049/passthrough-KV/01-29-15/070010/0c2ec4728ffa9937e2fc1c74d56bd710.zip
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment