./chc-comp-wrapper.sh ../../../chc-comp24-benchmarks/LIA-Arrays/chc-comp24-LIA-Arrays-096.smt2 .


--------------------------------------------------------------------------------


This is Ultimate 0.3.0-dev-42d8767-m
[2025-04-28 21:21:24,134 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-04-28 21:21:24,245 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_ad143cfd-2467-44d6-b50b-f2ab89b3bdc6/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-04-28 21:21:24,254 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-04-28 21:21:24,254 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-04-28 21:21:24,282 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-04-28 21:21:24,283 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-04-28 21:21:24,283 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-04-28 21:21:24,283 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-04-28 21:21:24,284 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-04-28 21:21:24,284 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-04-28 21:21:24,284 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-04-28 21:21:24,284 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-04-28 21:21:24,285 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-04-28 21:21:24,285 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-04-28 21:21:24,285 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-04-28 21:21:24,285 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-04-28 21:21:24,285 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-04-28 21:21:24,286 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:24,286 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-04-28 21:21:24,286 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-04-28 21:21:24,286 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-04-28 21:21:24,286 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-04-28 21:21:24,287 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-04-28 21:21:24,287 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-04-28 21:21:24,288 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-04-28 21:21:24,288 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-04-28 21:21:24,701 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-04-28 21:21:24,714 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-04-28 21:21:24,719 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-04-28 21:21:24,723 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-04-28 21:21:24,724 INFO  L274        PluginConnector]: SmtParser initialized
[2025-04-28 21:21:24,727 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_ad143cfd-2467-44d6-b50b-f2ab89b3bdc6/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA-Arrays/chc-comp24-LIA-Arrays-096.smt2
[2025-04-28 21:21:24,729 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-04-28 21:21:24,736 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-04-28 21:21:25,323 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_ad143cfd-2467-44d6-b50b-f2ab89b3bdc6/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA-Arrays/chc-comp24-LIA-Arrays-096.smt2
[2025-04-28 21:21:25,327 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-04-28 21:21:25,329 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-04-28 21:21:25,330 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-04-28 21:21:25,330 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-04-28 21:21:25,331 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-04-28 21:21:25,335 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,409 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25 Unit
[2025-04-28 21:21:25,410 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-04-28 21:21:25,411 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-04-28 21:21:25,411 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-04-28 21:21:25,411 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-04-28 21:21:25,434 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,434 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,484 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,485 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,494 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,496 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,499 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,503 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,505 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,524 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-04-28 21:21:25,525 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-04-28 21:21:25,525 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-04-28 21:21:25,526 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-04-28 21:21:25,527 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (1/1) ...
[2025-04-28 21:21:25,531 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:25,554 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:25,570 INFO  L229       MonitoredProcess]: Starting monitored process 1 with /usr/bin/z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000 (exit command is (exit), workingDir is null)
[2025-04-28 21:21:25,574 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000 (1)] Waiting until timeout for monitored process
[2025-04-28 21:21:25,588 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-04-28 21:21:25,588 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-04-28 21:21:25,588 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-04-28 21:21:25,588 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure realizable given in one single declaration
[2025-04-28 21:21:25,588 INFO  L130     BoogieDeclarations]: Found specification of procedure realizable
[2025-04-28 21:21:25,589 INFO  L138     BoogieDeclarations]: Found implementation of procedure realizable
[2025-04-28 21:21:25,589 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcStart__syn given in one single declaration
[2025-04-28 21:21:25,589 INFO  L130     BoogieDeclarations]: Found specification of procedure funcStart__syn
[2025-04-28 21:21:25,589 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcStart__syn
[2025-04-28 21:21:25,589 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcB__syn given in one single declaration
[2025-04-28 21:21:25,589 INFO  L130     BoogieDeclarations]: Found specification of procedure funcB__syn
[2025-04-28 21:21:25,589 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcB__syn
[2025-04-28 21:21:25,589 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcA__syn given in one single declaration
[2025-04-28 21:21:25,589 INFO  L130     BoogieDeclarations]: Found specification of procedure funcA__syn
[2025-04-28 21:21:25,589 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcA__syn
[2025-04-28 21:21:25,590 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcS__syn given in one single declaration
[2025-04-28 21:21:25,590 INFO  L130     BoogieDeclarations]: Found specification of procedure funcS__syn
[2025-04-28 21:21:25,590 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcS__syn
[2025-04-28 21:21:25,590 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcE__syn given in one single declaration
[2025-04-28 21:21:25,590 INFO  L130     BoogieDeclarations]: Found specification of procedure funcE__syn
[2025-04-28 21:21:25,590 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcE__syn
[2025-04-28 21:21:25,590 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcStart__sem given in one single declaration
[2025-04-28 21:21:25,590 INFO  L130     BoogieDeclarations]: Found specification of procedure funcStart__sem
[2025-04-28 21:21:25,590 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcStart__sem
[2025-04-28 21:21:25,590 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcS__sem given in one single declaration
[2025-04-28 21:21:25,590 INFO  L130     BoogieDeclarations]: Found specification of procedure funcS__sem
[2025-04-28 21:21:25,591 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcS__sem
[2025-04-28 21:21:25,591 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcE__sem given in one single declaration
[2025-04-28 21:21:25,591 INFO  L130     BoogieDeclarations]: Found specification of procedure funcE__sem
[2025-04-28 21:21:25,591 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcE__sem
[2025-04-28 21:21:25,591 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcA__sem given in one single declaration
[2025-04-28 21:21:25,591 INFO  L130     BoogieDeclarations]: Found specification of procedure funcA__sem
[2025-04-28 21:21:25,591 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcA__sem
[2025-04-28 21:21:25,591 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure funcB__sem given in one single declaration
[2025-04-28 21:21:25,591 INFO  L130     BoogieDeclarations]: Found specification of procedure funcB__sem
[2025-04-28 21:21:25,591 INFO  L138     BoogieDeclarations]: Found implementation of procedure funcB__sem
[2025-04-28 21:21:25,592 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-04-28 21:21:25,592 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-04-28 21:21:25,592 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-04-28 21:21:25,806 INFO  L234             CfgBuilder]: Building ICFG
[2025-04-28 21:21:25,812 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-04-28 21:21:26,362 INFO  L?                        ?]: Removed 130 outVars from TransFormulas that were not future-live.
[2025-04-28 21:21:26,362 INFO  L283             CfgBuilder]: Performing block encoding
[2025-04-28 21:21:26,379 INFO  L304             CfgBuilder]: Using library mode
[2025-04-28 21:21:26,379 INFO  L312             CfgBuilder]: Removed 1 assume(true) statements.
[2025-04-28 21:21:26,380 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:26 BoogieIcfgContainer
[2025-04-28 21:21:26,380 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-04-28 21:21:26,384 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-04-28 21:21:26,385 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-04-28 21:21:26,389 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-04-28 21:21:26,389 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:25" (1/3) ...
[2025-04-28 21:21:26,390 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@1a5034f3 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 28.04 09:21:26, skipping insertion in model container
[2025-04-28 21:21:26,390 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:25" (2/3) ...
[2025-04-28 21:21:26,390 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@1a5034f3 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 28.04 09:21:26, skipping insertion in model container
[2025-04-28 21:21:26,390 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:26" (3/3) ...
[2025-04-28 21:21:26,393 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-04-28 21:21:26,409 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-04-28 21:21:26,412 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 13 procedures, 78 locations, 162 edges, 13 initial locations, 0 loop locations, and 1 error locations.
[2025-04-28 21:21:26,475 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-04-28 21:21:26,493 INFO  L340      AbstractCegarLoop]: Settings: SEPARATE_VIOLATION_CHECK=true, mInterprocedural=true, mMaxIterations=1000000, mWatchIteration=1000000, mArtifact=RCFG, mInterpolation=FPandBP, mInterpolantAutomaton=STRAIGHT_LINE, mDumpAutomata=false, mAutomataFormat=ATS_NUMERATE, mDumpPath=., mDeterminiation=PREDICATE_ABSTRACTION, mMinimize=MINIMIZE_SEVPA, mAutomataTypeConcurrency=PETRI_NET, mHoareTripleChecks=INCREMENTAL, mHoareAnnotationPositions=None, mDumpOnlyReuseAutomata=false, mLimitTraceHistogram=0, mErrorLocTimeLimit=0, mLimitPathProgramCount=0, mCollectInterpolantStatistics=true, mHeuristicEmptinessCheck=false, mHeuristicEmptinessCheckAStarHeuristic=ZERO, mHeuristicEmptinessCheckAStarHeuristicRandomSeed=1337, mHeuristicEmptinessCheckSmtFeatureScoringMethod=DAGSIZE, mSMTFeatureExtraction=false, mSMTFeatureExtractionDumpPath=., mOverrideInterpolantAutomaton=false, mMcrInterpolantMethod=WP, mPorIndependenceSettings=[Lde.uni_freiburg.informatik.ultimate.lib.tracecheckerutils.partialorder.independence.IndependenceSettings;@47b19662, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-04-28 21:21:26,493 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-04-28 21:21:26,498 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 78 states, 25 states have (on average 1.8) internal successors, (45), 41 states have internal predecessors, (45), 39 states have call successors, (39), 12 states have call predecessors, (39), 12 states have return successors, (39), 25 states have call predecessors, (39), 39 states have call successors, (39)
[2025-04-28 21:21:26,516 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 41
[2025-04-28 21:21:26,516 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:26,517 INFO  L218           NwaCegarLoop]: trace histogram [3, 3, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:26,518 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:26,524 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:26,524 INFO  L85        PathProgramCache]: Analyzing trace with hash -1774160159, now seen corresponding path program 1 times
[2025-04-28 21:21:26,532 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:26,533 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [466542785]
[2025-04-28 21:21:26,533 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:26,533 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:26,600 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 40 statements into 1 equivalence classes.
[2025-04-28 21:21:26,678 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 40 of 40 statements.
[2025-04-28 21:21:26,679 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:26,679 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:27,735 INFO  L134       CoverageAnalysis]: Checked inductivity of 9 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:27,735 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:27,735 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [466542785]
[2025-04-28 21:21:27,737 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [466542785] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:27,737 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-04-28 21:21:27,797 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [] total 6
[2025-04-28 21:21:27,801 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [868417741]
[2025-04-28 21:21:27,805 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:27,811 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-04-28 21:21:27,812 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:27,896 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-04-28 21:21:27,896 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=10, Invalid=20, Unknown=0, NotChecked=0, Total=30
[2025-04-28 21:21:27,903 INFO  L87              Difference]: Start difference. First operand  has 78 states, 25 states have (on average 1.8) internal successors, (45), 41 states have internal predecessors, (45), 39 states have call successors, (39), 12 states have call predecessors, (39), 12 states have return successors, (39), 25 states have call predecessors, (39), 39 states have call successors, (39) Second operand  has 6 states, 4 states have (on average 4.0) internal successors, (16), 6 states have internal predecessors, (16), 4 states have call successors, (10), 1 states have call predecessors, (10), 4 states have return successors, (10), 3 states have call predecessors, (10), 4 states have call successors, (10)
[2025-04-28 21:21:28,177 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:28,179 INFO  L93              Difference]: Finished difference Result 82 states and 129 transitions.
[2025-04-28 21:21:28,181 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-04-28 21:21:28,183 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 4 states have (on average 4.0) internal successors, (16), 6 states have internal predecessors, (16), 4 states have call successors, (10), 1 states have call predecessors, (10), 4 states have return successors, (10), 3 states have call predecessors, (10), 4 states have call successors, (10) Word has length 40
[2025-04-28 21:21:28,184 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:28,198 INFO  L225             Difference]: With dead ends: 82
[2025-04-28 21:21:28,199 INFO  L226             Difference]: Without dead ends: 78
[2025-04-28 21:21:28,201 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 6 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 4 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=10, Invalid=20, Unknown=0, NotChecked=0, Total=30
[2025-04-28 21:21:28,209 INFO  L437           NwaCegarLoop]: 118 mSDtfsCounter, 2 mSDsluCounter, 457 mSDsCounter, 0 mSdLazyCounter, 21 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 6 SdHoareTripleChecker+Valid, 575 SdHoareTripleChecker+Invalid, 21 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.1s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 21 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:28,210 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [6 Valid, 575 Invalid, 21 Unknown, 0 Unchecked, 0.1s Time], IncrementalHoareTripleChecker [0 Valid, 21 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-04-28 21:21:28,232 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 78 states.
[2025-04-28 21:21:28,277 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 78 to 78.
[2025-04-28 21:21:28,282 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 78 states, 25 states have (on average 1.76) internal successors, (44), 40 states have internal predecessors, (44), 39 states have call successors, (39), 12 states have call predecessors, (39), 13 states have return successors, (40), 25 states have call predecessors, (40), 39 states have call successors, (40)
[2025-04-28 21:21:28,296 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 78 states to 78 states and 123 transitions.
[2025-04-28 21:21:28,297 INFO  L79                 Accepts]: Start accepts. Automaton has 78 states and 123 transitions. Word has length 40
[2025-04-28 21:21:28,298 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:28,299 INFO  L485      AbstractCegarLoop]: Abstraction has 78 states and 123 transitions.
[2025-04-28 21:21:28,299 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 4 states have (on average 4.0) internal successors, (16), 6 states have internal predecessors, (16), 4 states have call successors, (10), 1 states have call predecessors, (10), 4 states have return successors, (10), 3 states have call predecessors, (10), 4 states have call successors, (10)
[2025-04-28 21:21:28,300 INFO  L278                IsEmpty]: Start isEmpty. Operand 78 states and 123 transitions.
[2025-04-28 21:21:28,307 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 69
[2025-04-28 21:21:28,310 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:28,310 INFO  L218           NwaCegarLoop]: trace histogram [3, 3, 3, 3, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:28,310 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-04-28 21:21:28,311 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:28,311 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:28,312 INFO  L85        PathProgramCache]: Analyzing trace with hash -630724298, now seen corresponding path program 1 times
[2025-04-28 21:21:28,312 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:28,312 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1084277233]
[2025-04-28 21:21:28,312 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:28,312 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:28,387 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:28,446 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:28,446 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:28,446 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:29,133 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 2 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:29,134 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:29,134 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1084277233]
[2025-04-28 21:21:29,134 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1084277233] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:29,134 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [934641124]
[2025-04-28 21:21:29,134 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:29,134 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:29,138 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:29,141 INFO  L229       MonitoredProcess]: Starting monitored process 2 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:29,145 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-04-28 21:21:29,434 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:29,718 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:29,718 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:29,718 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:29,727 INFO  L256         TraceCheckSpWp]: Trace formula consists of 861 conjuncts, 4 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:29,741 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:29,829 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 6 proven. 0 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:29,829 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-04-28 21:21:29,829 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [934641124] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:29,829 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-04-28 21:21:29,830 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [4] total 5
[2025-04-28 21:21:29,830 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1398888925]
[2025-04-28 21:21:29,831 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:29,831 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-04-28 21:21:29,831 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:29,832 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-04-28 21:21:29,832 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=8, Invalid=12, Unknown=0, NotChecked=0, Total=20
[2025-04-28 21:21:29,833 INFO  L87              Difference]: Start difference. First operand 78 states and 123 transitions. Second operand  has 4 states, 3 states have (on average 9.333333333333334) internal successors, (28), 4 states have internal predecessors, (28), 3 states have call successors, (17), 2 states have call predecessors, (17), 3 states have return successors, (17), 2 states have call predecessors, (17), 3 states have call successors, (17)
[2025-04-28 21:21:30,027 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:30,028 INFO  L93              Difference]: Finished difference Result 82 states and 136 transitions.
[2025-04-28 21:21:30,028 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-04-28 21:21:30,029 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 9.333333333333334) internal successors, (28), 4 states have internal predecessors, (28), 3 states have call successors, (17), 2 states have call predecessors, (17), 3 states have return successors, (17), 2 states have call predecessors, (17), 3 states have call successors, (17) Word has length 68
[2025-04-28 21:21:30,029 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:30,031 INFO  L225             Difference]: With dead ends: 82
[2025-04-28 21:21:30,031 INFO  L226             Difference]: Without dead ends: 82
[2025-04-28 21:21:30,031 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 76 GetRequests, 72 SyntacticMatches, 1 SemanticMatches, 3 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=8, Invalid=12, Unknown=0, NotChecked=0, Total=20
[2025-04-28 21:21:30,034 INFO  L437           NwaCegarLoop]: 111 mSDtfsCounter, 1 mSDsluCounter, 200 mSDsCounter, 0 mSdLazyCounter, 50 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 311 SdHoareTripleChecker+Invalid, 52 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 50 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:30,034 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 311 Invalid, 52 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 50 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:30,035 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 82 states.
[2025-04-28 21:21:30,063 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 82 to 80.
[2025-04-28 21:21:30,064 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 80 states, 26 states have (on average 1.7307692307692308) internal successors, (45), 42 states have internal predecessors, (45), 39 states have call successors, (39), 12 states have call predecessors, (39), 14 states have return successors, (47), 25 states have call predecessors, (47), 39 states have call successors, (47)
[2025-04-28 21:21:30,067 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 80 states to 80 states and 131 transitions.
[2025-04-28 21:21:30,067 INFO  L79                 Accepts]: Start accepts. Automaton has 80 states and 131 transitions. Word has length 68
[2025-04-28 21:21:30,068 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:30,068 INFO  L485      AbstractCegarLoop]: Abstraction has 80 states and 131 transitions.
[2025-04-28 21:21:30,068 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 9.333333333333334) internal successors, (28), 4 states have internal predecessors, (28), 3 states have call successors, (17), 2 states have call predecessors, (17), 3 states have return successors, (17), 2 states have call predecessors, (17), 3 states have call successors, (17)
[2025-04-28 21:21:30,069 INFO  L278                IsEmpty]: Start isEmpty. Operand 80 states and 131 transitions.
[2025-04-28 21:21:30,071 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 69
[2025-04-28 21:21:30,072 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:30,072 INFO  L218           NwaCegarLoop]: trace histogram [3, 3, 3, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:30,080 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-04-28 21:21:30,276 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2,2 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:30,276 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:30,277 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:30,277 INFO  L85        PathProgramCache]: Analyzing trace with hash 353018769, now seen corresponding path program 1 times
[2025-04-28 21:21:30,278 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:30,278 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [605381075]
[2025-04-28 21:21:30,278 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:30,278 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:30,343 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:30,423 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:30,424 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:30,424 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:32,086 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 2 proven. 4 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:32,088 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:32,088 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [605381075]
[2025-04-28 21:21:32,088 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [605381075] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:32,088 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [565904409]
[2025-04-28 21:21:32,089 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:32,090 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:32,093 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:32,096 INFO  L229       MonitoredProcess]: Starting monitored process 3 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:32,102 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-04-28 21:21:32,386 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:32,603 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:32,603 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:32,603 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:32,612 INFO  L256         TraceCheckSpWp]: Trace formula consists of 861 conjuncts, 15 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:32,618 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:32,682 INFO  L189   IndexEqualityManager]: detected not equals via solver
[2025-04-28 21:21:32,695 INFO  L354             Elim1Store]: Elim1 eliminated variable of array dimension 1, 2 stores, 0 select indices, 0 select index equivalence classes, 4 disjoint index pairs (out of 0 index pairs), introduced 0 new quantified variables, introduced 0 case distinctions, treesize of input 37 treesize of output 18
[2025-04-28 21:21:33,140 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 2 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:33,140 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:35,019 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 2 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:35,020 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [565904409] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:35,020 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:35,021 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [13, 10, 10] total 22
[2025-04-28 21:21:35,021 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [472806546]
[2025-04-28 21:21:35,021 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:35,022 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 22 states
[2025-04-28 21:21:35,023 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:35,024 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 22 interpolants.
[2025-04-28 21:21:35,024 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=50, Invalid=412, Unknown=0, NotChecked=0, Total=462
[2025-04-28 21:21:35,025 INFO  L87              Difference]: Start difference. First operand 80 states and 131 transitions. Second operand  has 22 states, 11 states have (on average 4.0) internal successors, (44), 19 states have internal predecessors, (44), 15 states have call successors, (30), 1 states have call predecessors, (30), 11 states have return successors, (30), 12 states have call predecessors, (30), 15 states have call successors, (30)
[2025-04-28 21:21:36,266 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:36,267 INFO  L93              Difference]: Finished difference Result 111 states and 185 transitions.
[2025-04-28 21:21:36,267 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 20 states. 
[2025-04-28 21:21:36,268 INFO  L79                 Accepts]: Start accepts. Automaton has  has 22 states, 11 states have (on average 4.0) internal successors, (44), 19 states have internal predecessors, (44), 15 states have call successors, (30), 1 states have call predecessors, (30), 11 states have return successors, (30), 12 states have call predecessors, (30), 15 states have call successors, (30) Word has length 68
[2025-04-28 21:21:36,268 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:36,271 INFO  L225             Difference]: With dead ends: 111
[2025-04-28 21:21:36,271 INFO  L226             Difference]: Without dead ends: 100
[2025-04-28 21:21:36,272 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 159 GetRequests, 127 SyntacticMatches, 2 SemanticMatches, 30 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 120 ImplicationChecksByTransitivity, 0.8s TimeCoverageRelationStatistics Valid=114, Invalid=878, Unknown=0, NotChecked=0, Total=992
[2025-04-28 21:21:36,273 INFO  L437           NwaCegarLoop]: 105 mSDtfsCounter, 11 mSDsluCounter, 1558 mSDsCounter, 0 mSdLazyCounter, 628 mSolverCounterSat, 17 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.8s Time, 0 mProtectedPredicate, 0 mProtectedAction, 24 SdHoareTripleChecker+Valid, 1663 SdHoareTripleChecker+Invalid, 645 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 17 IncrementalHoareTripleChecker+Valid, 628 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.9s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:36,273 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [24 Valid, 1663 Invalid, 645 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [17 Valid, 628 Invalid, 0 Unknown, 0 Unchecked, 0.9s Time]
[2025-04-28 21:21:36,274 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 100 states.
[2025-04-28 21:21:36,294 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 100 to 93.
[2025-04-28 21:21:36,294 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 93 states, 30 states have (on average 1.6333333333333333) internal successors, (49), 47 states have internal predecessors, (49), 44 states have call successors, (44), 12 states have call predecessors, (44), 18 states have return successors, (70), 33 states have call predecessors, (70), 44 states have call successors, (70)
[2025-04-28 21:21:36,297 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 93 states to 93 states and 163 transitions.
[2025-04-28 21:21:36,297 INFO  L79                 Accepts]: Start accepts. Automaton has 93 states and 163 transitions. Word has length 68
[2025-04-28 21:21:36,297 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:36,298 INFO  L485      AbstractCegarLoop]: Abstraction has 93 states and 163 transitions.
[2025-04-28 21:21:36,298 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 22 states, 11 states have (on average 4.0) internal successors, (44), 19 states have internal predecessors, (44), 15 states have call successors, (30), 1 states have call predecessors, (30), 11 states have return successors, (30), 12 states have call predecessors, (30), 15 states have call successors, (30)
[2025-04-28 21:21:36,298 INFO  L278                IsEmpty]: Start isEmpty. Operand 93 states and 163 transitions.
[2025-04-28 21:21:36,301 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 69
[2025-04-28 21:21:36,301 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:36,302 INFO  L218           NwaCegarLoop]: trace histogram [3, 3, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:36,310 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Forceful destruction successful, exit code 0
[2025-04-28 21:21:36,505 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3,3 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:36,506 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:36,506 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:36,507 INFO  L85        PathProgramCache]: Analyzing trace with hash -1986187627, now seen corresponding path program 1 times
[2025-04-28 21:21:36,508 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:36,508 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [90459337]
[2025-04-28 21:21:36,508 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:36,508 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:36,572 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:36,621 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:36,621 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:36,621 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:38,017 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 0 proven. 4 refuted. 0 times theorem prover too weak. 17 trivial. 0 not checked.
[2025-04-28 21:21:38,017 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:38,017 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [90459337]
[2025-04-28 21:21:38,017 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [90459337] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:38,018 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [910530093]
[2025-04-28 21:21:38,018 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:38,018 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:38,023 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:38,026 INFO  L229       MonitoredProcess]: Starting monitored process 4 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:38,029 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-04-28 21:21:38,243 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:38,399 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:38,399 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:38,399 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:38,405 INFO  L256         TraceCheckSpWp]: Trace formula consists of 861 conjuncts, 32 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:38,410 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:38,458 INFO  L189   IndexEqualityManager]: detected not equals via solver
[2025-04-28 21:21:38,465 INFO  L354             Elim1Store]: Elim1 eliminated variable of array dimension 1, 2 stores, 0 select indices, 0 select index equivalence classes, 4 disjoint index pairs (out of 0 index pairs), introduced 0 new quantified variables, introduced 0 case distinctions, treesize of input 37 treesize of output 18
[2025-04-28 21:21:39,450 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 0 proven. 6 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:39,450 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:45,150 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 0 proven. 6 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:45,150 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [910530093] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:45,150 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:45,151 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [17, 18, 18] total 40
[2025-04-28 21:21:45,151 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [465905375]
[2025-04-28 21:21:45,151 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:45,152 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 40 states
[2025-04-28 21:21:45,152 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:45,153 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 40 interpolants.
[2025-04-28 21:21:45,154 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=99, Invalid=1461, Unknown=0, NotChecked=0, Total=1560
[2025-04-28 21:21:45,155 INFO  L87              Difference]: Start difference. First operand 93 states and 163 transitions. Second operand  has 40 states, 17 states have (on average 2.9411764705882355) internal successors, (50), 32 states have internal predecessors, (50), 26 states have call successors, (34), 1 states have call predecessors, (34), 17 states have return successors, (35), 20 states have call predecessors, (35), 26 states have call successors, (35)
[2025-04-28 21:21:47,493 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:47,494 INFO  L93              Difference]: Finished difference Result 118 states and 224 transitions.
[2025-04-28 21:21:47,494 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 18 states. 
[2025-04-28 21:21:47,495 INFO  L79                 Accepts]: Start accepts. Automaton has  has 40 states, 17 states have (on average 2.9411764705882355) internal successors, (50), 32 states have internal predecessors, (50), 26 states have call successors, (34), 1 states have call predecessors, (34), 17 states have return successors, (35), 20 states have call predecessors, (35), 26 states have call successors, (35) Word has length 68
[2025-04-28 21:21:47,495 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:47,497 INFO  L225             Difference]: With dead ends: 118
[2025-04-28 21:21:47,497 INFO  L226             Difference]: Without dead ends: 114
[2025-04-28 21:21:47,499 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 170 GetRequests, 111 SyntacticMatches, 5 SemanticMatches, 54 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 319 ImplicationChecksByTransitivity, 2.1s TimeCoverageRelationStatistics Valid=221, Invalid=2859, Unknown=0, NotChecked=0, Total=3080
[2025-04-28 21:21:47,500 INFO  L437           NwaCegarLoop]: 109 mSDtfsCounter, 25 mSDsluCounter, 3233 mSDsCounter, 0 mSdLazyCounter, 1381 mSolverCounterSat, 78 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 1.3s Time, 0 mProtectedPredicate, 0 mProtectedAction, 25 SdHoareTripleChecker+Valid, 3342 SdHoareTripleChecker+Invalid, 1459 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 78 IncrementalHoareTripleChecker+Valid, 1381 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 1.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:47,500 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [25 Valid, 3342 Invalid, 1459 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [78 Valid, 1381 Invalid, 0 Unknown, 0 Unchecked, 1.5s Time]
[2025-04-28 21:21:47,501 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 114 states.
[2025-04-28 21:21:47,532 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 114 to 103.
[2025-04-28 21:21:47,532 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 103 states, 34 states have (on average 1.5588235294117647) internal successors, (53), 52 states have internal predecessors, (53), 46 states have call successors, (46), 12 states have call predecessors, (46), 22 states have return successors, (94), 39 states have call predecessors, (94), 46 states have call successors, (94)
[2025-04-28 21:21:47,535 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 103 states to 103 states and 193 transitions.
[2025-04-28 21:21:47,535 INFO  L79                 Accepts]: Start accepts. Automaton has 103 states and 193 transitions. Word has length 68
[2025-04-28 21:21:47,535 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:47,535 INFO  L485      AbstractCegarLoop]: Abstraction has 103 states and 193 transitions.
[2025-04-28 21:21:47,536 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 40 states, 17 states have (on average 2.9411764705882355) internal successors, (50), 32 states have internal predecessors, (50), 26 states have call successors, (34), 1 states have call predecessors, (34), 17 states have return successors, (35), 20 states have call predecessors, (35), 26 states have call successors, (35)
[2025-04-28 21:21:47,536 INFO  L278                IsEmpty]: Start isEmpty. Operand 103 states and 193 transitions.
[2025-04-28 21:21:47,542 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 69
[2025-04-28 21:21:47,542 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:47,542 INFO  L218           NwaCegarLoop]: trace histogram [3, 3, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:47,548 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Ended with exit code 0
[2025-04-28 21:21:47,743 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable4,4 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:47,743 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:47,743 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:47,744 INFO  L85        PathProgramCache]: Analyzing trace with hash -1110168621, now seen corresponding path program 1 times
[2025-04-28 21:21:47,744 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:47,744 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [767166024]
[2025-04-28 21:21:47,744 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:47,744 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:47,779 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:47,823 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:47,824 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:47,827 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:49,179 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 0 proven. 8 refuted. 0 times theorem prover too weak. 13 trivial. 0 not checked.
[2025-04-28 21:21:49,180 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:49,180 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [767166024]
[2025-04-28 21:21:49,180 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [767166024] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:49,180 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [332303199]
[2025-04-28 21:21:49,183 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:49,183 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:49,187 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:49,189 INFO  L229       MonitoredProcess]: Starting monitored process 5 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:49,194 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Waiting until timeout for monitored process
[2025-04-28 21:21:49,485 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-04-28 21:21:49,649 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-04-28 21:21:49,650 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:49,650 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:49,656 INFO  L256         TraceCheckSpWp]: Trace formula consists of 861 conjuncts, 36 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:49,662 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:49,719 INFO  L189   IndexEqualityManager]: detected not equals via solver
[2025-04-28 21:21:49,725 INFO  L354             Elim1Store]: Elim1 eliminated variable of array dimension 1, 2 stores, 0 select indices, 0 select index equivalence classes, 4 disjoint index pairs (out of 0 index pairs), introduced 0 new quantified variables, introduced 0 case distinctions, treesize of input 37 treesize of output 18
[2025-04-28 21:21:50,659 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 0 proven. 8 refuted. 0 times theorem prover too weak. 13 trivial. 0 not checked.
[2025-04-28 21:21:50,659 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
