Hi all,
I've got an issue running the contractrunnersuite. It seems that it crashes just after loading the blockchain. "popping off block xyz". I've tested with HelloWorld tests, resulting in the same crash. Is there a way to force reinitialisation or should I send the logs? (where could I upload them?) Thank you
We need to see the log file and a screen capture. Is that something that worked once and stopped working or never worked?
I've used the ContractRunnerSuite, and it stopped working at one point. I am not able to connect it to any event or change. I would reinstall Ardor and reinit everything, but that takes quite some time, hence my question how I could reinitialise the blockchain database of the unit tester.
Thanks for looking into that. Below you find my complete log, copied from the IntelliJ terminal.
/usr/lib/jvm/java-8-oracle/bin/java -ea -Didea.test.cyclic.buffer.size=1048576 -javaagent:/snap/intellij-idea-community/286/lib/idea_rt.jar=34469:/snap/intellij-idea-community/286/bin -Dfile.encoding=UTF-8 -classpath /snap/intellij-idea-community/286/lib/idea_rt.jar:/snap/intellij-idea-community/286/plugins/junit/lib/junit5-rt.jar:/snap/intellij-idea-community/286/plugins/junit/lib/junit-rt.jar:/usr/lib/jvm/java-8-oracle/jre/lib/charsets.jar:/usr/lib/jvm/java-8-oracle/jre/lib/deploy.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/cldrdata.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/dnsns.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/jaccess.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/jfxrt.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/localedata.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/nashorn.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/sunec.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/sunjce_provider.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/sunpkcs11.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/zipfs.jar:/usr/lib/jvm/java-8-oracle/jre/lib/javaws.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jce.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jfr.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jfxswt.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jsse.jar:/usr/lib/jvm/java-8-oracle/jre/lib/management-agent.jar:/usr/lib/jvm/java-8-oracle/jre/lib/plugin.jar:/usr/lib/jvm/java-8-oracle/jre/lib/resources.jar:/usr/lib/jvm/java-8-oracle/jre/lib/rt.jar:/home/malnemark/Ardor/addons/test/classes:/home/malnemark/Ardor/addons/classes:/home/malnemark/Ardor/ardor.jar:/home/malnemark/Ardor/lib/ed25519.jar:/home/malnemark/Ardor/lib/jna-5.5.0.jar:/home/malnemark/Ardor/lib/core-3.3.0.jar:/home/malnemark/Ardor/lib/h2-1.4.200.jar:/home/malnemark/Ardor/lib/javase-3.3.0.jar:/home/malnemark/Ardor/lib/weupnp-0.1.4.jar:/home/malnemark/Ardor/lib/tika-core-1.13.jar:/home/malnemark/Ardor/lib/javapoet-1.11.0.jar:/home/malnemark/Ardor/lib/slf4j-api-1.7.22.jar:/home/malnemark/Ardor/lib/commons-cli-1.3.1.jar:/home/malnemark/Ardor/lib/json-simple-1.1.1.jar:/home/malnemark/Ardor/lib/lucene-core-7.1.0.jar:/home/malnemark/Ardor/lib/tika-parsers-1.13.jar:/home/malnemark/Ardor/lib/bcpkix-jdk15on-165.jar:/home/malnemark/Ardor/lib/bcprov-jdk15on-165.jar:/home/malnemark/Ardor/lib/jna-platform-5.5.0.jar:/home/malnemark/Ardor/lib/slf4j-jdk14-1.7.22.jar:/home/malnemark/Ardor/lib/commons-math3-3.6.1.jar:/home/malnemark/Ardor/lib/lucene-queries-7.1.0.jar:/home/malnemark/Ardor/lib/javax.servlet-api-3.1.0.jar:/home/malnemark/Ardor/lib/purejavahidapi-0.0.10j1.jar:/home/malnemark/Ardor/lib/lucene-queryparser-7.1.0.jar:/home/malnemark/Ardor/lib/jetty-io-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-http-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-util-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-proxy-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-client-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-server-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/lucene-analyzers-common-7.1.0.jar:/home/malnemark/Ardor/lib/jetty-servlet-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-security-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-servlets-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-continuation-9.4.35.v20201120.jar:/home/malnemark/Ardor/ardor-tests.jar:/home/malnemark/Ardor/testlib/junit-4.11.jar:/home/malnemark/Ardor/testlib/hamcrest-core-1.3.jar:/home/malnemark/Ardor/testlib/websocket-api-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-client-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-common-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-server-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-servlet-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/javafx_webview_debugger--bce7c7c2ae-1.jar:/home/malnemark/Ardor/conf com.intellij.rt.junit.JUnitStarter -ideVersion5 -junit4 com.jelurida.ardor.contracts.ContractRunnerSuite
Initializing Nxt server version 2.3.3
Command line arguments
-ea
-Didea.test.cyclic.buffer.size=1048576
-javaagent:/snap/intellij-idea-community/286/lib/idea_rt.jar=34469:/snap/intellij-idea-community/286/bin
-Dfile.encoding=UTF-8
Loading nxt-installer.properties from classpath
isHeadless=false
Runtime mode nxt.env.CommandLineMode
User home folder /home/malnemark/Ardor
Loading nxt-default.properties from classpath
Loading nxt-installer.properties from classpath
Loading nxt.properties from test/java/unit-tests-nxt.properties
Loading logging-default.properties from classpath
2021-03-12 22:06:44 INFO: nxt.enableStackTraces = "true"
2021-03-12 22:06:44 INFO: nxt.enableLogTraceback = "false"
2021-03-12 22:06:44 INFO: nxt.enableLogThreadName = "true"
2021-03-12 22:06:44 INFO: main logging enabled
2021-03-12 22:06:44 INFO: main nxt.useStrongSecureRandom = "false"
2021-03-12 22:06:44 FINE: main java.version = 1.8.0_201
2021-03-12 22:06:44 FINE: main java.vm.version = 25.201-b09
2021-03-12 22:06:44 FINE: main java.vm.name = Java HotSpot(TM) 64-Bit Server VM
2021-03-12 22:06:44 FINE: main java.vendor = Oracle Corporation
2021-03-12 22:06:44 FINE: main java.vm.vendor = Oracle Corporation
2021-03-12 22:06:44 FINE: main java.home = /usr/lib/jvm/java-8-oracle/jre
2021-03-12 22:06:44 FINE: main java.library.path = /usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
2021-03-12 22:06:44 FINE: main java.class.path = /snap/intellij-idea-community/286/lib/idea_rt.jar:/snap/intellij-idea-community/286/plugins/junit/lib/junit5-rt.jar:/snap/intellij-idea-community/286/plugins/junit/lib/junit-rt.jar:/usr/lib/jvm/java-8-oracle/jre/lib/charsets.jar:/usr/lib/jvm/java-8-oracle/jre/lib/deploy.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/cldrdata.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/dnsns.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/jaccess.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/jfxrt.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/localedata.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/nashorn.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/sunec.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/sunjce_provider.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/sunpkcs11.jar:/usr/lib/jvm/java-8-oracle/jre/lib/ext/zipfs.jar:/usr/lib/jvm/java-8-oracle/jre/lib/javaws.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jce.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jfr.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jfxswt.jar:/usr/lib/jvm/java-8-oracle/jre/lib/jsse.jar:/usr/lib/jvm/java-8-oracle/jre/lib/management-agent.jar:/usr/lib/jvm/java-8-oracle/jre/lib/plugin.jar:/usr/lib/jvm/java-8-oracle/jre/lib/resources.jar:/usr/lib/jvm/java-8-oracle/jre/lib/rt.jar:/home/malnemark/Ardor/addons/test/classes:/home/malnemark/Ardor/addons/classes:/home/malnemark/Ardor/ardor.jar:/home/malnemark/Ardor/lib/ed25519.jar:/home/malnemark/Ardor/lib/jna-5.5.0.jar:/home/malnemark/Ardor/lib/core-3.3.0.jar:/home/malnemark/Ardor/lib/h2-1.4.200.jar:/home/malnemark/Ardor/lib/javase-3.3.0.jar:/home/malnemark/Ardor/lib/weupnp-0.1.4.jar:/home/malnemark/Ardor/lib/tika-core-1.13.jar:/home/malnemark/Ardor/lib/javapoet-1.11.0.jar:/home/malnemark/Ardor/lib/slf4j-api-1.7.22.jar:/home/malnemark/Ardor/lib/commons-cli-1.3.1.jar:/home/malnemark/Ardor/lib/json-simple-1.1.1.jar:/home/malnemark/Ardor/lib/lucene-core-7.1.0.jar:/home/malnemark/Ardor/lib/tika-parsers-1.13.jar:/home/malnemark/Ardor/lib/bcpkix-jdk15on-165.jar:/home/malnemark/Ardor/lib/bcprov-jdk15on-165.jar:/home/malnemark/Ardor/lib/jna-platform-5.5.0.jar:/home/malnemark/Ardor/lib/slf4j-jdk14-1.7.22.jar:/home/malnemark/Ardor/lib/commons-math3-3.6.1.jar:/home/malnemark/Ardor/lib/lucene-queries-7.1.0.jar:/home/malnemark/Ardor/lib/javax.servlet-api-3.1.0.jar:/home/malnemark/Ardor/lib/purejavahidapi-0.0.10j1.jar:/home/malnemark/Ardor/lib/lucene-queryparser-7.1.0.jar:/home/malnemark/Ardor/lib/jetty-io-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-http-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-util-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-proxy-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-client-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-server-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/lucene-analyzers-common-7.1.0.jar:/home/malnemark/Ardor/lib/jetty-servlet-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-security-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-servlets-9.4.35.v20201120.jar:/home/malnemark/Ardor/lib/jetty-continuation-9.4.35.v20201120.jar:/home/malnemark/Ardor/ardor-tests.jar:/home/malnemark/Ardor/testlib/junit-4.11.jar:/home/malnemark/Ardor/testlib/hamcrest-core-1.3.jar:/home/malnemark/Ardor/testlib/websocket-api-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-client-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-common-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-server-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/websocket-servlet-9.4.35.v20201120.jar:/home/malnemark/Ardor/testlib/javafx_webview_debugger--bce7c7c2ae-1.jar:/home/malnemark/Ardor/conf:/snap/intellij-idea-community/286/lib/idea_rt.jar
2021-03-12 22:06:44 FINE: main java.io.tmpdir = /tmp
2021-03-12 22:06:44 FINE: main os.arch = amd64
2021-03-12 22:06:44 FINE: main sun.arch.data.model = 64
2021-03-12 22:06:44 FINE: main os.name = Linux
2021-03-12 22:06:44 FINE: main file.encoding = UTF-8
2021-03-12 22:06:44 FINE: main java.security.policy = null
2021-03-12 22:06:44 FINE: main java.security.manager = null
2021-03-12 22:06:44 FINE: main java.specification.vendor = Oracle Corporation
2021-03-12 22:06:44 FINE: main nxt.runtime.mode = null
2021-03-12 22:06:44 FINE: main nxt.runtime.dirProvider = null
2021-03-12 22:06:44 FINE: main availableProcessors = 4
2021-03-12 22:06:44 FINE: main maxMemory = 1784152064
2021-03-12 22:06:44 FINE: main processId = 556751
2021-03-12 22:06:44 INFO: main nxt.isTestnet = "true"
2021-03-12 22:06:44 INFO: main nxt.isOffline = "true"
2021-03-12 22:06:44 INFO: main nxt.isLightClient = "false"
2021-03-12 22:06:44 INFO: main nxt.isPermissioned = "false"
2021-03-12 22:06:44 INFO: main nxt.isAutomatedTest = "true"
2021-03-12 22:06:44 INFO: main nxt.isAutomatedTestChildChainPermissions not defined, using default false
2021-03-12 22:06:44 INFO: main nxt.customLoginWarning not defined
2021-03-12 22:06:44 INFO: main nxt.maxRollback = "800"
2021-03-12 22:06:44 INFO: main nxt.testnetGuaranteedBalanceConfirmations = "1"
2021-03-12 22:06:44 INFO: main nxt.testnetLeasingDelay = "2"
2021-03-12 22:06:44 INFO: main nxt.forgingDelay = "10"
2021-03-12 22:06:44 INFO: main nxt.forgingSpeedup = "3"
2021-03-12 22:06:44 INFO: main nxt.testnetNumberOfForkConfirmations = "2"
2021-03-12 22:06:44 INFO: main nxt.batchCommitSize = "100"
2021-03-12 22:06:44 INFO: main nxt.maxPrunableLifetime = "7776000"
2021-03-12 22:06:44 INFO: main nxt.includeExpiredPrunable = "true"
2021-03-12 22:06:44 INFO: main nxt.enableLedgerWallet = "true"
2021-03-12 22:06:44 INFO: main nxt.correctInvalidFees = "false"
2021-03-12 22:06:44 INFO: main nxt.minBundlerBalanceFXT = "1000"
2021-03-12 22:06:44 INFO: main nxt.minBundlerFeeLimitFXT = "10"
2021-03-12 22:06:44 INFO: main nxt.disableFullTextSearch = "false"
2021-03-12 22:06:44 INFO: main nxt.disableMetadataDetection = "false"
2021-03-12 22:06:44 INFO: main nxt.statementLogThreshold = "10000"
2021-03-12 22:06:44 INFO: main nxt.transactionLogThreshold = "15000"
2021-03-12 22:06:44 INFO: main nxt.transactionLogInterval = "15"
2021-03-12 22:06:44 INFO: main nxt.dbCacheKB = "0"
2021-03-12 22:06:44 INFO: main nxt.testDbUrl not defined
2021-03-12 22:06:44 INFO: main nxt.testDbType = "h2"
2021-03-12 22:06:44 INFO: main nxt.testDbDir = "./nxt_unit_test_db/nxt"
2021-03-12 22:06:44 INFO: main nxt.testDbParams = "DB_CLOSE_ON_EXIT=FALSE"
2021-03-12 22:06:44 INFO: main nxt.testDbUsername = "sa"
2021-03-12 22:06:44 INFO: main nxt.testDbPassword = "{not logged}"
2021-03-12 22:06:44 INFO: main nxt.maxDbConnections = "30"
2021-03-12 22:06:44 INFO: main nxt.dbLoginTimeout = "70"
2021-03-12 22:06:44 INFO: main nxt.dbDefaultLockTimeout = "60"
2021-03-12 22:06:44 INFO: main nxt.dbMaxMemoryRows = "1000000"
2021-03-12 22:06:44 INFO: main nxt.adminPassword not defined
2021-03-12 22:06:44 INFO: main nxt.adminPasswordHash not defined
2021-03-12 22:06:44 INFO: main nxt.maxAPIRecords = "100"
2021-03-12 22:06:44 INFO: main nxt.enableAPIUPnP = "false"
2021-03-12 22:06:44 INFO: main nxt.apiServerIdleTimeout = "30000"
2021-03-12 22:06:44 INFO: main nxt.apiServerCORS = "true"
2021-03-12 22:06:44 INFO: main nxt.forwardedForHeader not defined
2021-03-12 22:06:44 INFO: main nxt.allowedBotHosts = "127.0.0.1; localhost; [0:0:0:0:0:0:0:1]; 0:0:0:0:0:0:0:1;"
2021-03-12 22:06:44 INFO: main nxt.enableAPIServer = "true"
2021-03-12 22:06:44 INFO: main nxt.apiServerHost = "127.0.0.1"
2021-03-12 22:06:44 INFO: main nxt.disableAdminPassword = "true"
2021-03-12 22:06:44 INFO: main nxt.apiSSL = "false"
2021-03-12 22:06:44 INFO: main API server using HTTP port 26875
2021-03-12 22:06:44 INFO: main nxt.apiResourceBase = "./html/www"
2021-03-12 22:06:44 INFO: main nxt.apiWelcomeFile = "index.html"
2021-03-12 22:06:44 INFO: main nxt.javadocResourceBase = "./html/doc"
2021-03-12 22:06:44 INFO: main nxt.maxUploadFileSize = "43008"
2021-03-12 22:06:44 INFO: main nxt.maxUploadFileSize = "43008"
2021-03-12 22:06:44 INFO: main nxt.enableAPIServerGZIPFilter not defined, using default false
2021-03-12 22:06:44 INFO: main nxt.apiFrameOptionsSameOrigin = "true"
2021-03-12 22:06:44 INFO: main nxt.apiCustomSetupImpl not defined
2021-03-12 22:06:44 INFO: main nxt.defaultChildBlockDeadline = "10"
2021-03-12 22:06:44 INFO: main nxt.trimFrequencyMultipliers = "PUBLIC_KEY-5;ALIAS-5"
2021-03-12 22:06:44 INFO: main nxt.trimDerivedTables = "true"
2021-03-12 22:06:44 INFO: main nxt.simulateEndlessDownload not defined, using default false
2021-03-12 22:06:45 INFO: main nxt.trimFrequency = "1000"
2021-03-12 22:06:45 INFO: main trimHeightOffset=842
2021-03-12 22:06:45 INFO: main nxt.stopDownloadHeight not defined or not numeric, using default value 0
2021-03-12 22:06:45 INFO: main nxt.processPolls = "true"
2021-03-12 22:06:45 INFO: main nxt.deleteFinishedShufflings = "false"
2021-03-12 22:06:45 INFO: main nxt.deleteProcessedVotes = "true"
2021-03-12 22:06:45 FINE: main Database jdbc url set to jdbc:h2:./nxt_unit_test_db/nxt;DB_CLOSE_ON_EXIT=FALSE;CACHE_SIZE=262144 username sa
2021-03-12 22:06:45 INFO: main nxt.connectionPoolImpl = "nxt.db.pool.H2ConnectionPool"
2021-03-12 22:06:47 FINE: main Database connection pool current size: 1
2021-03-12 22:06:47 INFO: main Database update may take a while if needed, current db version 178...
2021-03-12 22:06:47 INFO: main Database update may take a while if needed, current db version 167...
2021-03-12 22:06:47 INFO: main Database update may take a while if needed, current db version 167...
2021-03-12 22:06:47 INFO: main Database update may take a while if needed, current db version 167...
2021-03-12 22:06:47 INFO: main Database update may take a while if needed, current db version 167...
2021-03-12 22:06:47 INFO: main Database update may take a while if needed, current db version 167...
2021-03-12 22:06:47 INFO: main nxt.enableTransactionRebroadcasting = "true"
2021-03-12 22:06:47 INFO: main nxt.testUnconfirmedTransactions = "true"
2021-03-12 22:06:47 INFO: main nxt.maxUnconfirmedTransactions = "1500"
2021-03-12 22:06:47 INFO: main nxt.disableRemoveUnconfirmedTransactionsThread not defined, using default false
2021-03-12 22:06:47 INFO: main nxt.disableProcessWaitingTransactionsThread not defined, using default false
2021-03-12 22:06:47 INFO: main nxt.enablePublicKeyCache = "true"
2021-03-12 22:06:47 INFO: main nxt.ledgerTrimKeep = "0"
2021-03-12 22:06:47 INFO: main nxt.ledgerAccounts = "*"
2021-03-12 22:06:47 INFO: main Account ledger is tracking all accounts
2021-03-12 22:06:47 INFO: main nxt.ledgerLogUnconfirmed = "0"
2021-03-12 22:06:47 INFO: main nxt.maxNumberOfForgers = "100"
2021-03-12 22:06:47 INFO: main nxt.enableFakeForging = "true"
2021-03-12 22:06:47 INFO: main nxt.fakeForgingPublicKeys = "c695121842440c4646a128920af54c0f9d451a3c195f37e946cdb8c655753b77;584486d2ba4dbd7eaeadd071f9f8c3593cee620e1e374033551147d68899b529"
2021-03-12 22:06:47 INFO: main nxt.pauseForgingOnNoConnection = "true"
2021-03-12 22:06:47 INFO: main nxt.disableGenerateBlocksThread = "true"
2021-03-12 22:06:47 INFO: main Will not run GenerateBlocks thread
2021-03-12 22:06:47 INFO: main nxt.defaultChildBlockDeadline = "10"
2021-03-12 22:06:47 INFO: main nxt.bundlingFilter not defined
2021-03-12 22:06:47 INFO: main nxt.availableBundlingFilters = "nxt.addons.PersonalBundler;nxt.addons.AccountPropertyBundler; nxt.addons.AssetBundler;nxt.addons.CurrencyBundler;nxt.addons.PurchaseBundler; nxt.addons.QuotaBundler; nxt.addons.TransactionTypeBundler"
2021-03-12 22:06:47 INFO: main nxt.customBundlingFeeCalculators not defined
2021-03-12 22:06:47 INFO: main nxt.enablePeerUPnP = "true"
2021-03-12 22:06:47 INFO: main nxt.shareMyAddress = "false"
2021-03-12 22:06:47 INFO: main nxt.maxNumberOfOutboundConnections = "8"
2021-03-12 22:06:47 INFO: main nxt.maxNumberOfInboundConnections = "2000"
2021-03-12 22:06:47 INFO: main nxt.peerConnectTimeout = "10"
2021-03-12 22:06:47 INFO: main nxt.peerReadTimeout = "20"
2021-03-12 22:06:47 INFO: main nxt.peerServerHost = "0.0.0.0"
2021-03-12 22:06:47 INFO: main nxt.myAddress not defined
2021-03-12 22:06:47 INFO: main Network handler is offline
2021-03-12 22:06:47 INFO: main nxt.blacklistingPeriod = "600"
2021-03-12 22:06:47 INFO: main nxt.communicationLogging = "0"
2021-03-12 22:06:47 INFO: main nxt.getMorePeers = "true"
2021-03-12 22:06:47 INFO: main nxt.maxNumberOfKnownPeers = "2000"
2021-03-12 22:06:47 INFO: main nxt.minNumberOfKnownPeers = "1000"
2021-03-12 22:06:47 INFO: main nxt.usePeersDb = "true"
2021-03-12 22:06:47 INFO: main nxt.savePeers = "false"
2021-03-12 22:06:47 INFO: main nxt.hideErrorDetails = "false"
2021-03-12 22:06:47 INFO: main nxt.ignorePeerAnnouncedAddress = "false"
2021-03-12 22:06:47 INFO: main nxt.blacklistedBundlerAccounts not defined
2021-03-12 22:06:47 INFO: main nxt.credentials.secretPhrase not defined
2021-03-12 22:06:47 INFO: main nxt.testnetPeers not defined
2021-03-12 22:06:47 INFO: main nxt.knownBlacklistedPeers not defined
2021-03-12 22:06:47 INFO: main Peer services are offline
2021-03-12 22:06:47 INFO: main nxt.enableAPIProxy = "true"
2021-03-12 22:06:47 INFO: main nxt.apiProxyBlacklistingPeriod = "7200"
2021-03-12 22:06:47 INFO: main nxt.forceAPIProxyServerURL not defined
2021-03-12 22:06:47 INFO: main nxt.testnetProxyBootstrapNodes = "testardor.jelurida.com;"
2021-03-12 22:06:47 INFO: main nxt.addOns = "nxt.addons.ContractRunner;com.jelurida.ardor.contracts.TestApiAddOn"
2021-03-12 22:06:47 INFO: main nxt.disableSecurityPolicy = "false"
2021-03-12 22:06:47 INFO: main Creating Jelurida security provider
2021-03-12 22:06:47 INFO: main nxt.runtime.mode not defined
2021-03-12 22:06:47 INFO: main nxt.launchDesktopApplication = "true"
2021-03-12 22:06:47 INFO: main Desktop application isDesktopEnabled:false, isLaunchDesktopApplication:true, hasJavaFX:true
2021-03-12 22:06:47 INFO: main Setting security manager with policy ardor.policy
2021-03-12 22:06:47 INFO: main Initializing nxt.addons.ContractRunner
2021-03-12 22:06:47 INFO: main addon.contractRunner.configFile = "./addons/test/java/com/jelurida/ardor/contracts/test_contracts.json"
2021-03-12 22:06:47 INFO: main Loading file from path /home/malnemark/Ardor/./addons/test/java/com/jelurida/ardor/contracts/test_contracts.json
2021-03-12 22:06:47 INFO: main addon.contractRunner.privateKey not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.secretPhrase = "{not logged}"
2021-03-12 22:06:47 INFO: main addon.contractRunner.autoFeeRatePriority not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.minBundlerBalanceFXT not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.minBundlerFeeLimitFQT not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.feeRateNQTPerFXT.BITSWIFT not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.feeRateNQTPerFXT.MPG not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.feeRateNQTPerFXT.GPS not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.feeRateNQTPerFXT.IGNIS = "200000000"
2021-03-12 22:06:47 INFO: main addon.contractRunner.feeRateNQTPerFXT.AEUR = "20000"
2021-03-12 22:06:47 INFO: main addon.contractRunner.validator not defined
2021-03-12 22:06:47 INFO: main addon.contractRunner.seed not defined
2021-03-12 22:06:47 WARNING: main Contract runner random seed not specified, random values generated by this contract runner will be predictable
2021-03-12 22:06:47 INFO: main Contract Runner configuration loaded for account ARDOR-XK4R-7VJU-6EQG-7R335
2021-03-12 22:06:47 INFO: main ContractRunner shutting down all contracts
2021-03-12 22:06:47 INFO: main Loading contract Jackpot tx chain: IGNIS, full hash: c1e6c941d2a8468e931fa6416af64f1b9553117fbab7c3cfd27f5feab40619b5 runner account ARDOR-XK4R-7VJU-6EQG-7R335
2021-03-12 22:06:47 FINE: main Database connection pool current size: 2
2021-03-12 22:06:47 INFO: main CloudDataClassLoader implied permissions ("java.io.FilePermission" "/tmp*" "read,write,delete"),("java.lang.RuntimePermission" "stopThread"),("java.util.PropertyPermission" "java.io.tmpdir" "read"),("java.util.PropertyPermission" "java.specification.version" "read"),("java.util.PropertyPermission" "java.version" "read"),("java.util.PropertyPermission" "os.arch" "read"),("java.util.PropertyPermission" "java.specification.vendor" "read"),("java.util.PropertyPermission" "java.vm.specification.name" "read"),("java.util.PropertyPermission" "path.separator" "read"),("java.util.PropertyPermission" "java.vm.vendor" "read"),("java.util.PropertyPermission" "idea.test.cyclic.buffer.size" "read"),("java.util.PropertyPermission" "os.version" "read"),("java.util.PropertyPermission" "file.separator" "read"),("java.util.PropertyPermission" "line.separator" "read"),("java.util.PropertyPermission" "java.vendor" "read"),("java.util.PropertyPermission" "java.vendor.url" "read"),("java.util.PropertyPermission" "java.specification.name" "read"),("java.util.PropertyPermission" "java.vm.specification.vendor" "read"),("java.util.PropertyPermission" "java.vm.version" "read"),("java.util.PropertyPermission" "idea.junit.message.length.threshold" "read"),("java.util.PropertyPermission" "os.name" "read"),("java.util.PropertyPermission" "java.vm.specification.version" "read"),("java.util.PropertyPermission" "java.vm.name" "read"),("java.util.PropertyPermission" "java.class.version" "read"),(unresolved nxt.util.security.BlockchainPermission getBundlerRates null),(unresolved nxt.util.security.BlockchainPermission threadPool null),("java.net.URLPermission" "http:*" "*:*"),("java.net.URLPermission" "https:*" "*:*"),("java.net.SocketPermission" "localhost:0" "listen,resolve")
2021-03-12 22:06:47 INFO: main Initializing contract Jackpot with object identity 1934692470
2021-03-12 22:06:47 INFO: main nxt.apiServerEnforcePOST = "true"
2021-03-12 22:06:47 INFO: main nxt.apiFixResponseContentType = "false"
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: triggerContractByVoucher
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: saveContractRunnerEncrypted
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: getSupportedContracts
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: triggerContractByRequest
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: triggerContractByTransaction
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: triggerContractByHeight
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: startContractRunnerEncrypted
2021-03-12 22:06:47 INFO: main Add-on nxt.addons.ContractRunner registered new API: uploadContractRunnerConfiguration
2021-03-12 22:06:47 INFO: main Add-on com.jelurida.ardor.contracts.TestApiAddOn registered new API: TestApiAddOn
2021-03-12 22:06:47 INFO: main nxt.disabledAPIs not defined
2021-03-12 22:06:47 INFO: main nxt.disabledAPITags not defined
2021-03-12 22:06:47 INFO: main [getConstants]: request requestType=getConstants
2021-03-12 22:06:47 INFO: main ContractRunner Started
2021-03-12 22:06:47 INFO: main Initializing com.jelurida.ardor.contracts.TestApiAddOn
2021-03-12 22:06:47 INFO: main nxt.debugTraceQuote = """
2021-03-12 22:06:47 INFO: main nxt.debugTraceSeparator = " "
2021-03-12 22:06:47 INFO: main nxt.debugLogUnconfirmed = "false"
2021-03-12 22:06:47 INFO: main nxt.debugTraceAccounts not defined
2021-03-12 22:06:47 INFO: main nxt.debugTraceLog = "nxt-trace.csv"
2021-03-12 22:06:47 INFO: main nxt.timeMultiplier = "1"
2021-03-12 22:06:47 FINE: main Running 1 tasks...
2021-03-12 22:06:48 WARNING: Thread-1 Column in position 2 in SHUFFLING_ID_HEIGHT_IDX is 'HEIGHT' instead of 'FULL_HASH'. Fast trimming is disabled for table IGNIS.SHUFFLING
2021-03-12 22:06:48 WARNING: Thread-1 Column in position 2 in SHUFFLING_ID_HEIGHT_IDX is 'HEIGHT' instead of 'FULL_HASH'. Fast trimming is disabled for table AEUR.SHUFFLING
2021-03-12 22:06:48 WARNING: Thread-1 Column in position 2 in SHUFFLING_ID_HEIGHT_IDX is 'HEIGHT' instead of 'FULL_HASH'. Fast trimming is disabled for table BITSWIFT.SHUFFLING
2021-03-12 22:06:48 WARNING: Thread-1 Column in position 2 in SHUFFLING_ID_HEIGHT_IDX is 'HEIGHT' instead of 'FULL_HASH'. Fast trimming is disabled for table MPG.SHUFFLING
2021-03-12 22:06:48 WARNING: Thread-1 Column in position 2 in SHUFFLING_ID_HEIGHT_IDX is 'HEIGHT' instead of 'FULL_HASH'. Fast trimming is disabled for table GPS.SHUFFLING
2021-03-12 22:06:48 WARNING: Thread-1 Column CHILD_CHAIN_ID in PUBLIC.HOLDING_MIGRATE is not BIGINT. Fast trimming is disabled
2021-03-12 22:06:48 INFO: Thread-1 Genesis block already in database
2021-03-12 22:06:48 FINE: Thread-1 Will pop-off block 5649667879338536061
2021-03-12 22:06:48 FINE: Thread-1 Deleting blocks starting from height 9
2021-03-12 22:06:48 FINE: Thread-1 Average database transaction time is 0,020 seconds
2021-03-12 22:06:48 FINE: Thread-1 Rollback from block 5649667879338536061 at height 9 to 1797988708639827374 at 8
2021-03-12 22:07:48 SEVERE: Thread-1 Error popping off to 8, java.lang.RuntimeException: org.h2.jdbc.JdbcSQLTimeoutException: Zeitüberschreitung beim Versuch die Tabelle {0} zu sperren
Timeout trying to lock table {0}; SQL statement:
DELETE FROM PUBLIC.UNCONFIRMED_TRANSACTION WHERE height > ? LIMIT 100 [50200-200]
java.lang.RuntimeException: org.h2.jdbc.JdbcSQLTimeoutException: Zeitüberschreitung beim Versuch die Tabelle {0} zu sperren
Timeout trying to lock table {0}; SQL statement:
DELETE FROM PUBLIC.UNCONFIRMED_TRANSACTION WHERE height > ? LIMIT 100 [50200-200]
at nxt.db.DerivedDbTable.popOffTo(DerivedDbTable.java:47)
at nxt.db.TrimmableDbTable.popOffTo(TrimmableDbTable.java:180)
at nxt.blockchain.TransactionProcessorImpl$2.popOffTo(TransactionProcessorImpl.java:123)
at nxt.blockchain.BlockchainProcessorImpl.popOffTo(BlockchainProcessorImpl.java:1794)
at nxt.blockchain.BlockchainProcessorImpl.popOffTo(BlockchainProcessorImpl.java:1757)
at nxt.blockchain.BlockchainProcessorImpl.addGenesisBlock(BlockchainProcessorImpl.java:1387)
at nxt.blockchain.BlockchainProcessorImpl.lambda$new$6(BlockchainProcessorImpl.java:1001)
at nxt.util.ThreadPool.lambda$runAll$1(ThreadPool.java:165)
at java.lang.Thread.run(Thread.java:748)
Caused by: org.h2.jdbc.JdbcSQLTimeoutException: Zeitüberschreitung beim Versuch die Tabelle {0} zu sperren
Timeout trying to lock table {0}; SQL statement:
DELETE FROM PUBLIC.UNCONFIRMED_TRANSACTION WHERE height > ? LIMIT 100 [50200-200]
at org.h2.message.DbException.getJdbcSQLException(DbException.java:511)
at org.h2.message.DbException.getJdbcSQLException(DbException.java:429)
at org.h2.message.DbException.get(DbException.java:194)
at org.h2.command.Command.filterConcurrentUpdate(Command.java:309)
at org.h2.command.Command.executeUpdate(Command.java:253)
at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:191)
at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:152)
at nxt.db.FilteredPreparedStatement.executeUpdate(FilteredPreparedStatement.java:64)
at nxt.db.TransactionalDb$DbPreparedStatement.executeUpdate(TransactionalDb.java:409)
at nxt.db.DerivedDbTable.popOffTo(DerivedDbTable.java:43)
... 8 more
Caused by: org.h2.message.DbException: Row "12186" not found in primary index "PUBLIC.UNCONFIRMED_TRANSACTION_DATA" [90143-200]
at org.h2.message.DbException.get(DbException.java:205)
at org.h2.mvstore.db.MVPrimaryIndex.getRow(MVPrimaryIndex.java:254)
at org.h2.mvstore.db.MVTable.getRow(MVTable.java:323)
at org.h2.mvstore.db.MVSecondaryIndex$MVStoreCursor.get(MVSecondaryIndex.java:461)
at org.h2.index.IndexCursor.get(IndexCursor.java:274)
at org.h2.table.TableFilter.getValue(TableFilter.java:1166)
at org.h2.expression.ExpressionColumn.getValue(ExpressionColumn.java:202)
at org.h2.expression.condition.Comparison.getValue(Comparison.java:251)
at org.h2.expression.Expression.getBooleanValue(Expression.java:258)
at org.h2.command.dml.Delete.update(Delete.java:110)
at org.h2.command.CommandContainer.update(CommandContainer.java:198)
at org.h2.command.Command.executeUpdate(Command.java:251)
... 13 more
Caused by: org.h2.jdbc.JdbcSQLTransientException: Row "12186" not found in primary index "PUBLIC.UNCONFIRMED_TRANSACTION_DATA" [90143-200]
at org.h2.message.DbException.getJdbcSQLException(DbException.java:626)
at org.h2.message.DbException.getJdbcSQLException(DbException.java:429)
... 25 moreThe unit tests use their own database different from the mainnet (nxt_db) or testnet (nxt_test_db). Please look into a directory called nxt_unit_test_db and delete it, then run the unit tests again.