./chc-comp-wrapper.sh ../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-217.smt2 .


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-04-28 21:21:31,873 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-04-28 21:21:31,981 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_1527e0dc-e80f-43d3-a96e-28f7b933f290/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-04-28 21:21:31,993 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-04-28 21:21:31,993 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-04-28 21:21:32,031 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-04-28 21:21:32,033 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-04-28 21:21:32,033 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-04-28 21:21:32,035 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-04-28 21:21:32,035 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-04-28 21:21:32,036 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-04-28 21:21:32,036 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-04-28 21:21:32,036 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-04-28 21:21:32,036 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-04-28 21:21:32,038 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-04-28 21:21:32,038 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:32,039 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-04-28 21:21:32,039 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-04-28 21:21:32,041 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-04-28 21:21:32,041 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-04-28 21:21:32,388 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-04-28 21:21:32,402 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-04-28 21:21:32,404 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-04-28 21:21:32,406 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-04-28 21:21:32,408 INFO  L274        PluginConnector]: SmtParser initialized
[2025-04-28 21:21:32,409 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_1527e0dc-e80f-43d3-a96e-28f7b933f290/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-217.smt2
[2025-04-28 21:21:32,411 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-04-28 21:21:32,417 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-04-28 21:21:32,663 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_1527e0dc-e80f-43d3-a96e-28f7b933f290/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-217.smt2
[2025-04-28 21:21:32,670 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-04-28 21:21:32,671 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-04-28 21:21:32,672 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-04-28 21:21:32,672 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-04-28 21:21:32,672 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-04-28 21:21:32,676 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,697 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32 Unit
[2025-04-28 21:21:32,697 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-04-28 21:21:32,698 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-04-28 21:21:32,698 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-04-28 21:21:32,698 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-04-28 21:21:32,717 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,718 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,741 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,742 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,745 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,746 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,749 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,751 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,752 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,772 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-04-28 21:21:32,774 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-04-28 21:21:32,775 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-04-28 21:21:32,775 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-04-28 21:21:32,776 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (1/1) ...
[2025-04-28 21:21:32,779 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:32,792 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:32,807 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:32,811 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:32,823 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-04-28 21:21:32,824 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-04-28 21:21:32,824 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-04-28 21:21:32,824 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure CHC_COMP_FALSE given in one single declaration
[2025-04-28 21:21:32,824 INFO  L130     BoogieDeclarations]: Found specification of procedure CHC_COMP_FALSE
[2025-04-28 21:21:32,824 INFO  L138     BoogieDeclarations]: Found implementation of procedure CHC_COMP_FALSE
[2025-04-28 21:21:32,824 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure REC__f given in one single declaration
[2025-04-28 21:21:32,824 INFO  L130     BoogieDeclarations]: Found specification of procedure REC__f
[2025-04-28 21:21:32,824 INFO  L138     BoogieDeclarations]: Found implementation of procedure REC__f
[2025-04-28 21:21:32,825 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure REC_f_f given in one single declaration
[2025-04-28 21:21:32,825 INFO  L130     BoogieDeclarations]: Found specification of procedure REC_f_f
[2025-04-28 21:21:32,825 INFO  L138     BoogieDeclarations]: Found implementation of procedure REC_f_f
[2025-04-28 21:21:32,825 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure REC_f_ given in one single declaration
[2025-04-28 21:21:32,825 INFO  L130     BoogieDeclarations]: Found specification of procedure REC_f_
[2025-04-28 21:21:32,825 INFO  L138     BoogieDeclarations]: Found implementation of procedure REC_f_
[2025-04-28 21:21:32,825 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-04-28 21:21:32,825 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-04-28 21:21:32,825 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-04-28 21:21:32,876 INFO  L234             CfgBuilder]: Building ICFG
[2025-04-28 21:21:32,878 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-04-28 21:21:33,047 INFO  L?                        ?]: Removed 2 outVars from TransFormulas that were not future-live.
[2025-04-28 21:21:33,049 INFO  L283             CfgBuilder]: Performing block encoding
[2025-04-28 21:21:33,064 INFO  L304             CfgBuilder]: Using library mode
[2025-04-28 21:21:33,064 INFO  L312             CfgBuilder]: Removed 1 assume(true) statements.
[2025-04-28 21:21:33,065 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:33 BoogieIcfgContainer
[2025-04-28 21:21:33,065 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-04-28 21:21:33,068 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-04-28 21:21:33,068 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-04-28 21:21:33,072 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-04-28 21:21:33,072 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:32" (1/3) ...
[2025-04-28 21:21:33,074 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@3af1a50a and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 28.04 09:21:33, skipping insertion in model container
[2025-04-28 21:21:33,074 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:32" (2/3) ...
[2025-04-28 21:21:33,075 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@3af1a50a and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 28.04 09:21:33, skipping insertion in model container
[2025-04-28 21:21:33,075 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:33" (3/3) ...
[2025-04-28 21:21:33,077 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-04-28 21:21:33,096 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-04-28 21:21:33,099 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 6 procedures, 36 locations, 73 edges, 6 initial locations, 0 loop locations, and 1 error locations.
[2025-04-28 21:21:33,151 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-04-28 21:21:33,165 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;@1ab6b39b, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-04-28 21:21:33,165 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-04-28 21:21:33,173 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 36 states, 11 states have (on average 1.7272727272727273) internal successors, (19), 19 states have internal predecessors, (19), 18 states have call successors, (18), 5 states have call predecessors, (18), 5 states have return successors, (18), 14 states have call predecessors, (18), 18 states have call successors, (18)
[2025-04-28 21:21:33,187 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 17
[2025-04-28 21:21:33,189 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:33,190 INFO  L218           NwaCegarLoop]: trace histogram [2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:33,190 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:33,198 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:33,200 INFO  L85        PathProgramCache]: Analyzing trace with hash -8187285, now seen corresponding path program 1 times
[2025-04-28 21:21:33,209 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:33,209 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1391073253]
[2025-04-28 21:21:33,210 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:33,210 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:33,238 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 16 statements into 1 equivalence classes.
[2025-04-28 21:21:33,241 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 16 of 16 statements.
[2025-04-28 21:21:33,242 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:33,243 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:33,297 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-04-28 21:21:33,297 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:33,297 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1391073253]
[2025-04-28 21:21:33,298 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1391073253] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:33,298 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-04-28 21:21:33,301 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [2] imperfect sequences [] total 2
[2025-04-28 21:21:33,302 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1115150930]
[2025-04-28 21:21:33,303 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:33,307 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 2 states
[2025-04-28 21:21:33,308 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:33,335 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 2 interpolants.
[2025-04-28 21:21:33,335 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=1, Invalid=1, Unknown=0, NotChecked=0, Total=2
[2025-04-28 21:21:33,337 INFO  L87              Difference]: Start difference. First operand  has 36 states, 11 states have (on average 1.7272727272727273) internal successors, (19), 19 states have internal predecessors, (19), 18 states have call successors, (18), 5 states have call predecessors, (18), 5 states have return successors, (18), 14 states have call predecessors, (18), 18 states have call successors, (18) Second operand  has 2 states, 2 states have (on average 3.0) internal successors, (6), 2 states have internal predecessors, (6), 2 states have call successors, (4), 1 states have call predecessors, (4), 2 states have return successors, (4), 1 states have call predecessors, (4), 2 states have call successors, (4)
[2025-04-28 21:21:33,367 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:33,367 INFO  L93              Difference]: Finished difference Result 30 states and 43 transitions.
[2025-04-28 21:21:33,368 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 2 states. 
[2025-04-28 21:21:33,370 INFO  L79                 Accepts]: Start accepts. Automaton has  has 2 states, 2 states have (on average 3.0) internal successors, (6), 2 states have internal predecessors, (6), 2 states have call successors, (4), 1 states have call predecessors, (4), 2 states have return successors, (4), 1 states have call predecessors, (4), 2 states have call successors, (4) Word has length 16
[2025-04-28 21:21:33,370 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:33,376 INFO  L225             Difference]: With dead ends: 30
[2025-04-28 21:21:33,377 INFO  L226             Difference]: Without dead ends: 30
[2025-04-28 21:21:33,378 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 2 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 0 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=1, Invalid=1, Unknown=0, NotChecked=0, Total=2
[2025-04-28 21:21:33,381 INFO  L437           NwaCegarLoop]: 43 mSDtfsCounter, 0 mSDsluCounter, 0 mSDsCounter, 0 mSdLazyCounter, 0 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 0 SdHoareTripleChecker+Valid, 43 SdHoareTripleChecker+Invalid, 0 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 0 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:33,382 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [0 Valid, 43 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 0 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-04-28 21:21:33,394 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 30 states.
[2025-04-28 21:21:33,418 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 30 to 30.
[2025-04-28 21:21:33,419 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 30 states, 10 states have (on average 1.5) internal successors, (15), 15 states have internal predecessors, (15), 14 states have call successors, (14), 5 states have call predecessors, (14), 5 states have return successors, (14), 12 states have call predecessors, (14), 14 states have call successors, (14)
[2025-04-28 21:21:33,429 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 30 states to 30 states and 43 transitions.
[2025-04-28 21:21:33,430 INFO  L79                 Accepts]: Start accepts. Automaton has 30 states and 43 transitions. Word has length 16
[2025-04-28 21:21:33,430 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:33,431 INFO  L485      AbstractCegarLoop]: Abstraction has 30 states and 43 transitions.
[2025-04-28 21:21:33,431 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 2 states, 2 states have (on average 3.0) internal successors, (6), 2 states have internal predecessors, (6), 2 states have call successors, (4), 1 states have call predecessors, (4), 2 states have return successors, (4), 1 states have call predecessors, (4), 2 states have call successors, (4)
[2025-04-28 21:21:33,431 INFO  L278                IsEmpty]: Start isEmpty. Operand 30 states and 43 transitions.
[2025-04-28 21:21:33,436 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 17
[2025-04-28 21:21:33,436 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:33,436 INFO  L218           NwaCegarLoop]: trace histogram [2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:33,436 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-04-28 21:21:33,437 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:33,437 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:33,437 INFO  L85        PathProgramCache]: Analyzing trace with hash 1235596335, now seen corresponding path program 1 times
[2025-04-28 21:21:33,437 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:33,437 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1958436045]
[2025-04-28 21:21:33,438 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:33,438 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:33,450 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 16 statements into 1 equivalence classes.
[2025-04-28 21:21:33,472 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 16 of 16 statements.
[2025-04-28 21:21:33,472 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:33,472 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:34,111 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-04-28 21:21:34,113 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:34,113 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1958436045]
[2025-04-28 21:21:34,113 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1958436045] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:34,113 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1427107585]
[2025-04-28 21:21:34,113 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:34,113 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:34,117 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:34,125 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:34,126 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-04-28 21:21:34,175 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 16 statements into 1 equivalence classes.
[2025-04-28 21:21:34,193 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 16 of 16 statements.
[2025-04-28 21:21:34,194 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:34,194 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:34,197 WARN  L254         TraceCheckSpWp]: Trace formula consists of 58 conjuncts, 31 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:34,211 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:34,442 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-04-28 21:21:34,443 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-04-28 21:21:34,443 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1427107585] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:34,444 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-04-28 21:21:34,444 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [5] imperfect sequences [6] total 9
[2025-04-28 21:21:34,445 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [434852977]
[2025-04-28 21:21:34,445 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:34,446 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 5 states
[2025-04-28 21:21:34,448 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:34,448 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 5 interpolants.
[2025-04-28 21:21:34,449 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=16, Invalid=56, Unknown=0, NotChecked=0, Total=72
[2025-04-28 21:21:34,449 INFO  L87              Difference]: Start difference. First operand 30 states and 43 transitions. Second operand  has 5 states, 3 states have (on average 2.0) internal successors, (6), 3 states have internal predecessors, (6), 3 states have call successors, (4), 1 states have call predecessors, (4), 2 states have return successors, (4), 2 states have call predecessors, (4), 3 states have call successors, (4)
[2025-04-28 21:21:34,566 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:34,566 INFO  L93              Difference]: Finished difference Result 35 states and 52 transitions.
[2025-04-28 21:21:34,567 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 5 states. 
[2025-04-28 21:21:34,567 INFO  L79                 Accepts]: Start accepts. Automaton has  has 5 states, 3 states have (on average 2.0) internal successors, (6), 3 states have internal predecessors, (6), 3 states have call successors, (4), 1 states have call predecessors, (4), 2 states have return successors, (4), 2 states have call predecessors, (4), 3 states have call successors, (4) Word has length 16
[2025-04-28 21:21:34,567 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:34,568 INFO  L225             Difference]: With dead ends: 35
[2025-04-28 21:21:34,568 INFO  L226             Difference]: Without dead ends: 35
[2025-04-28 21:21:34,569 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 22 GetRequests, 14 SyntacticMatches, 0 SemanticMatches, 8 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 2 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=20, Invalid=70, Unknown=0, NotChecked=0, Total=90
[2025-04-28 21:21:34,570 INFO  L437           NwaCegarLoop]: 40 mSDtfsCounter, 3 mSDsluCounter, 107 mSDsCounter, 0 mSdLazyCounter, 22 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 147 SdHoareTripleChecker+Invalid, 24 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 22 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:34,570 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 147 Invalid, 24 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 22 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-04-28 21:21:34,571 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 35 states.
[2025-04-28 21:21:34,582 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 35 to 33.
[2025-04-28 21:21:34,585 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 33 states, 11 states have (on average 1.4545454545454546) internal successors, (16), 16 states have internal predecessors, (16), 15 states have call successors, (15), 5 states have call predecessors, (15), 6 states have return successors, (19), 13 states have call predecessors, (19), 15 states have call successors, (19)
[2025-04-28 21:21:34,588 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 33 states to 33 states and 50 transitions.
[2025-04-28 21:21:34,588 INFO  L79                 Accepts]: Start accepts. Automaton has 33 states and 50 transitions. Word has length 16
[2025-04-28 21:21:34,589 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:34,589 INFO  L485      AbstractCegarLoop]: Abstraction has 33 states and 50 transitions.
[2025-04-28 21:21:34,589 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 5 states, 3 states have (on average 2.0) internal successors, (6), 3 states have internal predecessors, (6), 3 states have call successors, (4), 1 states have call predecessors, (4), 2 states have return successors, (4), 2 states have call predecessors, (4), 3 states have call successors, (4)
[2025-04-28 21:21:34,589 INFO  L278                IsEmpty]: Start isEmpty. Operand 33 states and 50 transitions.
[2025-04-28 21:21:34,592 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 25
[2025-04-28 21:21:34,592 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:34,592 INFO  L218           NwaCegarLoop]: trace histogram [2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:34,597 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-04-28 21:21:34,794 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:34,794 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:34,795 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:34,795 INFO  L85        PathProgramCache]: Analyzing trace with hash 205889603, now seen corresponding path program 1 times
[2025-04-28 21:21:34,795 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:34,795 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [435232638]
[2025-04-28 21:21:34,795 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:34,795 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:34,802 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 24 statements into 1 equivalence classes.
[2025-04-28 21:21:34,810 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 24 of 24 statements.
[2025-04-28 21:21:34,811 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:34,811 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:35,031 INFO  L134       CoverageAnalysis]: Checked inductivity of 6 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 4 trivial. 0 not checked.
[2025-04-28 21:21:35,031 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:35,032 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [435232638]
[2025-04-28 21:21:35,032 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [435232638] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:35,032 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1746883300]
[2025-04-28 21:21:35,032 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:35,032 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:35,035 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:35,037 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:35,041 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-04-28 21:21:35,078 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 24 statements into 1 equivalence classes.
[2025-04-28 21:21:35,103 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 24 of 24 statements.
[2025-04-28 21:21:35,103 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:35,103 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:35,106 INFO  L256         TraceCheckSpWp]: Trace formula consists of 80 conjuncts, 13 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:35,108 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:35,245 INFO  L134       CoverageAnalysis]: Checked inductivity of 6 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 4 trivial. 0 not checked.
[2025-04-28 21:21:35,246 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:35,834 INFO  L134       CoverageAnalysis]: Checked inductivity of 6 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 4 trivial. 0 not checked.
[2025-04-28 21:21:35,834 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1746883300] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:35,834 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:35,835 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [6, 6, 6] total 11
[2025-04-28 21:21:35,835 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1738247148]
[2025-04-28 21:21:35,836 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:35,837 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 11 states
[2025-04-28 21:21:35,839 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:35,841 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 11 interpolants.
[2025-04-28 21:21:35,841 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=24, Invalid=86, Unknown=0, NotChecked=0, Total=110
[2025-04-28 21:21:35,841 INFO  L87              Difference]: Start difference. First operand 33 states and 50 transitions. Second operand  has 11 states, 7 states have (on average 2.4285714285714284) internal successors, (17), 9 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 7 states have return successors, (12), 5 states have call predecessors, (12), 7 states have call successors, (12)
[2025-04-28 21:21:36,059 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:36,060 INFO  L93              Difference]: Finished difference Result 37 states and 56 transitions.
[2025-04-28 21:21:36,060 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-04-28 21:21:36,060 INFO  L79                 Accepts]: Start accepts. Automaton has  has 11 states, 7 states have (on average 2.4285714285714284) internal successors, (17), 9 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 7 states have return successors, (12), 5 states have call predecessors, (12), 7 states have call successors, (12) Word has length 24
[2025-04-28 21:21:36,061 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:36,062 INFO  L225             Difference]: With dead ends: 37
[2025-04-28 21:21:36,062 INFO  L226             Difference]: Without dead ends: 37
[2025-04-28 21:21:36,065 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 55 GetRequests, 44 SyntacticMatches, 0 SemanticMatches, 11 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 14 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=35, Invalid=121, Unknown=0, NotChecked=0, Total=156
[2025-04-28 21:21:36,065 INFO  L437           NwaCegarLoop]: 41 mSDtfsCounter, 4 mSDsluCounter, 238 mSDsCounter, 0 mSdLazyCounter, 81 mSolverCounterSat, 7 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 9 SdHoareTripleChecker+Valid, 279 SdHoareTripleChecker+Invalid, 88 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 7 IncrementalHoareTripleChecker+Valid, 81 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:36,066 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [9 Valid, 279 Invalid, 88 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [7 Valid, 81 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:36,066 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 37 states.
[2025-04-28 21:21:36,074 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 37 to 35.
[2025-04-28 21:21:36,077 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 35 states, 12 states have (on average 1.4166666666666667) internal successors, (17), 17 states have internal predecessors, (17), 15 states have call successors, (15), 5 states have call predecessors, (15), 7 states have return successors, (22), 14 states have call predecessors, (22), 15 states have call successors, (22)
[2025-04-28 21:21:36,079 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 35 states to 35 states and 54 transitions.
[2025-04-28 21:21:36,080 INFO  L79                 Accepts]: Start accepts. Automaton has 35 states and 54 transitions. Word has length 24
[2025-04-28 21:21:36,080 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:36,080 INFO  L485      AbstractCegarLoop]: Abstraction has 35 states and 54 transitions.
[2025-04-28 21:21:36,080 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 11 states, 7 states have (on average 2.4285714285714284) internal successors, (17), 9 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 7 states have return successors, (12), 5 states have call predecessors, (12), 7 states have call successors, (12)
[2025-04-28 21:21:36,080 INFO  L278                IsEmpty]: Start isEmpty. Operand 35 states and 54 transitions.
[2025-04-28 21:21:36,082 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 25
[2025-04-28 21:21:36,084 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:36,085 INFO  L218           NwaCegarLoop]: trace histogram [4, 3, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:36,089 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Ended with exit code 0
[2025-04-28 21:21:36,285 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,285 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:36,286 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:36,286 INFO  L85        PathProgramCache]: Analyzing trace with hash 163804021, now seen corresponding path program 1 times
[2025-04-28 21:21:36,286 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:36,286 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1931330314]
[2025-04-28 21:21:36,286 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:36,286 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:36,292 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 24 statements into 1 equivalence classes.
[2025-04-28 21:21:36,315 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 24 of 24 statements.
[2025-04-28 21:21:36,315 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:36,315 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:36,703 INFO  L134       CoverageAnalysis]: Checked inductivity of 18 backedges. 0 proven. 12 refuted. 0 times theorem prover too weak. 6 trivial. 0 not checked.
[2025-04-28 21:21:36,703 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:36,704 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1931330314]
[2025-04-28 21:21:36,704 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1931330314] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:36,704 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1281186671]
[2025-04-28 21:21:36,704 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:36,704 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:36,707 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:36,709 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:36,711 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-04-28 21:21:36,748 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 24 statements into 1 equivalence classes.
[2025-04-28 21:21:36,765 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 24 of 24 statements.
[2025-04-28 21:21:36,765 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:36,766 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:36,770 WARN  L254         TraceCheckSpWp]: Trace formula consists of 94 conjuncts, 55 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:36,773 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:36,998 INFO  L134       CoverageAnalysis]: Checked inductivity of 18 backedges. 0 proven. 6 refuted. 0 times theorem prover too weak. 12 trivial. 0 not checked.
[2025-04-28 21:21:36,998 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:38,349 INFO  L134       CoverageAnalysis]: Checked inductivity of 18 backedges. 0 proven. 6 refuted. 0 times theorem prover too weak. 12 trivial. 0 not checked.
[2025-04-28 21:21:38,350 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1281186671] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:38,350 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:38,351 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [10, 8, 8] total 18
[2025-04-28 21:21:38,351 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [300327665]
[2025-04-28 21:21:38,351 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:38,351 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 18 states
[2025-04-28 21:21:38,351 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:38,352 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 18 interpolants.
[2025-04-28 21:21:38,353 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=45, Invalid=261, Unknown=0, NotChecked=0, Total=306
[2025-04-28 21:21:38,353 INFO  L87              Difference]: Start difference. First operand 35 states and 54 transitions. Second operand  has 18 states, 8 states have (on average 2.25) internal successors, (18), 12 states have internal predecessors, (18), 11 states have call successors, (12), 1 states have call predecessors, (12), 7 states have return successors, (14), 8 states have call predecessors, (14), 11 states have call successors, (14)
[2025-04-28 21:21:39,364 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:39,365 INFO  L93              Difference]: Finished difference Result 60 states and 139 transitions.
[2025-04-28 21:21:39,365 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 16 states. 
[2025-04-28 21:21:39,365 INFO  L79                 Accepts]: Start accepts. Automaton has  has 18 states, 8 states have (on average 2.25) internal successors, (18), 12 states have internal predecessors, (18), 11 states have call successors, (12), 1 states have call predecessors, (12), 7 states have return successors, (14), 8 states have call predecessors, (14), 11 states have call successors, (14) Word has length 24
[2025-04-28 21:21:39,365 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:39,367 INFO  L225             Difference]: With dead ends: 60
[2025-04-28 21:21:39,369 INFO  L226             Difference]: Without dead ends: 60
[2025-04-28 21:21:39,369 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 69 GetRequests, 41 SyntacticMatches, 0 SemanticMatches, 28 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 104 ImplicationChecksByTransitivity, 0.8s TimeCoverageRelationStatistics Valid=165, Invalid=705, Unknown=0, NotChecked=0, Total=870
[2025-04-28 21:21:39,371 INFO  L437           NwaCegarLoop]: 41 mSDtfsCounter, 17 mSDsluCounter, 345 mSDsCounter, 0 mSdLazyCounter, 290 mSolverCounterSat, 44 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 29 SdHoareTripleChecker+Valid, 386 SdHoareTripleChecker+Invalid, 334 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 44 IncrementalHoareTripleChecker+Valid, 290 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:39,373 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [29 Valid, 386 Invalid, 334 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [44 Valid, 290 Invalid, 0 Unknown, 0 Unchecked, 0.5s Time]
[2025-04-28 21:21:39,374 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 60 states.
[2025-04-28 21:21:39,403 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 60 to 41.
[2025-04-28 21:21:39,406 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 41 states, 14 states have (on average 1.3571428571428572) internal successors, (19), 19 states have internal predecessors, (19), 17 states have call successors, (17), 5 states have call predecessors, (17), 9 states have return successors, (40), 18 states have call predecessors, (40), 17 states have call successors, (40)
[2025-04-28 21:21:39,408 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 41 states to 41 states and 76 transitions.
[2025-04-28 21:21:39,408 INFO  L79                 Accepts]: Start accepts. Automaton has 41 states and 76 transitions. Word has length 24
[2025-04-28 21:21:39,408 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:39,408 INFO  L485      AbstractCegarLoop]: Abstraction has 41 states and 76 transitions.
[2025-04-28 21:21:39,408 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 18 states, 8 states have (on average 2.25) internal successors, (18), 12 states have internal predecessors, (18), 11 states have call successors, (12), 1 states have call predecessors, (12), 7 states have return successors, (14), 8 states have call predecessors, (14), 11 states have call successors, (14)
[2025-04-28 21:21:39,409 INFO  L278                IsEmpty]: Start isEmpty. Operand 41 states and 76 transitions.
[2025-04-28 21:21:39,411 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 33
[2025-04-28 21:21:39,411 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:39,411 INFO  L218           NwaCegarLoop]: trace histogram [4, 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]
[2025-04-28 21:21:39,417 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Ended with exit code 0
[2025-04-28 21:21:39,611 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:39,612 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:39,612 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:39,612 INFO  L85        PathProgramCache]: Analyzing trace with hash 320699785, now seen corresponding path program 1 times
[2025-04-28 21:21:39,612 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:39,613 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1692829504]
[2025-04-28 21:21:39,613 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:39,613 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:39,618 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 32 statements into 1 equivalence classes.
[2025-04-28 21:21:39,630 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 32 of 32 statements.
[2025-04-28 21:21:39,630 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:39,630 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:39,735 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 8 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:39,736 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:39,736 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1692829504]
[2025-04-28 21:21:39,736 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1692829504] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:39,736 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1194642323]
[2025-04-28 21:21:39,736 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:39,736 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:39,739 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:39,741 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:39,745 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Waiting until timeout for monitored process
[2025-04-28 21:21:39,786 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 32 statements into 1 equivalence classes.
[2025-04-28 21:21:39,807 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 32 of 32 statements.
[2025-04-28 21:21:39,808 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:39,808 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:39,811 INFO  L256         TraceCheckSpWp]: Trace formula consists of 116 conjuncts, 7 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:39,812 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:39,849 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 8 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:39,849 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:40,232 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 8 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:40,233 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1194642323] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:40,233 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:40,233 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [7, 7, 7] total 10
[2025-04-28 21:21:40,233 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2001671121]
[2025-04-28 21:21:40,233 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:40,233 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-04-28 21:21:40,234 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:40,235 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-04-28 21:21:40,235 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=22, Invalid=68, Unknown=0, NotChecked=0, Total=90
[2025-04-28 21:21:40,235 INFO  L87              Difference]: Start difference. First operand 41 states and 76 transitions. Second operand  has 10 states, 6 states have (on average 2.8333333333333335) internal successors, (17), 8 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 6 states have return successors, (11), 5 states have call predecessors, (11), 7 states have call successors, (11)
[2025-04-28 21:21:40,472 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:40,476 INFO  L93              Difference]: Finished difference Result 58 states and 147 transitions.
[2025-04-28 21:21:40,477 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-04-28 21:21:40,477 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 6 states have (on average 2.8333333333333335) internal successors, (17), 8 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 6 states have return successors, (11), 5 states have call predecessors, (11), 7 states have call successors, (11) Word has length 32
[2025-04-28 21:21:40,477 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:40,479 INFO  L225             Difference]: With dead ends: 58
[2025-04-28 21:21:40,479 INFO  L226             Difference]: Without dead ends: 58
[2025-04-28 21:21:40,480 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 78 GetRequests, 64 SyntacticMatches, 2 SemanticMatches, 12 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 11 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=53, Invalid=129, Unknown=0, NotChecked=0, Total=182
[2025-04-28 21:21:40,480 INFO  L437           NwaCegarLoop]: 43 mSDtfsCounter, 2 mSDsluCounter, 262 mSDsCounter, 0 mSdLazyCounter, 141 mSolverCounterSat, 13 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 305 SdHoareTripleChecker+Invalid, 154 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 13 IncrementalHoareTripleChecker+Valid, 141 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:40,481 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 305 Invalid, 154 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [13 Valid, 141 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:40,484 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 58 states.
[2025-04-28 21:21:40,522 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 58 to 56.
[2025-04-28 21:21:40,522 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 56 states, 20 states have (on average 1.25) internal successors, (25), 25 states have internal predecessors, (25), 20 states have call successors, (20), 5 states have call predecessors, (20), 15 states have return successors, (100), 27 states have call predecessors, (100), 20 states have call successors, (100)
[2025-04-28 21:21:40,524 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 56 states to 56 states and 145 transitions.
[2025-04-28 21:21:40,524 INFO  L79                 Accepts]: Start accepts. Automaton has 56 states and 145 transitions. Word has length 32
[2025-04-28 21:21:40,524 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:40,525 INFO  L485      AbstractCegarLoop]: Abstraction has 56 states and 145 transitions.
[2025-04-28 21:21:40,525 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 6 states have (on average 2.8333333333333335) internal successors, (17), 8 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 6 states have return successors, (11), 5 states have call predecessors, (11), 7 states have call successors, (11)
[2025-04-28 21:21:40,525 INFO  L278                IsEmpty]: Start isEmpty. Operand 56 states and 145 transitions.
[2025-04-28 21:21:40,527 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 33
[2025-04-28 21:21:40,527 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:40,528 INFO  L218           NwaCegarLoop]: trace histogram [4, 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]
[2025-04-28 21:21:40,535 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Ended with exit code 0
[2025-04-28 21:21:40,730 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 5 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable5
[2025-04-28 21:21:40,731 INFO  L403      AbstractCegarLoop]: === Iteration 6 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:40,731 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:40,731 INFO  L85        PathProgramCache]: Analyzing trace with hash 731407495, now seen corresponding path program 1 times
[2025-04-28 21:21:40,731 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:40,731 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1938869300]
[2025-04-28 21:21:40,731 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:40,731 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:40,739 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 32 statements into 1 equivalence classes.
[2025-04-28 21:21:40,747 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 32 of 32 statements.
[2025-04-28 21:21:40,750 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:40,750 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:40,835 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 8 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:40,835 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:40,835 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1938869300]
[2025-04-28 21:21:40,835 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1938869300] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:40,835 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [966446552]
[2025-04-28 21:21:40,836 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:40,836 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:40,838 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:40,840 INFO  L229       MonitoredProcess]: Starting monitored process 6 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:40,844 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (6)] Waiting until timeout for monitored process
[2025-04-28 21:21:40,880 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 32 statements into 1 equivalence classes.
[2025-04-28 21:21:40,898 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 32 of 32 statements.
[2025-04-28 21:21:40,899 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:40,899 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:40,900 INFO  L256         TraceCheckSpWp]: Trace formula consists of 116 conjuncts, 7 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:40,901 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:40,940 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 8 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:40,940 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:41,304 INFO  L134       CoverageAnalysis]: Checked inductivity of 21 backedges. 4 proven. 8 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-04-28 21:21:41,304 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [966446552] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:41,305 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:41,305 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [7, 7, 7] total 10
[2025-04-28 21:21:41,305 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1325940905]
[2025-04-28 21:21:41,305 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:41,306 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-04-28 21:21:41,306 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:41,307 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-04-28 21:21:41,307 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=22, Invalid=68, Unknown=0, NotChecked=0, Total=90
[2025-04-28 21:21:41,308 INFO  L87              Difference]: Start difference. First operand 56 states and 145 transitions. Second operand  has 10 states, 6 states have (on average 2.8333333333333335) internal successors, (17), 8 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 6 states have return successors, (11), 5 states have call predecessors, (11), 7 states have call successors, (11)
[2025-04-28 21:21:41,502 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:41,502 INFO  L93              Difference]: Finished difference Result 79 states and 259 transitions.
[2025-04-28 21:21:41,502 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 9 states. 
[2025-04-28 21:21:41,503 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 6 states have (on average 2.8333333333333335) internal successors, (17), 8 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 6 states have return successors, (11), 5 states have call predecessors, (11), 7 states have call successors, (11) Word has length 32
[2025-04-28 21:21:41,503 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:41,506 INFO  L225             Difference]: With dead ends: 79
[2025-04-28 21:21:41,506 INFO  L226             Difference]: Without dead ends: 79
[2025-04-28 21:21:41,507 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 78 GetRequests, 63 SyntacticMatches, 3 SemanticMatches, 12 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 13 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=53, Invalid=129, Unknown=0, NotChecked=0, Total=182
[2025-04-28 21:21:41,507 INFO  L437           NwaCegarLoop]: 44 mSDtfsCounter, 6 mSDsluCounter, 236 mSDsCounter, 0 mSdLazyCounter, 112 mSolverCounterSat, 17 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 12 SdHoareTripleChecker+Valid, 280 SdHoareTripleChecker+Invalid, 129 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 17 IncrementalHoareTripleChecker+Valid, 112 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:41,508 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [12 Valid, 280 Invalid, 129 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [17 Valid, 112 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-04-28 21:21:41,508 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 79 states.
[2025-04-28 21:21:41,560 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 79 to 77.
[2025-04-28 21:21:41,561 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 77 states, 29 states have (on average 1.1724137931034482) internal successors, (34), 34 states have internal predecessors, (34), 23 states have call successors, (23), 5 states have call predecessors, (23), 24 states have return successors, (200), 39 states have call predecessors, (200), 23 states have call successors, (200)
[2025-04-28 21:21:41,565 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 77 states to 77 states and 257 transitions.
[2025-04-28 21:21:41,566 INFO  L79                 Accepts]: Start accepts. Automaton has 77 states and 257 transitions. Word has length 32
[2025-04-28 21:21:41,566 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:41,566 INFO  L485      AbstractCegarLoop]: Abstraction has 77 states and 257 transitions.
[2025-04-28 21:21:41,566 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 6 states have (on average 2.8333333333333335) internal successors, (17), 8 states have internal predecessors, (17), 7 states have call successors, (10), 1 states have call predecessors, (10), 6 states have return successors, (11), 5 states have call predecessors, (11), 7 states have call successors, (11)
[2025-04-28 21:21:41,566 INFO  L278                IsEmpty]: Start isEmpty. Operand 77 states and 257 transitions.
[2025-04-28 21:21:41,572 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 41
[2025-04-28 21:21:41,572 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:41,573 INFO  L218           NwaCegarLoop]: trace histogram [4, 4, 4, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:41,577 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (6)] Forceful destruction successful, exit code 0
[2025-04-28 21:21:41,776 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable6,6 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:41,776 INFO  L403      AbstractCegarLoop]: === Iteration 7 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:41,777 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:41,777 INFO  L85        PathProgramCache]: Analyzing trace with hash -942881767, now seen corresponding path program 2 times
[2025-04-28 21:21:41,777 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:41,777 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [396195250]
[2025-04-28 21:21:41,777 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:21:41,777 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:41,783 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 40 statements into 2 equivalence classes.
[2025-04-28 21:21:41,789 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 40 of 40 statements.
[2025-04-28 21:21:41,789 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:21:41,789 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:41,842 INFO  L134       CoverageAnalysis]: Checked inductivity of 38 backedges. 0 proven. 8 refuted. 0 times theorem prover too weak. 30 trivial. 0 not checked.
[2025-04-28 21:21:41,842 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:41,843 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [396195250]
[2025-04-28 21:21:41,843 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [396195250] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:41,843 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [235440528]
[2025-04-28 21:21:41,843 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:21:41,843 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:41,846 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:41,848 INFO  L229       MonitoredProcess]: Starting monitored process 7 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:41,851 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (7)] Waiting until timeout for monitored process
[2025-04-28 21:21:41,894 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 40 statements into 2 equivalence classes.
[2025-04-28 21:21:41,918 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 40 of 40 statements.
[2025-04-28 21:21:41,919 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:21:41,919 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:41,920 INFO  L256         TraceCheckSpWp]: Trace formula consists of 138 conjuncts, 7 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:41,921 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:41,955 INFO  L134       CoverageAnalysis]: Checked inductivity of 38 backedges. 23 proven. 0 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-04-28 21:21:41,955 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-04-28 21:21:41,955 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [235440528] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:41,956 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-04-28 21:21:41,956 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [4] total 5
[2025-04-28 21:21:41,956 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2032913003]
[2025-04-28 21:21:41,956 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:41,956 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-04-28 21:21:41,956 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:41,957 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-04-28 21:21:41,957 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=8, Invalid=12, Unknown=0, NotChecked=0, Total=20
[2025-04-28 21:21:41,957 INFO  L87              Difference]: Start difference. First operand 77 states and 257 transitions. Second operand  has 4 states, 3 states have (on average 4.666666666666667) internal successors, (14), 4 states have internal predecessors, (14), 4 states have call successors, (10), 2 states have call predecessors, (10), 3 states have return successors, (10), 2 states have call predecessors, (10), 4 states have call successors, (10)
[2025-04-28 21:21:41,996 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:41,996 INFO  L93              Difference]: Finished difference Result 77 states and 256 transitions.
[2025-04-28 21:21:41,997 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-04-28 21:21:41,997 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 4.666666666666667) internal successors, (14), 4 states have internal predecessors, (14), 4 states have call successors, (10), 2 states have call predecessors, (10), 3 states have return successors, (10), 2 states have call predecessors, (10), 4 states have call successors, (10) Word has length 40
[2025-04-28 21:21:41,997 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:41,999 INFO  L225             Difference]: With dead ends: 77
[2025-04-28 21:21:41,999 INFO  L226             Difference]: Without dead ends: 77
[2025-04-28 21:21:42,000 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 43 GetRequests, 40 SyntacticMatches, 0 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:42,000 INFO  L437           NwaCegarLoop]: 44 mSDtfsCounter, 1 mSDsluCounter, 73 mSDsCounter, 0 mSdLazyCounter, 15 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 117 SdHoareTripleChecker+Invalid, 15 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 15 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:42,000 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 117 Invalid, 15 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 15 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-04-28 21:21:42,001 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 77 states.
[2025-04-28 21:21:42,029 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 77 to 77.
[2025-04-28 21:21:42,030 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 77 states, 29 states have (on average 1.1724137931034482) internal successors, (34), 34 states have internal predecessors, (34), 23 states have call successors, (23), 5 states have call predecessors, (23), 24 states have return successors, (199), 39 states have call predecessors, (199), 23 states have call successors, (199)
[2025-04-28 21:21:42,032 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 77 states to 77 states and 256 transitions.
[2025-04-28 21:21:42,033 INFO  L79                 Accepts]: Start accepts. Automaton has 77 states and 256 transitions. Word has length 40
[2025-04-28 21:21:42,033 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:42,033 INFO  L485      AbstractCegarLoop]: Abstraction has 77 states and 256 transitions.
[2025-04-28 21:21:42,033 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 4.666666666666667) internal successors, (14), 4 states have internal predecessors, (14), 4 states have call successors, (10), 2 states have call predecessors, (10), 3 states have return successors, (10), 2 states have call predecessors, (10), 4 states have call successors, (10)
[2025-04-28 21:21:42,033 INFO  L278                IsEmpty]: Start isEmpty. Operand 77 states and 256 transitions.
[2025-04-28 21:21:42,037 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 73
[2025-04-28 21:21:42,037 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:42,037 INFO  L218           NwaCegarLoop]: trace histogram [10, 6, 6, 4, 4, 4, 4, 4, 3, 3, 3, 3, 3, 3, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:42,043 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (7)] Ended with exit code 0
[2025-04-28 21:21:42,237 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable7,7 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:42,238 INFO  L403      AbstractCegarLoop]: === Iteration 8 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:42,238 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:42,238 INFO  L85        PathProgramCache]: Analyzing trace with hash 949421059, now seen corresponding path program 2 times
[2025-04-28 21:21:42,238 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:42,238 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1985761182]
[2025-04-28 21:21:42,238 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:21:42,239 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:42,245 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 72 statements into 2 equivalence classes.
[2025-04-28 21:21:42,260 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 72 of 72 statements.
[2025-04-28 21:21:42,260 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:21:42,260 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:42,472 INFO  L134       CoverageAnalysis]: Checked inductivity of 198 backedges. 0 proven. 56 refuted. 0 times theorem prover too weak. 142 trivial. 0 not checked.
[2025-04-28 21:21:42,472 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:42,472 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1985761182]
[2025-04-28 21:21:42,472 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1985761182] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:42,472 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [132651599]
[2025-04-28 21:21:42,472 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:21:42,473 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:42,475 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:42,477 INFO  L229       MonitoredProcess]: Starting monitored process 8 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:42,481 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (8)] Waiting until timeout for monitored process
[2025-04-28 21:21:42,524 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 72 statements into 2 equivalence classes.
[2025-04-28 21:21:42,559 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 72 of 72 statements.
[2025-04-28 21:21:42,559 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:21:42,559 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:42,561 INFO  L256         TraceCheckSpWp]: Trace formula consists of 268 conjuncts, 17 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:42,566 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:42,713 INFO  L134       CoverageAnalysis]: Checked inductivity of 198 backedges. 97 proven. 6 refuted. 0 times theorem prover too weak. 95 trivial. 0 not checked.
[2025-04-28 21:21:42,717 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:43,942 INFO  L134       CoverageAnalysis]: Checked inductivity of 198 backedges. 0 proven. 58 refuted. 0 times theorem prover too weak. 140 trivial. 0 not checked.
[2025-04-28 21:21:43,942 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [132651599] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:43,942 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:43,942 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [7, 8, 8] total 16
[2025-04-28 21:21:43,943 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [682866932]
[2025-04-28 21:21:43,943 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:43,943 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 16 states
[2025-04-28 21:21:43,943 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:43,944 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 16 interpolants.
[2025-04-28 21:21:43,944 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=40, Invalid=200, Unknown=0, NotChecked=0, Total=240
[2025-04-28 21:21:43,945 INFO  L87              Difference]: Start difference. First operand 77 states and 256 transitions. Second operand  has 16 states, 8 states have (on average 3.875) internal successors, (31), 13 states have internal predecessors, (31), 12 states have call successors, (24), 2 states have call predecessors, (24), 8 states have return successors, (25), 8 states have call predecessors, (25), 12 states have call successors, (25)
[2025-04-28 21:21:44,681 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:44,682 INFO  L93              Difference]: Finished difference Result 110 states and 460 transitions.
[2025-04-28 21:21:44,682 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 16 states. 
[2025-04-28 21:21:44,683 INFO  L79                 Accepts]: Start accepts. Automaton has  has 16 states, 8 states have (on average 3.875) internal successors, (31), 13 states have internal predecessors, (31), 12 states have call successors, (24), 2 states have call predecessors, (24), 8 states have return successors, (25), 8 states have call predecessors, (25), 12 states have call successors, (25) Word has length 72
[2025-04-28 21:21:44,683 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:44,686 INFO  L225             Difference]: With dead ends: 110
[2025-04-28 21:21:44,686 INFO  L226             Difference]: Without dead ends: 110
[2025-04-28 21:21:44,687 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 162 GetRequests, 137 SyntacticMatches, 0 SemanticMatches, 25 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 104 ImplicationChecksByTransitivity, 0.4s TimeCoverageRelationStatistics Valid=145, Invalid=557, Unknown=0, NotChecked=0, Total=702
[2025-04-28 21:21:44,687 INFO  L437           NwaCegarLoop]: 46 mSDtfsCounter, 14 mSDsluCounter, 406 mSDsCounter, 0 mSdLazyCounter, 415 mSolverCounterSat, 66 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 29 SdHoareTripleChecker+Valid, 452 SdHoareTripleChecker+Invalid, 481 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 66 IncrementalHoareTripleChecker+Valid, 415 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:44,688 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [29 Valid, 452 Invalid, 481 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [66 Valid, 415 Invalid, 0 Unknown, 0 Unchecked, 0.5s Time]
[2025-04-28 21:21:44,688 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 110 states.
[2025-04-28 21:21:44,719 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 110 to 94.
[2025-04-28 21:21:44,719 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 94 states, 37 states have (on average 1.135135135135135) internal successors, (42), 42 states have internal predecessors, (42), 24 states have call successors, (24), 5 states have call predecessors, (24), 32 states have return successors, (315), 48 states have call predecessors, (315), 24 states have call successors, (315)
[2025-04-28 21:21:44,722 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 94 states to 94 states and 381 transitions.
[2025-04-28 21:21:44,722 INFO  L79                 Accepts]: Start accepts. Automaton has 94 states and 381 transitions. Word has length 72
[2025-04-28 21:21:44,723 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:44,723 INFO  L485      AbstractCegarLoop]: Abstraction has 94 states and 381 transitions.
[2025-04-28 21:21:44,723 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 16 states, 8 states have (on average 3.875) internal successors, (31), 13 states have internal predecessors, (31), 12 states have call successors, (24), 2 states have call predecessors, (24), 8 states have return successors, (25), 8 states have call predecessors, (25), 12 states have call successors, (25)
[2025-04-28 21:21:44,723 INFO  L278                IsEmpty]: Start isEmpty. Operand 94 states and 381 transitions.
[2025-04-28 21:21:44,727 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 57
[2025-04-28 21:21:44,727 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:44,728 INFO  L218           NwaCegarLoop]: trace histogram [8, 3, 3, 3, 3, 3, 3, 2, 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]
[2025-04-28 21:21:44,733 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (8)] Forceful destruction successful, exit code 0
[2025-04-28 21:21:44,931 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 8 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable8
[2025-04-28 21:21:44,932 INFO  L403      AbstractCegarLoop]: === Iteration 9 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:44,933 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:44,933 INFO  L85        PathProgramCache]: Analyzing trace with hash 1058450087, now seen corresponding path program 1 times
[2025-04-28 21:21:44,933 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:44,933 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [2098538554]
[2025-04-28 21:21:44,933 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:44,933 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:44,940 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 56 statements into 1 equivalence classes.
[2025-04-28 21:21:44,953 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 56 of 56 statements.
[2025-04-28 21:21:44,953 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:44,953 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:45,110 INFO  L134       CoverageAnalysis]: Checked inductivity of 96 backedges. 0 proven. 38 refuted. 0 times theorem prover too weak. 58 trivial. 0 not checked.
[2025-04-28 21:21:45,111 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:45,111 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [2098538554]
[2025-04-28 21:21:45,111 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [2098538554] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:45,111 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [194635546]
[2025-04-28 21:21:45,111 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:45,112 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:45,114 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:45,116 INFO  L229       MonitoredProcess]: Starting monitored process 9 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:45,120 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (9)] Waiting until timeout for monitored process
[2025-04-28 21:21:45,167 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 56 statements into 1 equivalence classes.
[2025-04-28 21:21:45,195 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 56 of 56 statements.
[2025-04-28 21:21:45,195 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:45,195 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:45,199 INFO  L256         TraceCheckSpWp]: Trace formula consists of 210 conjuncts, 17 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:45,203 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:45,335 INFO  L134       CoverageAnalysis]: Checked inductivity of 96 backedges. 49 proven. 6 refuted. 0 times theorem prover too weak. 41 trivial. 0 not checked.
[2025-04-28 21:21:45,339 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:46,508 INFO  L134       CoverageAnalysis]: Checked inductivity of 96 backedges. 0 proven. 40 refuted. 0 times theorem prover too weak. 56 trivial. 0 not checked.
[2025-04-28 21:21:46,509 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [194635546] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:46,509 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:46,509 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [7, 8, 8] total 16
[2025-04-28 21:21:46,509 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2036677513]
[2025-04-28 21:21:46,509 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:46,509 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 16 states
[2025-04-28 21:21:46,510 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:46,510 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 16 interpolants.
[2025-04-28 21:21:46,510 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=40, Invalid=200, Unknown=0, NotChecked=0, Total=240
[2025-04-28 21:21:46,511 INFO  L87              Difference]: Start difference. First operand 94 states and 381 transitions. Second operand  has 16 states, 8 states have (on average 4.125) internal successors, (33), 13 states have internal predecessors, (33), 12 states have call successors, (24), 2 states have call predecessors, (24), 8 states have return successors, (25), 8 states have call predecessors, (25), 12 states have call successors, (25)
[2025-04-28 21:21:47,263 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:47,264 INFO  L93              Difference]: Finished difference Result 107 states and 397 transitions.
[2025-04-28 21:21:47,264 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 16 states. 
[2025-04-28 21:21:47,265 INFO  L79                 Accepts]: Start accepts. Automaton has  has 16 states, 8 states have (on average 4.125) internal successors, (33), 13 states have internal predecessors, (33), 12 states have call successors, (24), 2 states have call predecessors, (24), 8 states have return successors, (25), 8 states have call predecessors, (25), 12 states have call successors, (25) Word has length 56
[2025-04-28 21:21:47,265 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:47,268 INFO  L225             Difference]: With dead ends: 107
[2025-04-28 21:21:47,268 INFO  L226             Difference]: Without dead ends: 107
[2025-04-28 21:21:47,269 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 131 GetRequests, 106 SyntacticMatches, 0 SemanticMatches, 25 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 105 ImplicationChecksByTransitivity, 0.4s TimeCoverageRelationStatistics Valid=144, Invalid=558, Unknown=0, NotChecked=0, Total=702
[2025-04-28 21:21:47,269 INFO  L437           NwaCegarLoop]: 45 mSDtfsCounter, 16 mSDsluCounter, 337 mSDsCounter, 0 mSdLazyCounter, 358 mSolverCounterSat, 67 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 28 SdHoareTripleChecker+Valid, 382 SdHoareTripleChecker+Invalid, 425 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 67 IncrementalHoareTripleChecker+Valid, 358 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:47,270 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [28 Valid, 382 Invalid, 425 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [67 Valid, 358 Invalid, 0 Unknown, 0 Unchecked, 0.5s Time]
[2025-04-28 21:21:47,270 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 107 states.
[2025-04-28 21:21:47,298 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 107 to 50.
[2025-04-28 21:21:47,299 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 50 states, 18 states have (on average 1.2777777777777777) internal successors, (23), 23 states have internal predecessors, (23), 18 states have call successors, (18), 5 states have call predecessors, (18), 13 states have return successors, (69), 23 states have call predecessors, (69), 18 states have call successors, (69)
[2025-04-28 21:21:47,300 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 50 states to 50 states and 110 transitions.
[2025-04-28 21:21:47,300 INFO  L79                 Accepts]: Start accepts. Automaton has 50 states and 110 transitions. Word has length 56
[2025-04-28 21:21:47,300 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:47,300 INFO  L485      AbstractCegarLoop]: Abstraction has 50 states and 110 transitions.
[2025-04-28 21:21:47,301 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 16 states, 8 states have (on average 4.125) internal successors, (33), 13 states have internal predecessors, (33), 12 states have call successors, (24), 2 states have call predecessors, (24), 8 states have return successors, (25), 8 states have call predecessors, (25), 12 states have call successors, (25)
[2025-04-28 21:21:47,301 INFO  L278                IsEmpty]: Start isEmpty. Operand 50 states and 110 transitions.
[2025-04-28 21:21:47,302 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 41
[2025-04-28 21:21:47,302 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:47,302 INFO  L218           NwaCegarLoop]: trace histogram [6, 3, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:47,307 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (9)] Ended with exit code 0
[2025-04-28 21:21:47,506 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 9 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable9
[2025-04-28 21:21:47,506 INFO  L403      AbstractCegarLoop]: === Iteration 10 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:47,507 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:47,507 INFO  L85        PathProgramCache]: Analyzing trace with hash -462233009, now seen corresponding path program 3 times
[2025-04-28 21:21:47,507 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:47,507 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [290326332]
[2025-04-28 21:21:47,507 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:21:47,507 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:47,512 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 40 statements into 5 equivalence classes.
[2025-04-28 21:21:47,519 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s) and asserted 38 of 40 statements.
[2025-04-28 21:21:47,519 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s)
[2025-04-28 21:21:47,519 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:47,676 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 25 proven. 4 refuted. 0 times theorem prover too weak. 21 trivial. 0 not checked.
[2025-04-28 21:21:47,676 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:47,676 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [290326332]
[2025-04-28 21:21:47,676 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [290326332] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:47,676 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [640880042]
[2025-04-28 21:21:47,676 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:21:47,676 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:47,679 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:47,681 INFO  L229       MonitoredProcess]: Starting monitored process 10 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:47,684 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (10)] Waiting until timeout for monitored process
[2025-04-28 21:21:47,737 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 40 statements into 5 equivalence classes.
[2025-04-28 21:21:47,759 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s) and asserted 38 of 40 statements.
[2025-04-28 21:21:47,760 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s)
[2025-04-28 21:21:47,760 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:47,761 INFO  L256         TraceCheckSpWp]: Trace formula consists of 136 conjuncts, 11 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:47,762 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:47,820 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 25 proven. 2 refuted. 0 times theorem prover too weak. 23 trivial. 0 not checked.
[2025-04-28 21:21:47,820 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:48,711 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 27 proven. 2 refuted. 0 times theorem prover too weak. 21 trivial. 0 not checked.
[2025-04-28 21:21:48,711 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [640880042] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:48,711 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:48,711 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [9, 8, 9] total 15
[2025-04-28 21:21:48,711 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [508102060]
[2025-04-28 21:21:48,711 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:48,712 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 15 states
[2025-04-28 21:21:48,712 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:48,712 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 15 interpolants.
[2025-04-28 21:21:48,712 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=42, Invalid=168, Unknown=0, NotChecked=0, Total=210
[2025-04-28 21:21:48,713 INFO  L87              Difference]: Start difference. First operand 50 states and 110 transitions. Second operand  has 15 states, 8 states have (on average 2.5) internal successors, (20), 10 states have internal predecessors, (20), 8 states have call successors, (13), 1 states have call predecessors, (13), 8 states have return successors, (16), 9 states have call predecessors, (16), 8 states have call successors, (16)
[2025-04-28 21:21:49,011 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:49,011 INFO  L93              Difference]: Finished difference Result 70 states and 188 transitions.
[2025-04-28 21:21:49,012 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 11 states. 
[2025-04-28 21:21:49,012 INFO  L79                 Accepts]: Start accepts. Automaton has  has 15 states, 8 states have (on average 2.5) internal successors, (20), 10 states have internal predecessors, (20), 8 states have call successors, (13), 1 states have call predecessors, (13), 8 states have return successors, (16), 9 states have call predecessors, (16), 8 states have call successors, (16) Word has length 40
[2025-04-28 21:21:49,012 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:49,014 INFO  L225             Difference]: With dead ends: 70
[2025-04-28 21:21:49,015 INFO  L226             Difference]: Without dead ends: 70
[2025-04-28 21:21:49,016 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 98 GetRequests, 77 SyntacticMatches, 3 SemanticMatches, 18 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 42 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=81, Invalid=299, Unknown=0, NotChecked=0, Total=380
[2025-04-28 21:21:49,016 INFO  L437           NwaCegarLoop]: 47 mSDtfsCounter, 7 mSDsluCounter, 320 mSDsCounter, 0 mSdLazyCounter, 234 mSolverCounterSat, 14 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 17 SdHoareTripleChecker+Valid, 367 SdHoareTripleChecker+Invalid, 248 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 14 IncrementalHoareTripleChecker+Valid, 234 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:49,017 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [17 Valid, 367 Invalid, 248 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [14 Valid, 234 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:49,017 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 70 states.
[2025-04-28 21:21:49,029 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 70 to 62.
[2025-04-28 21:21:49,030 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 62 states, 23 states have (on average 1.2173913043478262) internal successors, (28), 28 states have internal predecessors, (28), 20 states have call successors, (20), 5 states have call predecessors, (20), 18 states have return successors, (110), 29 states have call predecessors, (110), 20 states have call successors, (110)
[2025-04-28 21:21:49,031 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 62 states to 62 states and 158 transitions.
[2025-04-28 21:21:49,031 INFO  L79                 Accepts]: Start accepts. Automaton has 62 states and 158 transitions. Word has length 40
[2025-04-28 21:21:49,032 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:49,032 INFO  L485      AbstractCegarLoop]: Abstraction has 62 states and 158 transitions.
[2025-04-28 21:21:49,032 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 15 states, 8 states have (on average 2.5) internal successors, (20), 10 states have internal predecessors, (20), 8 states have call successors, (13), 1 states have call predecessors, (13), 8 states have return successors, (16), 9 states have call predecessors, (16), 8 states have call successors, (16)
[2025-04-28 21:21:49,032 INFO  L278                IsEmpty]: Start isEmpty. Operand 62 states and 158 transitions.
[2025-04-28 21:21:49,033 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 41
[2025-04-28 21:21:49,034 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:49,034 INFO  L218           NwaCegarLoop]: trace histogram [6, 3, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:49,039 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (10)] Ended with exit code 0
[2025-04-28 21:21:49,234 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 10 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable10
[2025-04-28 21:21:49,234 INFO  L403      AbstractCegarLoop]: === Iteration 11 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:49,235 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:49,235 INFO  L85        PathProgramCache]: Analyzing trace with hash -909114931, now seen corresponding path program 3 times
[2025-04-28 21:21:49,235 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:49,235 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [612435263]
[2025-04-28 21:21:49,235 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:21:49,235 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:49,240 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 40 statements into 5 equivalence classes.
[2025-04-28 21:21:49,247 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s) and asserted 38 of 40 statements.
[2025-04-28 21:21:49,248 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s)
[2025-04-28 21:21:49,248 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:49,348 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 25 proven. 2 refuted. 0 times theorem prover too weak. 23 trivial. 0 not checked.
[2025-04-28 21:21:49,348 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:49,349 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [612435263]
[2025-04-28 21:21:49,349 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [612435263] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:49,349 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1237305818]
[2025-04-28 21:21:49,349 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:21:49,349 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:49,352 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:49,354 INFO  L229       MonitoredProcess]: Starting monitored process 11 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:49,357 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (11)] Waiting until timeout for monitored process
[2025-04-28 21:21:49,415 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 40 statements into 5 equivalence classes.
[2025-04-28 21:21:49,438 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s) and asserted 38 of 40 statements.
[2025-04-28 21:21:49,438 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 4 check-sat command(s)
[2025-04-28 21:21:49,439 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:49,440 INFO  L256         TraceCheckSpWp]: Trace formula consists of 136 conjuncts, 11 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:49,441 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:49,474 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 25 proven. 2 refuted. 0 times theorem prover too weak. 23 trivial. 0 not checked.
[2025-04-28 21:21:49,474 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:50,378 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 27 proven. 2 refuted. 0 times theorem prover too weak. 21 trivial. 0 not checked.
[2025-04-28 21:21:50,378 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1237305818] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:50,378 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:50,379 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [8, 8, 9] total 14
[2025-04-28 21:21:50,379 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [601574773]
[2025-04-28 21:21:50,379 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:50,379 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 14 states
[2025-04-28 21:21:50,380 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:50,380 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 14 interpolants.
[2025-04-28 21:21:50,380 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=36, Invalid=146, Unknown=0, NotChecked=0, Total=182
[2025-04-28 21:21:50,381 INFO  L87              Difference]: Start difference. First operand 62 states and 158 transitions. Second operand  has 14 states, 8 states have (on average 2.5) internal successors, (20), 10 states have internal predecessors, (20), 7 states have call successors, (12), 1 states have call predecessors, (12), 8 states have return successors, (14), 8 states have call predecessors, (14), 7 states have call successors, (14)
[2025-04-28 21:21:50,637 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:50,637 INFO  L93              Difference]: Finished difference Result 86 states and 262 transitions.
[2025-04-28 21:21:50,638 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 11 states. 
[2025-04-28 21:21:50,638 INFO  L79                 Accepts]: Start accepts. Automaton has  has 14 states, 8 states have (on average 2.5) internal successors, (20), 10 states have internal predecessors, (20), 7 states have call successors, (12), 1 states have call predecessors, (12), 8 states have return successors, (14), 8 states have call predecessors, (14), 7 states have call successors, (14) Word has length 40
[2025-04-28 21:21:50,638 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:50,640 INFO  L225             Difference]: With dead ends: 86
[2025-04-28 21:21:50,640 INFO  L226             Difference]: Without dead ends: 86
[2025-04-28 21:21:50,641 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 100 GetRequests, 81 SyntacticMatches, 1 SemanticMatches, 18 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 26 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=81, Invalid=299, Unknown=0, NotChecked=0, Total=380
[2025-04-28 21:21:50,643 INFO  L437           NwaCegarLoop]: 47 mSDtfsCounter, 7 mSDsluCounter, 279 mSDsCounter, 0 mSdLazyCounter, 146 mSolverCounterSat, 26 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 16 SdHoareTripleChecker+Valid, 326 SdHoareTripleChecker+Invalid, 172 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 26 IncrementalHoareTripleChecker+Valid, 146 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:50,643 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [16 Valid, 326 Invalid, 172 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [26 Valid, 146 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:50,644 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 86 states.
[2025-04-28 21:21:50,660 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 86 to 78.
[2025-04-28 21:21:50,660 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 78 states, 30 states have (on average 1.1666666666666667) internal successors, (35), 35 states have internal predecessors, (35), 22 states have call successors, (22), 5 states have call predecessors, (22), 25 states have return successors, (173), 37 states have call predecessors, (173), 22 states have call successors, (173)
[2025-04-28 21:21:50,662 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 78 states to 78 states and 230 transitions.
[2025-04-28 21:21:50,662 INFO  L79                 Accepts]: Start accepts. Automaton has 78 states and 230 transitions. Word has length 40
[2025-04-28 21:21:50,662 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:50,662 INFO  L485      AbstractCegarLoop]: Abstraction has 78 states and 230 transitions.
[2025-04-28 21:21:50,663 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 14 states, 8 states have (on average 2.5) internal successors, (20), 10 states have internal predecessors, (20), 7 states have call successors, (12), 1 states have call predecessors, (12), 8 states have return successors, (14), 8 states have call predecessors, (14), 7 states have call successors, (14)
[2025-04-28 21:21:50,663 INFO  L278                IsEmpty]: Start isEmpty. Operand 78 states and 230 transitions.
[2025-04-28 21:21:50,665 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 65
[2025-04-28 21:21:50,665 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:50,665 INFO  L218           NwaCegarLoop]: trace histogram [12, 6, 5, 5, 5, 5, 5, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:50,671 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (11)] Ended with exit code 0
[2025-04-28 21:21:50,866 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable11,11 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:50,866 INFO  L403      AbstractCegarLoop]: === Iteration 12 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:50,867 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:50,867 INFO  L85        PathProgramCache]: Analyzing trace with hash -323159903, now seen corresponding path program 4 times
[2025-04-28 21:21:50,867 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:50,867 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [238838744]
[2025-04-28 21:21:50,867 INFO  L95    rtionOrderModulation]: Changing assertion order to TERMS_WITH_SMALL_CONSTANTS_FIRST
[2025-04-28 21:21:50,867 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:50,875 INFO  L108    AnnotateAndAsserter]: Assert order TERMS_WITH_SMALL_CONSTANTS_FIRST partitioned 64 statements into 2 equivalence classes.
[2025-04-28 21:21:50,888 INFO  L111    AnnotateAndAsserter]: Assert order TERMS_WITH_SMALL_CONSTANTS_FIRST issued 2 check-sat command(s) and asserted 64 of 64 statements.
[2025-04-28 21:21:50,888 INFO  L114    AnnotateAndAsserter]: Assert order TERMS_WITH_SMALL_CONSTANTS_FIRST issued 2 check-sat command(s)
[2025-04-28 21:21:50,888 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:51,009 INFO  L134       CoverageAnalysis]: Checked inductivity of 221 backedges. 45 proven. 42 refuted. 0 times theorem prover too weak. 134 trivial. 0 not checked.
[2025-04-28 21:21:51,009 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:51,010 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [238838744]
[2025-04-28 21:21:51,010 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [238838744] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:51,010 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [448716803]
[2025-04-28 21:21:51,010 INFO  L95    rtionOrderModulation]: Changing assertion order to TERMS_WITH_SMALL_CONSTANTS_FIRST
[2025-04-28 21:21:51,010 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:51,012 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:51,015 INFO  L229       MonitoredProcess]: Starting monitored process 12 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:51,018 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (12)] Waiting until timeout for monitored process
[2025-04-28 21:21:51,084 INFO  L108    AnnotateAndAsserter]: Assert order TERMS_WITH_SMALL_CONSTANTS_FIRST partitioned 64 statements into 2 equivalence classes.
[2025-04-28 21:21:51,120 INFO  L111    AnnotateAndAsserter]: Assert order TERMS_WITH_SMALL_CONSTANTS_FIRST issued 2 check-sat command(s) and asserted 64 of 64 statements.
[2025-04-28 21:21:51,120 INFO  L114    AnnotateAndAsserter]: Assert order TERMS_WITH_SMALL_CONSTANTS_FIRST issued 2 check-sat command(s)
[2025-04-28 21:21:51,120 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:51,122 INFO  L256         TraceCheckSpWp]: Trace formula consists of 260 conjuncts, 12 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:51,135 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:51,226 INFO  L134       CoverageAnalysis]: Checked inductivity of 221 backedges. 34 proven. 69 refuted. 0 times theorem prover too weak. 118 trivial. 0 not checked.
[2025-04-28 21:21:51,226 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:52,031 INFO  L134       CoverageAnalysis]: Checked inductivity of 221 backedges. 38 proven. 66 refuted. 0 times theorem prover too weak. 117 trivial. 0 not checked.
[2025-04-28 21:21:52,031 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [448716803] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:52,031 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:52,031 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [7, 10, 11] total 18
[2025-04-28 21:21:52,031 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1567536347]
[2025-04-28 21:21:52,032 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:52,032 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 18 states
[2025-04-28 21:21:52,032 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:52,033 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 18 interpolants.
[2025-04-28 21:21:52,033 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=53, Invalid=253, Unknown=0, NotChecked=0, Total=306
[2025-04-28 21:21:52,033 INFO  L87              Difference]: Start difference. First operand 78 states and 230 transitions. Second operand  has 18 states, 9 states have (on average 2.888888888888889) internal successors, (26), 13 states have internal predecessors, (26), 12 states have call successors, (18), 1 states have call predecessors, (18), 9 states have return successors, (22), 10 states have call predecessors, (22), 12 states have call successors, (22)
[2025-04-28 21:21:52,618 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:52,618 INFO  L93              Difference]: Finished difference Result 134 states and 603 transitions.
[2025-04-28 21:21:52,619 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 18 states. 
[2025-04-28 21:21:52,619 INFO  L79                 Accepts]: Start accepts. Automaton has  has 18 states, 9 states have (on average 2.888888888888889) internal successors, (26), 13 states have internal predecessors, (26), 12 states have call successors, (18), 1 states have call predecessors, (18), 9 states have return successors, (22), 10 states have call predecessors, (22), 12 states have call successors, (22) Word has length 64
[2025-04-28 21:21:52,621 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:52,622 INFO  L225             Difference]: With dead ends: 134
[2025-04-28 21:21:52,624 INFO  L226             Difference]: Without dead ends: 84
[2025-04-28 21:21:52,625 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 151 GetRequests, 117 SyntacticMatches, 3 SemanticMatches, 31 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 114 ImplicationChecksByTransitivity, 0.4s TimeCoverageRelationStatistics Valid=290, Invalid=766, Unknown=0, NotChecked=0, Total=1056
[2025-04-28 21:21:52,626 INFO  L437           NwaCegarLoop]: 48 mSDtfsCounter, 11 mSDsluCounter, 363 mSDsCounter, 0 mSdLazyCounter, 319 mSolverCounterSat, 86 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.3s Time, 0 mProtectedPredicate, 0 mProtectedAction, 15 SdHoareTripleChecker+Valid, 411 SdHoareTripleChecker+Invalid, 405 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 86 IncrementalHoareTripleChecker+Valid, 319 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.3s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:52,626 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [15 Valid, 411 Invalid, 405 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [86 Valid, 319 Invalid, 0 Unknown, 0 Unchecked, 0.3s Time]
[2025-04-28 21:21:52,627 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 84 states.
[2025-04-28 21:21:52,640 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 84 to 58.
[2025-04-28 21:21:52,640 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 58 states, 21 states have (on average 1.2380952380952381) internal successors, (26), 26 states have internal predecessors, (26), 20 states have call successors, (20), 5 states have call predecessors, (20), 16 states have return successors, (68), 27 states have call predecessors, (68), 20 states have call successors, (68)
[2025-04-28 21:21:52,641 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 58 states to 58 states and 114 transitions.
[2025-04-28 21:21:52,641 INFO  L79                 Accepts]: Start accepts. Automaton has 58 states and 114 transitions. Word has length 64
[2025-04-28 21:21:52,641 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:52,641 INFO  L485      AbstractCegarLoop]: Abstraction has 58 states and 114 transitions.
[2025-04-28 21:21:52,642 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 18 states, 9 states have (on average 2.888888888888889) internal successors, (26), 13 states have internal predecessors, (26), 12 states have call successors, (18), 1 states have call predecessors, (18), 9 states have return successors, (22), 10 states have call predecessors, (22), 12 states have call successors, (22)
[2025-04-28 21:21:52,642 INFO  L278                IsEmpty]: Start isEmpty. Operand 58 states and 114 transitions.
[2025-04-28 21:21:52,644 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 57
[2025-04-28 21:21:52,644 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:52,644 INFO  L218           NwaCegarLoop]: trace histogram [12, 7, 5, 5, 5, 5, 5, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:52,650 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (12)] Ended with exit code 0
[2025-04-28 21:21:52,848 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 12 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable12
[2025-04-28 21:21:52,849 INFO  L403      AbstractCegarLoop]: === Iteration 13 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:52,849 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:52,849 INFO  L85        PathProgramCache]: Analyzing trace with hash -2089913843, now seen corresponding path program 2 times
[2025-04-28 21:21:52,849 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:52,849 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [260175462]
[2025-04-28 21:21:52,849 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:21:52,849 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:52,857 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 56 statements into 2 equivalence classes.
[2025-04-28 21:21:52,874 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 56 of 56 statements.
[2025-04-28 21:21:52,878 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:21:52,878 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:53,236 INFO  L134       CoverageAnalysis]: Checked inductivity of 218 backedges. 27 proven. 107 refuted. 0 times theorem prover too weak. 84 trivial. 0 not checked.
[2025-04-28 21:21:53,236 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:53,236 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [260175462]
[2025-04-28 21:21:53,237 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [260175462] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:53,237 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1588835315]
[2025-04-28 21:21:53,237 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:21:53,237 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:53,240 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:53,242 INFO  L229       MonitoredProcess]: Starting monitored process 13 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:53,246 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (13)] Waiting until timeout for monitored process
[2025-04-28 21:21:53,315 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 56 statements into 2 equivalence classes.
[2025-04-28 21:21:53,348 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 56 of 56 statements.
[2025-04-28 21:21:53,348 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:21:53,348 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:53,350 INFO  L256         TraceCheckSpWp]: Trace formula consists of 238 conjuncts, 35 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:53,353 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:53,595 INFO  L134       CoverageAnalysis]: Checked inductivity of 218 backedges. 33 proven. 104 refuted. 0 times theorem prover too weak. 81 trivial. 0 not checked.
[2025-04-28 21:21:53,596 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:58,847 INFO  L134       CoverageAnalysis]: Checked inductivity of 218 backedges. 2 proven. 150 refuted. 0 times theorem prover too weak. 66 trivial. 0 not checked.
[2025-04-28 21:21:58,848 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1588835315] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:58,848 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:58,848 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [14, 16, 24] total 38
[2025-04-28 21:21:58,848 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1285780579]
[2025-04-28 21:21:58,848 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:58,848 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 38 states
[2025-04-28 21:21:58,849 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:58,849 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 38 interpolants.
[2025-04-28 21:21:58,850 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=158, Invalid=1248, Unknown=0, NotChecked=0, Total=1406
[2025-04-28 21:21:58,850 INFO  L87              Difference]: Start difference. First operand 58 states and 114 transitions. Second operand  has 38 states, 17 states have (on average 2.5294117647058822) internal successors, (43), 28 states have internal predecessors, (43), 23 states have call successors, (27), 2 states have call predecessors, (27), 17 states have return successors, (29), 18 states have call predecessors, (29), 23 states have call successors, (29)
[2025-04-28 21:21:59,645 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:59,645 INFO  L93              Difference]: Finished difference Result 74 states and 154 transitions.
[2025-04-28 21:21:59,646 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 16 states. 
[2025-04-28 21:21:59,646 INFO  L79                 Accepts]: Start accepts. Automaton has  has 38 states, 17 states have (on average 2.5294117647058822) internal successors, (43), 28 states have internal predecessors, (43), 23 states have call successors, (27), 2 states have call predecessors, (27), 17 states have return successors, (29), 18 states have call predecessors, (29), 23 states have call successors, (29) Word has length 56
[2025-04-28 21:21:59,647 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:59,649 INFO  L225             Difference]: With dead ends: 74
[2025-04-28 21:21:59,649 INFO  L226             Difference]: Without dead ends: 74
[2025-04-28 21:21:59,650 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 155 GetRequests, 102 SyntacticMatches, 4 SemanticMatches, 49 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 448 ImplicationChecksByTransitivity, 1.1s TimeCoverageRelationStatistics Valid=476, Invalid=2074, Unknown=0, NotChecked=0, Total=2550
[2025-04-28 21:21:59,653 INFO  L437           NwaCegarLoop]: 44 mSDtfsCounter, 39 mSDsluCounter, 621 mSDsCounter, 0 mSdLazyCounter, 435 mSolverCounterSat, 115 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 49 SdHoareTripleChecker+Valid, 665 SdHoareTripleChecker+Invalid, 550 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 115 IncrementalHoareTripleChecker+Valid, 435 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.4s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:59,653 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [49 Valid, 665 Invalid, 550 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [115 Valid, 435 Invalid, 0 Unknown, 0 Unchecked, 0.4s Time]
[2025-04-28 21:21:59,654 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 74 states.
[2025-04-28 21:21:59,664 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 74 to 59.
[2025-04-28 21:21:59,665 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 59 states, 22 states have (on average 1.2272727272727273) internal successors, (27), 27 states have internal predecessors, (27), 19 states have call successors, (19), 5 states have call predecessors, (19), 17 states have return successors, (73), 27 states have call predecessors, (73), 19 states have call successors, (73)
[2025-04-28 21:21:59,666 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 59 states to 59 states and 119 transitions.
[2025-04-28 21:21:59,666 INFO  L79                 Accepts]: Start accepts. Automaton has 59 states and 119 transitions. Word has length 56
[2025-04-28 21:21:59,666 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:59,666 INFO  L485      AbstractCegarLoop]: Abstraction has 59 states and 119 transitions.
[2025-04-28 21:21:59,666 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 38 states, 17 states have (on average 2.5294117647058822) internal successors, (43), 28 states have internal predecessors, (43), 23 states have call successors, (27), 2 states have call predecessors, (27), 17 states have return successors, (29), 18 states have call predecessors, (29), 23 states have call successors, (29)
[2025-04-28 21:21:59,667 INFO  L278                IsEmpty]: Start isEmpty. Operand 59 states and 119 transitions.
[2025-04-28 21:21:59,668 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 65
[2025-04-28 21:21:59,668 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:59,668 INFO  L218           NwaCegarLoop]: trace histogram [8, 6, 5, 3, 3, 3, 3, 3, 3, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:59,675 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (13)] Forceful destruction successful, exit code 0
[2025-04-28 21:21:59,872 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable13,13 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:59,872 INFO  L403      AbstractCegarLoop]: === Iteration 14 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:59,873 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:59,873 INFO  L85        PathProgramCache]: Analyzing trace with hash 1179429419, now seen corresponding path program 1 times
[2025-04-28 21:21:59,873 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:59,873 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1111388819]
[2025-04-28 21:21:59,873 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:59,873 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:59,880 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 64 statements into 1 equivalence classes.
[2025-04-28 21:21:59,891 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 64 of 64 statements.
[2025-04-28 21:21:59,892 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:59,892 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:59,985 INFO  L134       CoverageAnalysis]: Checked inductivity of 137 backedges. 29 proven. 22 refuted. 0 times theorem prover too weak. 86 trivial. 0 not checked.
[2025-04-28 21:21:59,985 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:59,986 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1111388819]
[2025-04-28 21:21:59,986 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1111388819] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:59,986 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [105303827]
[2025-04-28 21:21:59,986 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:59,986 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:59,988 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:59,991 INFO  L229       MonitoredProcess]: Starting monitored process 14 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:59,994 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (14)] Waiting until timeout for monitored process
[2025-04-28 21:22:00,095 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 64 statements into 1 equivalence classes.
[2025-04-28 21:22:00,127 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 64 of 64 statements.
[2025-04-28 21:22:00,127 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:00,127 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:00,129 INFO  L256         TraceCheckSpWp]: Trace formula consists of 232 conjuncts, 12 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:00,130 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:00,199 INFO  L134       CoverageAnalysis]: Checked inductivity of 137 backedges. 18 proven. 39 refuted. 0 times theorem prover too weak. 80 trivial. 0 not checked.
[2025-04-28 21:22:00,199 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:22:00,963 INFO  L134       CoverageAnalysis]: Checked inductivity of 137 backedges. 22 proven. 36 refuted. 0 times theorem prover too weak. 79 trivial. 0 not checked.
[2025-04-28 21:22:00,963 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [105303827] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:22:00,963 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:22:00,963 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [7, 10, 11] total 17
[2025-04-28 21:22:00,963 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1993535039]
[2025-04-28 21:22:00,963 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:22:00,964 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 17 states
[2025-04-28 21:22:00,964 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:22:00,964 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 17 interpolants.
[2025-04-28 21:22:00,965 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=48, Invalid=224, Unknown=0, NotChecked=0, Total=272
[2025-04-28 21:22:00,965 INFO  L87              Difference]: Start difference. First operand 59 states and 119 transitions. Second operand  has 17 states, 9 states have (on average 3.0) internal successors, (27), 12 states have internal predecessors, (27), 11 states have call successors, (21), 1 states have call predecessors, (21), 9 states have return successors, (25), 10 states have call predecessors, (25), 11 states have call successors, (25)
[2025-04-28 21:22:01,322 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:22:01,322 INFO  L93              Difference]: Finished difference Result 64 states and 125 transitions.
[2025-04-28 21:22:01,323 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 15 states. 
[2025-04-28 21:22:01,323 INFO  L79                 Accepts]: Start accepts. Automaton has  has 17 states, 9 states have (on average 3.0) internal successors, (27), 12 states have internal predecessors, (27), 11 states have call successors, (21), 1 states have call predecessors, (21), 9 states have return successors, (25), 10 states have call predecessors, (25), 11 states have call successors, (25) Word has length 64
[2025-04-28 21:22:01,323 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:22:01,325 INFO  L225             Difference]: With dead ends: 64
[2025-04-28 21:22:01,325 INFO  L226             Difference]: Without dead ends: 57
[2025-04-28 21:22:01,325 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 146 GetRequests, 116 SyntacticMatches, 4 SemanticMatches, 26 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 68 ImplicationChecksByTransitivity, 0.3s TimeCoverageRelationStatistics Valid=201, Invalid=555, Unknown=0, NotChecked=0, Total=756
[2025-04-28 21:22:01,326 INFO  L437           NwaCegarLoop]: 47 mSDtfsCounter, 16 mSDsluCounter, 317 mSDsCounter, 0 mSdLazyCounter, 228 mSolverCounterSat, 47 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 19 SdHoareTripleChecker+Valid, 364 SdHoareTripleChecker+Invalid, 275 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 47 IncrementalHoareTripleChecker+Valid, 228 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:22:01,327 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [19 Valid, 364 Invalid, 275 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [47 Valid, 228 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:22:01,327 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 57 states.
[2025-04-28 21:22:01,333 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 57 to 43.
[2025-04-28 21:22:01,334 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 43 states, 16 states have (on average 1.3125) internal successors, (21), 21 states have internal predecessors, (21), 15 states have call successors, (15), 5 states have call predecessors, (15), 11 states have return successors, (30), 18 states have call predecessors, (30), 15 states have call successors, (30)
[2025-04-28 21:22:01,334 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 43 states to 43 states and 66 transitions.
[2025-04-28 21:22:01,334 INFO  L79                 Accepts]: Start accepts. Automaton has 43 states and 66 transitions. Word has length 64
[2025-04-28 21:22:01,334 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:22:01,334 INFO  L485      AbstractCegarLoop]: Abstraction has 43 states and 66 transitions.
[2025-04-28 21:22:01,335 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 17 states, 9 states have (on average 3.0) internal successors, (27), 12 states have internal predecessors, (27), 11 states have call successors, (21), 1 states have call predecessors, (21), 9 states have return successors, (25), 10 states have call predecessors, (25), 11 states have call successors, (25)
[2025-04-28 21:22:01,335 INFO  L278                IsEmpty]: Start isEmpty. Operand 43 states and 66 transitions.
[2025-04-28 21:22:01,336 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 65
[2025-04-28 21:22:01,336 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:22:01,336 INFO  L218           NwaCegarLoop]: trace histogram [14, 8, 6, 6, 6, 6, 6, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:22:01,342 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (14)] Ended with exit code 0
[2025-04-28 21:22:01,540 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 14 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable14
[2025-04-28 21:22:01,540 INFO  L403      AbstractCegarLoop]: === Iteration 15 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:22:01,541 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:22:01,541 INFO  L85        PathProgramCache]: Analyzing trace with hash -412226221, now seen corresponding path program 3 times
[2025-04-28 21:22:01,541 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:22:01,541 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [163464725]
[2025-04-28 21:22:01,541 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:22:01,541 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:22:01,547 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 64 statements into 10 equivalence classes.
[2025-04-28 21:22:01,560 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 8 check-sat command(s) and asserted 56 of 64 statements.
[2025-04-28 21:22:01,561 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 8 check-sat command(s)
[2025-04-28 21:22:01,561 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:01,718 INFO  L134       CoverageAnalysis]: Checked inductivity of 303 backedges. 106 proven. 36 refuted. 0 times theorem prover too weak. 161 trivial. 0 not checked.
[2025-04-28 21:22:01,719 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:22:01,719 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [163464725]
[2025-04-28 21:22:01,719 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [163464725] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:22:01,719 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [374590476]
[2025-04-28 21:22:01,719 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:22:01,719 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:01,722 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:22:01,724 INFO  L229       MonitoredProcess]: Starting monitored process 15 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:22:01,734 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (15)] Waiting until timeout for monitored process
[2025-04-28 21:22:01,847 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 64 statements into 10 equivalence classes.
[2025-04-28 21:22:01,885 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 8 check-sat command(s) and asserted 56 of 64 statements.
[2025-04-28 21:22:01,885 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 8 check-sat command(s)
[2025-04-28 21:22:01,885 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:01,887 INFO  L256         TraceCheckSpWp]: Trace formula consists of 238 conjuncts, 15 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:01,889 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:01,937 INFO  L134       CoverageAnalysis]: Checked inductivity of 303 backedges. 106 proven. 34 refuted. 0 times theorem prover too weak. 163 trivial. 0 not checked.
[2025-04-28 21:22:01,937 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
