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


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-04-28 21:21:45,600 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-04-28 21:21:45,701 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_9ced73c4-5718-42ad-a07e-7638069654ec/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-04-28 21:21:45,709 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-04-28 21:21:45,709 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-04-28 21:21:45,748 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-04-28 21:21:45,749 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-04-28 21:21:45,749 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-04-28 21:21:45,751 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-04-28 21:21:45,751 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-04-28 21:21:45,753 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-04-28 21:21:45,753 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-04-28 21:21:45,753 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-04-28 21:21:45,753 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-04-28 21:21:45,754 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-04-28 21:21:45,754 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-04-28 21:21:45,754 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-04-28 21:21:45,754 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-04-28 21:21:45,755 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:45,755 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-04-28 21:21:45,755 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-04-28 21:21:45,755 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-04-28 21:21:45,755 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-04-28 21:21:45,755 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-04-28 21:21:45,755 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-04-28 21:21:45,756 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-04-28 21:21:45,756 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-04-28 21:21:46,089 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-04-28 21:21:46,103 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-04-28 21:21:46,106 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-04-28 21:21:46,108 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-04-28 21:21:46,109 INFO  L274        PluginConnector]: SmtParser initialized
[2025-04-28 21:21:46,110 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_9ced73c4-5718-42ad-a07e-7638069654ec/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-222.smt2
[2025-04-28 21:21:46,111 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-04-28 21:21:46,115 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-04-28 21:21:46,402 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_9ced73c4-5718-42ad-a07e-7638069654ec/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-222.smt2
[2025-04-28 21:21:46,408 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-04-28 21:21:46,409 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-04-28 21:21:46,412 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-04-28 21:21:46,413 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-04-28 21:21:46,413 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-04-28 21:21:46,416 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,449 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46 Unit
[2025-04-28 21:21:46,449 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-04-28 21:21:46,450 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-04-28 21:21:46,451 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-04-28 21:21:46,452 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-04-28 21:21:46,473 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,473 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,509 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,511 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,514 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,516 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,519 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,523 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,524 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,546 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-04-28 21:21:46,547 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-04-28 21:21:46,549 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-04-28 21:21:46,549 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-04-28 21:21:46,551 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (1/1) ...
[2025-04-28 21:21:46,554 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:46,571 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:46,591 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:46,595 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:46,616 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-04-28 21:21:46,616 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-04-28 21:21:46,616 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-04-28 21:21:46,617 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure inv_main16 given in one single declaration
[2025-04-28 21:21:46,617 INFO  L130     BoogieDeclarations]: Found specification of procedure inv_main16
[2025-04-28 21:21:46,617 INFO  L138     BoogieDeclarations]: Found implementation of procedure inv_main16
[2025-04-28 21:21:46,617 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann_post given in one single declaration
[2025-04-28 21:21:46,617 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann_post
[2025-04-28 21:21:46,617 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann_post
[2025-04-28 21:21:46,617 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann1 given in one single declaration
[2025-04-28 21:21:46,617 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann1
[2025-04-28 21:21:46,618 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann1
[2025-04-28 21:21:46,618 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann11 given in one single declaration
[2025-04-28 21:21:46,618 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann11
[2025-04-28 21:21:46,619 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann11
[2025-04-28 21:21:46,620 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann10 given in one single declaration
[2025-04-28 21:21:46,620 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann10
[2025-04-28 21:21:46,620 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann10
[2025-04-28 21:21:46,620 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann6 given in one single declaration
[2025-04-28 21:21:46,620 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann6
[2025-04-28 21:21:46,620 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann6
[2025-04-28 21:21:46,620 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann8 given in one single declaration
[2025-04-28 21:21:46,621 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann8
[2025-04-28 21:21:46,621 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann8
[2025-04-28 21:21:46,621 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann3 given in one single declaration
[2025-04-28 21:21:46,621 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann3
[2025-04-28 21:21:46,621 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann3
[2025-04-28 21:21:46,621 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann5 given in one single declaration
[2025-04-28 21:21:46,622 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann5
[2025-04-28 21:21:46,622 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann5
[2025-04-28 21:21:46,622 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann0 given in one single declaration
[2025-04-28 21:21:46,623 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann0
[2025-04-28 21:21:46,623 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann0
[2025-04-28 21:21:46,623 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann_pre given in one single declaration
[2025-04-28 21:21:46,623 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann_pre
[2025-04-28 21:21:46,623 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann_pre
[2025-04-28 21:21:46,623 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann9 given in one single declaration
[2025-04-28 21:21:46,623 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann9
[2025-04-28 21:21:46,624 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann9
[2025-04-28 21:21:46,624 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann7 given in one single declaration
[2025-04-28 21:21:46,624 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann7
[2025-04-28 21:21:46,624 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann7
[2025-04-28 21:21:46,625 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure ackermann4 given in one single declaration
[2025-04-28 21:21:46,625 INFO  L130     BoogieDeclarations]: Found specification of procedure ackermann4
[2025-04-28 21:21:46,625 INFO  L138     BoogieDeclarations]: Found implementation of procedure ackermann4
[2025-04-28 21:21:46,625 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure inv_main13 given in one single declaration
[2025-04-28 21:21:46,626 INFO  L130     BoogieDeclarations]: Found specification of procedure inv_main13
[2025-04-28 21:21:46,626 INFO  L138     BoogieDeclarations]: Found implementation of procedure inv_main13
[2025-04-28 21:21:46,626 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure inv_main2 given in one single declaration
[2025-04-28 21:21:46,626 INFO  L130     BoogieDeclarations]: Found specification of procedure inv_main2
[2025-04-28 21:21:46,626 INFO  L138     BoogieDeclarations]: Found implementation of procedure inv_main2
[2025-04-28 21:21:46,626 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-04-28 21:21:46,626 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-04-28 21:21:46,626 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-04-28 21:21:46,722 INFO  L234             CfgBuilder]: Building ICFG
[2025-04-28 21:21:46,725 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-04-28 21:21:46,955 INFO  L?                        ?]: Removed 0 outVars from TransFormulas that were not future-live.
[2025-04-28 21:21:46,956 INFO  L283             CfgBuilder]: Performing block encoding
[2025-04-28 21:21:46,973 INFO  L304             CfgBuilder]: Using library mode
[2025-04-28 21:21:46,973 INFO  L312             CfgBuilder]: Removed 12 assume(true) statements.
[2025-04-28 21:21:46,974 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:46 BoogieIcfgContainer
[2025-04-28 21:21:46,974 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-04-28 21:21:46,977 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-04-28 21:21:46,977 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-04-28 21:21:46,982 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-04-28 21:21:46,982 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:46" (1/3) ...
[2025-04-28 21:21:46,983 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@8a8ae7f and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 28.04 09:21:46, skipping insertion in model container
[2025-04-28 21:21:46,983 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:46" (2/3) ...
[2025-04-28 21:21:46,983 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@8a8ae7f and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 28.04 09:21:46, skipping insertion in model container
[2025-04-28 21:21:46,984 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:46" (3/3) ...
[2025-04-28 21:21:46,985 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-04-28 21:21:47,004 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-04-28 21:21:47,007 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 18 procedures, 69 locations, 108 edges, 18 initial locations, 0 loop locations, and 1 error locations.
[2025-04-28 21:21:47,062 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-04-28 21:21:47,077 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;@a705477, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-04-28 21:21:47,077 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-04-28 21:21:47,082 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 69 states, 29 states have (on average 1.0344827586206897) internal successors, (30), 30 states have internal predecessors, (30), 22 states have call successors, (26), 17 states have call predecessors, (26), 17 states have return successors, (26), 21 states have call predecessors, (26), 22 states have call successors, (26)
[2025-04-28 21:21:47,094 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 41
[2025-04-28 21:21:47,094 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:47,095 INFO  L218           NwaCegarLoop]: trace histogram [2, 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, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:47,095 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:47,101 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:47,102 INFO  L85        PathProgramCache]: Analyzing trace with hash 745936776, now seen corresponding path program 1 times
[2025-04-28 21:21:47,112 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:47,113 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1767297702]
[2025-04-28 21:21:47,113 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:47,114 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:47,170 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 40 statements into 1 equivalence classes.
[2025-04-28 21:21:47,221 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 40 of 40 statements.
[2025-04-28 21:21:47,221 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:47,221 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:48,008 INFO  L134       CoverageAnalysis]: Checked inductivity of 6 backedges. 0 proven. 3 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-04-28 21:21:48,008 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:48,009 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1767297702]
[2025-04-28 21:21:48,009 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1767297702] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:48,009 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [702167790]
[2025-04-28 21:21:48,010 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:48,010 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:48,014 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:48,016 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:48,020 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-04-28 21:21:48,097 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 40 statements into 1 equivalence classes.
[2025-04-28 21:21:48,133 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 40 of 40 statements.
[2025-04-28 21:21:48,133 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:48,133 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:48,136 INFO  L256         TraceCheckSpWp]: Trace formula consists of 135 conjuncts, 14 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:48,142 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:48,480 INFO  L134       CoverageAnalysis]: Checked inductivity of 6 backedges. 0 proven. 3 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-04-28 21:21:48,480 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:50,461 INFO  L134       CoverageAnalysis]: Checked inductivity of 6 backedges. 0 proven. 3 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-04-28 21:21:50,461 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [702167790] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:50,462 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:50,465 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [10, 10, 10] total 20
[2025-04-28 21:21:50,468 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [101167161]
[2025-04-28 21:21:50,468 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:50,474 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 20 states
[2025-04-28 21:21:50,474 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:50,529 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 20 interpolants.
[2025-04-28 21:21:50,533 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=53, Invalid=327, Unknown=0, NotChecked=0, Total=380
[2025-04-28 21:21:50,540 INFO  L87              Difference]: Start difference. First operand  has 69 states, 29 states have (on average 1.0344827586206897) internal successors, (30), 30 states have internal predecessors, (30), 22 states have call successors, (26), 17 states have call predecessors, (26), 17 states have return successors, (26), 21 states have call predecessors, (26), 22 states have call successors, (26) Second operand  has 20 states, 11 states have (on average 2.4545454545454546) internal successors, (27), 17 states have internal predecessors, (27), 14 states have call successors, (19), 1 states have call predecessors, (19), 11 states have return successors, (21), 14 states have call predecessors, (21), 14 states have call successors, (21)
[2025-04-28 21:21:51,027 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:51,028 INFO  L93              Difference]: Finished difference Result 71 states and 86 transitions.
[2025-04-28 21:21:51,031 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 10 states. 
[2025-04-28 21:21:51,032 INFO  L79                 Accepts]: Start accepts. Automaton has  has 20 states, 11 states have (on average 2.4545454545454546) internal successors, (27), 17 states have internal predecessors, (27), 14 states have call successors, (19), 1 states have call predecessors, (19), 11 states have return successors, (21), 14 states have call predecessors, (21), 14 states have call successors, (21) Word has length 40
[2025-04-28 21:21:51,033 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:51,043 INFO  L225             Difference]: With dead ends: 71
[2025-04-28 21:21:51,043 INFO  L226             Difference]: Without dead ends: 71
[2025-04-28 21:21:51,045 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 92 GetRequests, 66 SyntacticMatches, 5 SemanticMatches, 21 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 102 ImplicationChecksByTransitivity, 0.6s TimeCoverageRelationStatistics Valid=71, Invalid=435, Unknown=0, NotChecked=0, Total=506
[2025-04-28 21:21:51,051 INFO  L437           NwaCegarLoop]: 70 mSDtfsCounter, 3 mSDsluCounter, 1000 mSDsCounter, 0 mSdLazyCounter, 174 mSolverCounterSat, 3 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 1070 SdHoareTripleChecker+Invalid, 177 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.1s SdHoareTripleChecker+Time, 3 IncrementalHoareTripleChecker+Valid, 174 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.3s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:51,052 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 1070 Invalid, 177 Unknown, 0 Unchecked, 0.1s Time], IncrementalHoareTripleChecker [3 Valid, 174 Invalid, 0 Unknown, 0 Unchecked, 0.3s Time]
[2025-04-28 21:21:51,068 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 71 states.
[2025-04-28 21:21:51,093 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 71 to 71.
[2025-04-28 21:21:51,094 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 71 states, 30 states have (on average 1.0) internal successors, (30), 30 states have internal predecessors, (30), 22 states have call successors, (26), 17 states have call predecessors, (26), 19 states have return successors, (30), 23 states have call predecessors, (30), 22 states have call successors, (30)
[2025-04-28 21:21:51,099 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 71 states to 71 states and 86 transitions.
[2025-04-28 21:21:51,100 INFO  L79                 Accepts]: Start accepts. Automaton has 71 states and 86 transitions. Word has length 40
[2025-04-28 21:21:51,101 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:51,101 INFO  L485      AbstractCegarLoop]: Abstraction has 71 states and 86 transitions.
[2025-04-28 21:21:51,102 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 20 states, 11 states have (on average 2.4545454545454546) internal successors, (27), 17 states have internal predecessors, (27), 14 states have call successors, (19), 1 states have call predecessors, (19), 11 states have return successors, (21), 14 states have call predecessors, (21), 14 states have call successors, (21)
[2025-04-28 21:21:51,102 INFO  L278                IsEmpty]: Start isEmpty. Operand 71 states and 86 transitions.
[2025-04-28 21:21:51,105 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 76
[2025-04-28 21:21:51,105 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:51,105 INFO  L218           NwaCegarLoop]: trace histogram [3, 3, 3, 3, 3, 2, 2, 2, 2, 2, 2, 2, 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:51,111 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-04-28 21:21:51,309 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1,2 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:51,310 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:51,310 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:51,311 INFO  L85        PathProgramCache]: Analyzing trace with hash -672167145, now seen corresponding path program 1 times
[2025-04-28 21:21:51,311 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:51,311 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1793284716]
[2025-04-28 21:21:51,311 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:51,311 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:51,324 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 75 statements into 1 equivalence classes.
[2025-04-28 21:21:51,334 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 75 of 75 statements.
[2025-04-28 21:21:51,334 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:51,334 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:51,851 INFO  L134       CoverageAnalysis]: Checked inductivity of 31 backedges. 2 proven. 5 refuted. 0 times theorem prover too weak. 24 trivial. 0 not checked.
[2025-04-28 21:21:51,851 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:51,852 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1793284716]
[2025-04-28 21:21:51,852 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1793284716] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:51,852 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1628784268]
[2025-04-28 21:21:51,852 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:51,852 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:51,856 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:51,859 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:51,864 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-04-28 21:21:51,954 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 75 statements into 1 equivalence classes.
[2025-04-28 21:21:52,007 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 75 of 75 statements.
[2025-04-28 21:21:52,007 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:52,007 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:52,009 INFO  L256         TraceCheckSpWp]: Trace formula consists of 267 conjuncts, 12 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:52,012 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:52,252 INFO  L134       CoverageAnalysis]: Checked inductivity of 31 backedges. 3 proven. 7 refuted. 0 times theorem prover too weak. 21 trivial. 0 not checked.
[2025-04-28 21:21:52,252 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:56,446 INFO  L134       CoverageAnalysis]: Checked inductivity of 31 backedges. 3 proven. 7 refuted. 0 times theorem prover too weak. 21 trivial. 0 not checked.
[2025-04-28 21:21:56,446 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1628784268] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:56,446 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:56,447 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [12, 10, 10] total 21
[2025-04-28 21:21:56,447 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [920532766]
[2025-04-28 21:21:56,447 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:56,448 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 21 states
[2025-04-28 21:21:56,448 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:56,449 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 21 interpolants.
[2025-04-28 21:21:56,449 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=52, Invalid=368, Unknown=0, NotChecked=0, Total=420
[2025-04-28 21:21:56,450 INFO  L87              Difference]: Start difference. First operand 71 states and 86 transitions. Second operand  has 21 states, 15 states have (on average 2.533333333333333) internal successors, (38), 20 states have internal predecessors, (38), 11 states have call successors, (24), 1 states have call predecessors, (24), 15 states have return successors, (31), 18 states have call predecessors, (31), 11 states have call successors, (31)
[2025-04-28 21:21:56,981 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:56,981 INFO  L93              Difference]: Finished difference Result 101 states and 131 transitions.
[2025-04-28 21:21:56,982 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 21 states. 
[2025-04-28 21:21:56,982 INFO  L79                 Accepts]: Start accepts. Automaton has  has 21 states, 15 states have (on average 2.533333333333333) internal successors, (38), 20 states have internal predecessors, (38), 11 states have call successors, (24), 1 states have call predecessors, (24), 15 states have return successors, (31), 18 states have call predecessors, (31), 11 states have call successors, (31) Word has length 75
[2025-04-28 21:21:56,983 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:56,985 INFO  L225             Difference]: With dead ends: 101
[2025-04-28 21:21:56,985 INFO  L226             Difference]: Without dead ends: 101
[2025-04-28 21:21:56,985 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 166 GetRequests, 133 SyntacticMatches, 9 SemanticMatches, 24 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 125 ImplicationChecksByTransitivity, 0.6s TimeCoverageRelationStatistics Valid=78, Invalid=572, Unknown=0, NotChecked=0, Total=650
[2025-04-28 21:21:56,986 INFO  L437           NwaCegarLoop]: 73 mSDtfsCounter, 3 mSDsluCounter, 1035 mSDsCounter, 0 mSdLazyCounter, 355 mSolverCounterSat, 9 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.3s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 1108 SdHoareTripleChecker+Invalid, 364 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 9 IncrementalHoareTripleChecker+Valid, 355 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.4s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:56,987 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 1108 Invalid, 364 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [9 Valid, 355 Invalid, 0 Unknown, 0 Unchecked, 0.4s Time]
[2025-04-28 21:21:56,988 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 101 states.
[2025-04-28 21:21:57,008 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 101 to 83.
[2025-04-28 21:21:57,008 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 83 states, 35 states have (on average 1.0) internal successors, (35), 35 states have internal predecessors, (35), 24 states have call successors, (28), 17 states have call predecessors, (28), 24 states have return successors, (40), 30 states have call predecessors, (40), 24 states have call successors, (40)
[2025-04-28 21:21:57,010 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 83 states to 83 states and 103 transitions.
[2025-04-28 21:21:57,011 INFO  L79                 Accepts]: Start accepts. Automaton has 83 states and 103 transitions. Word has length 75
[2025-04-28 21:21:57,011 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:57,011 INFO  L485      AbstractCegarLoop]: Abstraction has 83 states and 103 transitions.
[2025-04-28 21:21:57,011 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 21 states, 15 states have (on average 2.533333333333333) internal successors, (38), 20 states have internal predecessors, (38), 11 states have call successors, (24), 1 states have call predecessors, (24), 15 states have return successors, (31), 18 states have call predecessors, (31), 11 states have call successors, (31)
[2025-04-28 21:21:57,012 INFO  L278                IsEmpty]: Start isEmpty. Operand 83 states and 103 transitions.
[2025-04-28 21:21:57,016 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 132
[2025-04-28 21:21:57,016 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:57,016 INFO  L218           NwaCegarLoop]: trace histogram [4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 3, 3, 3, 3, 3, 3, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 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, 1]
[2025-04-28 21:21:57,021 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Ended with exit code 0
[2025-04-28 21:21:57,217 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2,3 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:57,217 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:57,220 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:57,222 INFO  L85        PathProgramCache]: Analyzing trace with hash -441127017, now seen corresponding path program 1 times
[2025-04-28 21:21:57,222 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:57,222 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1692974224]
[2025-04-28 21:21:57,222 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:57,222 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:57,259 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 131 statements into 1 equivalence classes.
[2025-04-28 21:21:57,278 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 131 of 131 statements.
[2025-04-28 21:21:57,287 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:57,287 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:57,703 INFO  L134       CoverageAnalysis]: Checked inductivity of 119 backedges. 8 proven. 27 refuted. 0 times theorem prover too weak. 84 trivial. 0 not checked.
[2025-04-28 21:21:57,703 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:57,703 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1692974224]
[2025-04-28 21:21:57,704 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1692974224] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:57,704 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [199962092]
[2025-04-28 21:21:57,704 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:57,704 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:57,707 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:57,710 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:57,715 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-04-28 21:21:57,840 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 131 statements into 1 equivalence classes.
[2025-04-28 21:21:57,923 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 131 of 131 statements.
[2025-04-28 21:21:57,923 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:57,923 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:57,926 INFO  L256         TraceCheckSpWp]: Trace formula consists of 485 conjuncts, 20 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:57,936 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:58,444 INFO  L134       CoverageAnalysis]: Checked inductivity of 119 backedges. 7 proven. 44 refuted. 0 times theorem prover too weak. 68 trivial. 0 not checked.
[2025-04-28 21:21:58,444 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:22:12,328 INFO  L134       CoverageAnalysis]: Checked inductivity of 119 backedges. 7 proven. 44 refuted. 0 times theorem prover too weak. 68 trivial. 0 not checked.
[2025-04-28 21:22:12,328 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [199962092] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:22:12,328 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:22:12,328 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [11, 18, 18] total 29
[2025-04-28 21:22:12,329 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [793186415]
[2025-04-28 21:22:12,329 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:22:12,330 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 29 states
[2025-04-28 21:22:12,330 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:22:12,331 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 29 interpolants.
[2025-04-28 21:22:12,331 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=61, Invalid=751, Unknown=0, NotChecked=0, Total=812
[2025-04-28 21:22:12,332 INFO  L87              Difference]: Start difference. First operand 83 states and 103 transitions. Second operand  has 29 states, 22 states have (on average 2.5454545454545454) internal successors, (56), 29 states have internal predecessors, (56), 12 states have call successors, (31), 1 states have call predecessors, (31), 22 states have return successors, (48), 23 states have call predecessors, (48), 12 states have call successors, (48)
[2025-04-28 21:22:13,165 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:22:13,165 INFO  L93              Difference]: Finished difference Result 135 states and 177 transitions.
[2025-04-28 21:22:13,166 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 30 states. 
[2025-04-28 21:22:13,166 INFO  L79                 Accepts]: Start accepts. Automaton has  has 29 states, 22 states have (on average 2.5454545454545454) internal successors, (56), 29 states have internal predecessors, (56), 12 states have call successors, (31), 1 states have call predecessors, (31), 22 states have return successors, (48), 23 states have call predecessors, (48), 12 states have call successors, (48) Word has length 131
[2025-04-28 21:22:13,167 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:22:13,169 INFO  L225             Difference]: With dead ends: 135
[2025-04-28 21:22:13,169 INFO  L226             Difference]: Without dead ends: 135
[2025-04-28 21:22:13,170 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 286 GetRequests, 231 SyntacticMatches, 15 SemanticMatches, 40 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 130 ImplicationChecksByTransitivity, 1.2s TimeCoverageRelationStatistics Valid=127, Invalid=1595, Unknown=0, NotChecked=0, Total=1722
[2025-04-28 21:22:13,171 INFO  L437           NwaCegarLoop]: 78 mSDtfsCounter, 12 mSDsluCounter, 1866 mSDsCounter, 0 mSdLazyCounter, 679 mSolverCounterSat, 18 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 21 SdHoareTripleChecker+Valid, 1944 SdHoareTripleChecker+Invalid, 697 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 18 IncrementalHoareTripleChecker+Valid, 679 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:22:13,171 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [21 Valid, 1944 Invalid, 697 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [18 Valid, 679 Invalid, 0 Unknown, 0 Unchecked, 0.5s Time]
[2025-04-28 21:22:13,172 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 135 states.
[2025-04-28 21:22:13,185 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 135 to 90.
[2025-04-28 21:22:13,185 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 90 states, 38 states have (on average 1.0) internal successors, (38), 38 states have internal predecessors, (38), 26 states have call successors, (32), 19 states have call predecessors, (32), 26 states have return successors, (43), 32 states have call predecessors, (43), 26 states have call successors, (43)
[2025-04-28 21:22:13,187 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 90 states to 90 states and 113 transitions.
[2025-04-28 21:22:13,187 INFO  L79                 Accepts]: Start accepts. Automaton has 90 states and 113 transitions. Word has length 131
[2025-04-28 21:22:13,188 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:22:13,188 INFO  L485      AbstractCegarLoop]: Abstraction has 90 states and 113 transitions.
[2025-04-28 21:22:13,188 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 29 states, 22 states have (on average 2.5454545454545454) internal successors, (56), 29 states have internal predecessors, (56), 12 states have call successors, (31), 1 states have call predecessors, (31), 22 states have return successors, (48), 23 states have call predecessors, (48), 12 states have call successors, (48)
[2025-04-28 21:22:13,188 INFO  L278                IsEmpty]: Start isEmpty. Operand 90 states and 113 transitions.
[2025-04-28 21:22:13,191 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 160
[2025-04-28 21:22:13,191 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:22:13,191 INFO  L218           NwaCegarLoop]: trace histogram [5, 5, 5, 5, 5, 5, 5, 5, 5, 5, 4, 4, 4, 4, 4, 4, 3, 3, 3, 3, 3, 3, 3, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 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:22:13,196 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Forceful destruction successful, exit code 0
[2025-04-28 21:22:13,393 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3,4 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:13,393 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:22:13,394 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:22:13,394 INFO  L85        PathProgramCache]: Analyzing trace with hash 1271919611, now seen corresponding path program 1 times
[2025-04-28 21:22:13,394 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:22:13,394 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [923433975]
[2025-04-28 21:22:13,394 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:22:13,394 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:22:13,409 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 159 statements into 1 equivalence classes.
[2025-04-28 21:22:13,418 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 159 of 159 statements.
[2025-04-28 21:22:13,418 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:13,418 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:13,801 INFO  L134       CoverageAnalysis]: Checked inductivity of 203 backedges. 27 proven. 42 refuted. 0 times theorem prover too weak. 134 trivial. 0 not checked.
[2025-04-28 21:22:13,802 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:22:13,802 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [923433975]
[2025-04-28 21:22:13,802 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [923433975] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:22:13,804 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [879696404]
[2025-04-28 21:22:13,804 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:22:13,804 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:13,807 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:22:13,810 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:22:13,814 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Waiting until timeout for monitored process
[2025-04-28 21:22:14,142 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 159 statements into 1 equivalence classes.
[2025-04-28 21:22:14,228 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 159 of 159 statements.
[2025-04-28 21:22:14,228 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:14,228 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:14,232 INFO  L256         TraceCheckSpWp]: Trace formula consists of 590 conjuncts, 15 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:14,237 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:14,553 INFO  L134       CoverageAnalysis]: Checked inductivity of 203 backedges. 138 proven. 3 refuted. 0 times theorem prover too weak. 62 trivial. 0 not checked.
[2025-04-28 21:22:14,553 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
