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


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-04-28 21:21:51,877 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-04-28 21:21:51,977 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_56877eaa-fbcf-4f18-b1f3-5cf89a974cca/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-04-28 21:21:51,986 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-04-28 21:21:51,986 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-04-28 21:21:52,009 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-04-28 21:21:52,011 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-04-28 21:21:52,011 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-04-28 21:21:52,012 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-04-28 21:21:52,013 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-04-28 21:21:52,014 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-04-28 21:21:52,014 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-04-28 21:21:52,014 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-04-28 21:21:52,014 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-04-28 21:21:52,015 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-04-28 21:21:52,015 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-04-28 21:21:52,015 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-04-28 21:21:52,015 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-04-28 21:21:52,015 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:52,016 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-04-28 21:21:52,016 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-04-28 21:21:52,016 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-04-28 21:21:52,016 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-04-28 21:21:52,016 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-04-28 21:21:52,016 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-04-28 21:21:52,017 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-04-28 21:21:52,017 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-04-28 21:21:52,329 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-04-28 21:21:52,338 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-04-28 21:21:52,340 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-04-28 21:21:52,342 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-04-28 21:21:52,342 INFO  L274        PluginConnector]: SmtParser initialized
[2025-04-28 21:21:52,343 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_56877eaa-fbcf-4f18-b1f3-5cf89a974cca/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-130.smt2
[2025-04-28 21:21:52,345 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-04-28 21:21:52,348 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-04-28 21:21:52,636 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_56877eaa-fbcf-4f18-b1f3-5cf89a974cca/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-130.smt2
[2025-04-28 21:21:52,642 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-04-28 21:21:52,644 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-04-28 21:21:52,644 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-04-28 21:21:52,645 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-04-28 21:21:52,645 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-04-28 21:21:52,648 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,679 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52 Unit
[2025-04-28 21:21:52,679 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-04-28 21:21:52,680 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-04-28 21:21:52,680 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-04-28 21:21:52,680 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-04-28 21:21:52,697 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,697 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,724 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,727 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,732 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,734 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,736 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,737 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,738 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,755 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-04-28 21:21:52,756 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-04-28 21:21:52,757 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-04-28 21:21:52,757 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-04-28 21:21:52,758 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (1/1) ...
[2025-04-28 21:21:52,760 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:52,773 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:52,785 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:52,788 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:52,800 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-04-28 21:21:52,800 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-04-28 21:21:52,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-04-28 21:21:52,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure make_array.DLRunknown.CLN17 given in one single declaration
[2025-04-28 21:21:52,801 INFO  L130     BoogieDeclarations]: Found specification of procedure make_array.DLRunknown.CLN17
[2025-04-28 21:21:52,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure make_array.DLRunknown.CLN17
[2025-04-28 21:21:52,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure bcopy_aux.DLRunknown.CLN10 given in one single declaration
[2025-04-28 21:21:52,801 INFO  L130     BoogieDeclarations]: Found specification of procedure bcopy_aux.DLRunknown.CLN10
[2025-04-28 21:21:52,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure bcopy_aux.DLRunknown.CLN10
[2025-04-28 21:21:52,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure bcopy_aux.DLRunknown.CLN14 given in one single declaration
[2025-04-28 21:21:52,802 INFO  L130     BoogieDeclarations]: Found specification of procedure bcopy_aux.DLRunknown.CLN14
[2025-04-28 21:21:52,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure bcopy_aux.DLRunknown.CLN14
[2025-04-28 21:21:52,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure bcopy_aux.DLRunknown.CLN11 given in one single declaration
[2025-04-28 21:21:52,802 INFO  L130     BoogieDeclarations]: Found specification of procedure bcopy_aux.DLRunknown.CLN11
[2025-04-28 21:21:52,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure bcopy_aux.DLRunknown.CLN11
[2025-04-28 21:21:52,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure make_array.DLRunknown.CLN18 given in one single declaration
[2025-04-28 21:21:52,802 INFO  L130     BoogieDeclarations]: Found specification of procedure make_array.DLRunknown.CLN18
[2025-04-28 21:21:52,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure make_array.DLRunknown.CLN18
[2025-04-28 21:21:52,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure bcopy_aux.DLRunknown.CLN12 given in one single declaration
[2025-04-28 21:21:52,802 INFO  L130     BoogieDeclarations]: Found specification of procedure bcopy_aux.DLRunknown.CLN12
[2025-04-28 21:21:52,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure bcopy_aux.DLRunknown.CLN12
[2025-04-28 21:21:52,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN21 given in one single declaration
[2025-04-28 21:21:52,803 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN21
[2025-04-28 21:21:52,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN21
[2025-04-28 21:21:52,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN22 given in one single declaration
[2025-04-28 21:21:52,803 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN22
[2025-04-28 21:21:52,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN22
[2025-04-28 21:21:52,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure bcopy_aux.DLRunknown.CLN13 given in one single declaration
[2025-04-28 21:21:52,803 INFO  L130     BoogieDeclarations]: Found specification of procedure bcopy_aux.DLRunknown.CLN13
[2025-04-28 21:21:52,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure bcopy_aux.DLRunknown.CLN13
[2025-04-28 21:21:52,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN25 given in one single declaration
[2025-04-28 21:21:52,804 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN25
[2025-04-28 21:21:52,804 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN25
[2025-04-28 21:21:52,804 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN8 given in one single declaration
[2025-04-28 21:21:52,804 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN8
[2025-04-28 21:21:52,804 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN8
[2025-04-28 21:21:52,804 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN4 given in one single declaration
[2025-04-28 21:21:52,804 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN4
[2025-04-28 21:21:52,804 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN4
[2025-04-28 21:21:52,804 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN7 given in one single declaration
[2025-04-28 21:21:52,804 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN7
[2025-04-28 21:21:52,805 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN7
[2025-04-28 21:21:52,805 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN24 given in one single declaration
[2025-04-28 21:21:52,805 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN24
[2025-04-28 21:21:52,805 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN24
[2025-04-28 21:21:52,805 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN3 given in one single declaration
[2025-04-28 21:21:52,805 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN3
[2025-04-28 21:21:52,805 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN3
[2025-04-28 21:21:52,805 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN23 given in one single declaration
[2025-04-28 21:21:52,805 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN23
[2025-04-28 21:21:52,806 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN23
[2025-04-28 21:21:52,806 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-04-28 21:21:52,806 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-04-28 21:21:52,806 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-04-28 21:21:52,890 INFO  L234             CfgBuilder]: Building ICFG
[2025-04-28 21:21:52,893 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-04-28 21:21:53,217 INFO  L?                        ?]: Removed 45 outVars from TransFormulas that were not future-live.
[2025-04-28 21:21:53,217 INFO  L283             CfgBuilder]: Performing block encoding
[2025-04-28 21:21:53,244 INFO  L304             CfgBuilder]: Using library mode
[2025-04-28 21:21:53,245 INFO  L312             CfgBuilder]: Removed 0 assume(true) statements.
[2025-04-28 21:21:53,245 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:53 BoogieIcfgContainer
[2025-04-28 21:21:53,245 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-04-28 21:21:53,248 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-04-28 21:21:53,249 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-04-28 21:21:53,255 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-04-28 21:21:53,256 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:52" (1/3) ...
[2025-04-28 21:21:53,257 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@34320ec and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 28.04 09:21:53, skipping insertion in model container
[2025-04-28 21:21:53,257 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:52" (2/3) ...
[2025-04-28 21:21:53,258 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@34320ec and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 28.04 09:21:53, skipping insertion in model container
[2025-04-28 21:21:53,258 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:53" (3/3) ...
[2025-04-28 21:21:53,259 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-04-28 21:21:53,279 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-04-28 21:21:53,282 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 18 procedures, 102 locations, 184 edges, 18 initial locations, 0 loop locations, and 1 error locations.
[2025-04-28 21:21:53,336 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-04-28 21:21:53,359 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;@4a6848fb, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-04-28 21:21:53,359 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-04-28 21:21:53,370 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 102 states, 36 states have (on average 1.1944444444444444) internal successors, (43), 43 states have internal predecessors, (43), 47 states have call successors, (47), 17 states have call predecessors, (47), 17 states have return successors, (47), 43 states have call predecessors, (47), 47 states have call successors, (47)
[2025-04-28 21:21:53,383 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 6
[2025-04-28 21:21:53,383 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:53,384 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1]
[2025-04-28 21:21:53,384 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:53,390 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:53,390 INFO  L85        PathProgramCache]: Analyzing trace with hash 211651141, now seen corresponding path program 1 times
[2025-04-28 21:21:53,400 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:53,400 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1260086797]
[2025-04-28 21:21:53,401 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:53,401 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:53,433 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 5 statements into 1 equivalence classes.
[2025-04-28 21:21:53,438 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 5 of 5 statements.
[2025-04-28 21:21:53,438 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:53,439 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:53,475 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-04-28 21:21:53,476 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:53,479 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1260086797]
[2025-04-28 21:21:53,480 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1260086797] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:53,480 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-04-28 21:21:53,483 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [2] imperfect sequences [] total 2
[2025-04-28 21:21:53,486 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [93827820]
[2025-04-28 21:21:53,486 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:53,491 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 2 states
[2025-04-28 21:21:53,491 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:53,530 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 2 interpolants.
[2025-04-28 21:21:53,531 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=1, Invalid=1, Unknown=0, NotChecked=0, Total=2
[2025-04-28 21:21:53,535 INFO  L87              Difference]: Start difference. First operand  has 102 states, 36 states have (on average 1.1944444444444444) internal successors, (43), 43 states have internal predecessors, (43), 47 states have call successors, (47), 17 states have call predecessors, (47), 17 states have return successors, (47), 43 states have call predecessors, (47), 47 states have call successors, (47) Second operand  has 2 states, 2 states have (on average 1.5) internal successors, (3), 1 states have internal predecessors, (3), 1 states have call successors, (1), 1 states have call predecessors, (1), 1 states have return successors, (1), 1 states have call predecessors, (1), 1 states have call successors, (1)
[2025-04-28 21:21:53,577 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:53,579 INFO  L93              Difference]: Finished difference Result 100 states and 134 transitions.
[2025-04-28 21:21:53,580 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 2 states. 
[2025-04-28 21:21:53,582 INFO  L79                 Accepts]: Start accepts. Automaton has  has 2 states, 2 states have (on average 1.5) internal successors, (3), 1 states have internal predecessors, (3), 1 states have call successors, (1), 1 states have call predecessors, (1), 1 states have return successors, (1), 1 states have call predecessors, (1), 1 states have call successors, (1) Word has length 5
[2025-04-28 21:21:53,582 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:53,591 INFO  L225             Difference]: With dead ends: 100
[2025-04-28 21:21:53,592 INFO  L226             Difference]: Without dead ends: 100
[2025-04-28 21:21:53,595 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:53,601 INFO  L437           NwaCegarLoop]: 134 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, 134 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:53,602 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [0 Valid, 134 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:53,618 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 100 states.
[2025-04-28 21:21:53,665 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 100 to 100.
[2025-04-28 21:21:53,668 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 100 states, 35 states have (on average 1.1428571428571428) internal successors, (40), 40 states have internal predecessors, (40), 47 states have call successors, (47), 17 states have call predecessors, (47), 17 states have return successors, (47), 43 states have call predecessors, (47), 47 states have call successors, (47)
[2025-04-28 21:21:53,679 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 100 states to 100 states and 134 transitions.
[2025-04-28 21:21:53,682 INFO  L79                 Accepts]: Start accepts. Automaton has 100 states and 134 transitions. Word has length 5
[2025-04-28 21:21:53,682 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:53,682 INFO  L485      AbstractCegarLoop]: Abstraction has 100 states and 134 transitions.
[2025-04-28 21:21:53,683 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 2 states, 2 states have (on average 1.5) internal successors, (3), 1 states have internal predecessors, (3), 1 states have call successors, (1), 1 states have call predecessors, (1), 1 states have return successors, (1), 1 states have call predecessors, (1), 1 states have call successors, (1)
[2025-04-28 21:21:53,683 INFO  L278                IsEmpty]: Start isEmpty. Operand 100 states and 134 transitions.
[2025-04-28 21:21:53,684 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 18
[2025-04-28 21:21:53,684 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:53,685 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:53,685 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-04-28 21:21:53,685 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:53,686 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:53,686 INFO  L85        PathProgramCache]: Analyzing trace with hash 1075918218, now seen corresponding path program 1 times
[2025-04-28 21:21:53,686 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:53,686 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [73793285]
[2025-04-28 21:21:53,686 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:53,686 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:53,701 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 17 statements into 1 equivalence classes.
[2025-04-28 21:21:53,728 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 17 of 17 statements.
[2025-04-28 21:21:53,728 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:53,729 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:54,241 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-04-28 21:21:54,241 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:54,241 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [73793285]
[2025-04-28 21:21:54,242 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [73793285] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:54,242 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-04-28 21:21:54,242 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [7] imperfect sequences [] total 7
[2025-04-28 21:21:54,242 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2007948146]
[2025-04-28 21:21:54,242 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:54,243 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 7 states
[2025-04-28 21:21:54,244 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:54,244 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 7 interpolants.
[2025-04-28 21:21:54,245 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=12, Invalid=30, Unknown=0, NotChecked=0, Total=42
[2025-04-28 21:21:54,245 INFO  L87              Difference]: Start difference. First operand 100 states and 134 transitions. Second operand  has 7 states, 5 states have (on average 1.8) internal successors, (9), 7 states have internal predecessors, (9), 3 states have call successors, (4), 1 states have call predecessors, (4), 4 states have return successors, (4), 3 states have call predecessors, (4), 3 states have call successors, (4)
[2025-04-28 21:21:54,427 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:54,428 INFO  L93              Difference]: Finished difference Result 106 states and 147 transitions.
[2025-04-28 21:21:54,428 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 7 states. 
[2025-04-28 21:21:54,429 INFO  L79                 Accepts]: Start accepts. Automaton has  has 7 states, 5 states have (on average 1.8) internal successors, (9), 7 states have internal predecessors, (9), 3 states have call successors, (4), 1 states have call predecessors, (4), 4 states have return successors, (4), 3 states have call predecessors, (4), 3 states have call successors, (4) Word has length 17
[2025-04-28 21:21:54,429 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:54,432 INFO  L225             Difference]: With dead ends: 106
[2025-04-28 21:21:54,432 INFO  L226             Difference]: Without dead ends: 106
[2025-04-28 21:21:54,432 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 7 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 5 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 1 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=12, Invalid=30, Unknown=0, NotChecked=0, Total=42
[2025-04-28 21:21:54,433 INFO  L437           NwaCegarLoop]: 124 mSDtfsCounter, 2 mSDsluCounter, 477 mSDsCounter, 0 mSdLazyCounter, 65 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 4 SdHoareTripleChecker+Valid, 601 SdHoareTripleChecker+Invalid, 65 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 65 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:54,434 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [4 Valid, 601 Invalid, 65 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 65 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-04-28 21:21:54,435 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 106 states.
[2025-04-28 21:21:54,462 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 106 to 106.
[2025-04-28 21:21:54,463 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 106 states, 38 states have (on average 1.131578947368421) internal successors, (43), 43 states have internal predecessors, (43), 47 states have call successors, (47), 17 states have call predecessors, (47), 20 states have return successors, (57), 45 states have call predecessors, (57), 47 states have call successors, (57)
[2025-04-28 21:21:54,472 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 106 states to 106 states and 147 transitions.
[2025-04-28 21:21:54,472 INFO  L79                 Accepts]: Start accepts. Automaton has 106 states and 147 transitions. Word has length 17
[2025-04-28 21:21:54,472 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:54,472 INFO  L485      AbstractCegarLoop]: Abstraction has 106 states and 147 transitions.
[2025-04-28 21:21:54,473 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 7 states, 5 states have (on average 1.8) internal successors, (9), 7 states have internal predecessors, (9), 3 states have call successors, (4), 1 states have call predecessors, (4), 4 states have return successors, (4), 3 states have call predecessors, (4), 3 states have call successors, (4)
[2025-04-28 21:21:54,473 INFO  L278                IsEmpty]: Start isEmpty. Operand 106 states and 147 transitions.
[2025-04-28 21:21:54,479 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 50
[2025-04-28 21:21:54,480 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:54,481 INFO  L218           NwaCegarLoop]: trace histogram [4, 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:54,481 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2
[2025-04-28 21:21:54,481 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:54,482 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:54,483 INFO  L85        PathProgramCache]: Analyzing trace with hash -106628069, now seen corresponding path program 1 times
[2025-04-28 21:21:54,483 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:54,484 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1871235835]
[2025-04-28 21:21:54,484 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:54,484 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:54,505 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 49 statements into 1 equivalence classes.
[2025-04-28 21:21:54,570 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 49 of 49 statements.
[2025-04-28 21:21:54,570 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:54,570 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:55,048 INFO  L134       CoverageAnalysis]: Checked inductivity of 34 backedges. 12 proven. 6 refuted. 0 times theorem prover too weak. 16 trivial. 0 not checked.
[2025-04-28 21:21:55,049 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:55,049 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1871235835]
[2025-04-28 21:21:55,049 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1871235835] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:55,049 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [411170764]
[2025-04-28 21:21:55,051 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:55,051 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:55,057 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:55,062 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:55,064 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-04-28 21:21:55,144 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 49 statements into 1 equivalence classes.
[2025-04-28 21:21:55,203 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 49 of 49 statements.
[2025-04-28 21:21:55,203 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:55,203 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:55,209 INFO  L256         TraceCheckSpWp]: Trace formula consists of 183 conjuncts, 20 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:55,218 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:55,460 INFO  L134       CoverageAnalysis]: Checked inductivity of 34 backedges. 10 proven. 8 refuted. 0 times theorem prover too weak. 16 trivial. 0 not checked.
[2025-04-28 21:21:55,460 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:57,081 INFO  L134       CoverageAnalysis]: Checked inductivity of 34 backedges. 12 proven. 6 refuted. 0 times theorem prover too weak. 16 trivial. 0 not checked.
[2025-04-28 21:21:57,082 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [411170764] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:57,082 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:57,082 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [9, 9, 9] total 13
[2025-04-28 21:21:57,082 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1303717404]
[2025-04-28 21:21:57,082 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:57,084 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 13 states
[2025-04-28 21:21:57,084 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:57,085 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 13 interpolants.
[2025-04-28 21:21:57,086 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=31, Invalid=125, Unknown=0, NotChecked=0, Total=156
[2025-04-28 21:21:57,086 INFO  L87              Difference]: Start difference. First operand 106 states and 147 transitions. Second operand  has 13 states, 7 states have (on average 3.5714285714285716) internal successors, (25), 13 states have internal predecessors, (25), 8 states have call successors, (13), 1 states have call predecessors, (13), 7 states have return successors, (15), 5 states have call predecessors, (15), 8 states have call successors, (15)
[2025-04-28 21:21:57,424 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:57,426 INFO  L93              Difference]: Finished difference Result 108 states and 149 transitions.
[2025-04-28 21:21:57,426 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 9 states. 
[2025-04-28 21:21:57,427 INFO  L79                 Accepts]: Start accepts. Automaton has  has 13 states, 7 states have (on average 3.5714285714285716) internal successors, (25), 13 states have internal predecessors, (25), 8 states have call successors, (13), 1 states have call predecessors, (13), 7 states have return successors, (15), 5 states have call predecessors, (15), 8 states have call successors, (15) Word has length 49
[2025-04-28 21:21:57,428 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:57,430 INFO  L225             Difference]: With dead ends: 108
[2025-04-28 21:21:57,433 INFO  L226             Difference]: Without dead ends: 108
[2025-04-28 21:21:57,434 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 108 GetRequests, 94 SyntacticMatches, 2 SemanticMatches, 12 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 27 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=37, Invalid=145, Unknown=0, NotChecked=0, Total=182
[2025-04-28 21:21:57,435 INFO  L437           NwaCegarLoop]: 128 mSDtfsCounter, 4 mSDsluCounter, 841 mSDsCounter, 0 mSdLazyCounter, 183 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 8 SdHoareTripleChecker+Valid, 969 SdHoareTripleChecker+Invalid, 185 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 183 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:57,437 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [8 Valid, 969 Invalid, 185 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 183 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:57,438 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 108 states.
[2025-04-28 21:21:57,459 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 108 to 102.
[2025-04-28 21:21:57,461 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 102 states, 36 states have (on average 1.1388888888888888) internal successors, (41), 41 states have internal predecessors, (41), 47 states have call successors, (47), 17 states have call predecessors, (47), 18 states have return successors, (48), 44 states have call predecessors, (48), 47 states have call successors, (48)
[2025-04-28 21:21:57,465 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 102 states to 102 states and 136 transitions.
[2025-04-28 21:21:57,468 INFO  L79                 Accepts]: Start accepts. Automaton has 102 states and 136 transitions. Word has length 49
[2025-04-28 21:21:57,469 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:57,469 INFO  L485      AbstractCegarLoop]: Abstraction has 102 states and 136 transitions.
[2025-04-28 21:21:57,469 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 13 states, 7 states have (on average 3.5714285714285716) internal successors, (25), 13 states have internal predecessors, (25), 8 states have call successors, (13), 1 states have call predecessors, (13), 7 states have return successors, (15), 5 states have call predecessors, (15), 8 states have call successors, (15)
[2025-04-28 21:21:57,469 INFO  L278                IsEmpty]: Start isEmpty. Operand 102 states and 136 transitions.
[2025-04-28 21:21:57,472 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 86
[2025-04-28 21:21:57,474 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:57,474 INFO  L218           NwaCegarLoop]: trace histogram [6, 6, 4, 4, 4, 4, 3, 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, 1, 1, 1, 1, 1]
[2025-04-28 21:21:57,481 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-04-28 21:21:57,675 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3,2 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:57,675 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:57,676 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:57,676 INFO  L85        PathProgramCache]: Analyzing trace with hash -657140890, now seen corresponding path program 1 times
[2025-04-28 21:21:57,676 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:57,676 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1993719808]
[2025-04-28 21:21:57,676 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:57,676 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:57,691 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 85 statements into 1 equivalence classes.
[2025-04-28 21:21:57,719 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 85 of 85 statements.
[2025-04-28 21:21:57,720 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:57,720 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:58,294 INFO  L134       CoverageAnalysis]: Checked inductivity of 88 backedges. 4 proven. 10 refuted. 0 times theorem prover too weak. 74 trivial. 0 not checked.
[2025-04-28 21:21:58,294 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:58,294 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1993719808]
[2025-04-28 21:21:58,294 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1993719808] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:58,294 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1345376618]
[2025-04-28 21:21:58,295 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:58,295 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:58,297 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:58,299 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:58,303 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-04-28 21:21:58,382 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 85 statements into 1 equivalence classes.
[2025-04-28 21:21:58,447 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 85 of 85 statements.
[2025-04-28 21:21:58,447 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:58,447 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:58,450 INFO  L256         TraceCheckSpWp]: Trace formula consists of 322 conjuncts, 26 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:58,456 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:58,603 INFO  L134       CoverageAnalysis]: Checked inductivity of 88 backedges. 4 proven. 10 refuted. 0 times theorem prover too weak. 74 trivial. 0 not checked.
[2025-04-28 21:21:58,604 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:22:00,734 INFO  L134       CoverageAnalysis]: Checked inductivity of 88 backedges. 4 proven. 10 refuted. 0 times theorem prover too weak. 74 trivial. 0 not checked.
[2025-04-28 21:22:00,734 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1345376618] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:22:00,734 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:22:00,735 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [11, 11, 11] total 15
[2025-04-28 21:22:00,735 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [25406124]
[2025-04-28 21:22:00,735 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:22:00,735 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 15 states
[2025-04-28 21:22:00,736 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:22:00,736 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 15 interpolants.
[2025-04-28 21:22:00,736 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=35, Invalid=175, Unknown=0, NotChecked=0, Total=210
[2025-04-28 21:22:00,737 INFO  L87              Difference]: Start difference. First operand 102 states and 136 transitions. Second operand  has 15 states, 8 states have (on average 3.5) internal successors, (28), 15 states have internal predecessors, (28), 10 states have call successors, (17), 1 states have call predecessors, (17), 8 states have return successors, (18), 6 states have call predecessors, (18), 10 states have call successors, (18)
[2025-04-28 21:22:01,048 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:22:01,049 INFO  L93              Difference]: Finished difference Result 117 states and 170 transitions.
[2025-04-28 21:22:01,049 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 11 states. 
[2025-04-28 21:22:01,049 INFO  L79                 Accepts]: Start accepts. Automaton has  has 15 states, 8 states have (on average 3.5) internal successors, (28), 15 states have internal predecessors, (28), 10 states have call successors, (17), 1 states have call predecessors, (17), 8 states have return successors, (18), 6 states have call predecessors, (18), 10 states have call successors, (18) Word has length 85
[2025-04-28 21:22:01,050 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:22:01,055 INFO  L225             Difference]: With dead ends: 117
[2025-04-28 21:22:01,055 INFO  L226             Difference]: Without dead ends: 117
[2025-04-28 21:22:01,056 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 183 GetRequests, 166 SyntacticMatches, 2 SemanticMatches, 15 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 28 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=45, Invalid=227, Unknown=0, NotChecked=0, Total=272
[2025-04-28 21:22:01,057 INFO  L437           NwaCegarLoop]: 118 mSDtfsCounter, 8 mSDsluCounter, 793 mSDsCounter, 0 mSdLazyCounter, 204 mSolverCounterSat, 9 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 18 SdHoareTripleChecker+Valid, 911 SdHoareTripleChecker+Invalid, 213 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 9 IncrementalHoareTripleChecker+Valid, 204 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:22:01,059 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [18 Valid, 911 Invalid, 213 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [9 Valid, 204 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:22:01,060 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 117 states.
[2025-04-28 21:22:01,082 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 117 to 113.
[2025-04-28 21:22:01,083 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 113 states, 40 states have (on average 1.125) internal successors, (45), 45 states have internal predecessors, (45), 50 states have call successors, (50), 17 states have call predecessors, (50), 22 states have return successors, (70), 50 states have call predecessors, (70), 50 states have call successors, (70)
[2025-04-28 21:22:01,085 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 113 states to 113 states and 165 transitions.
[2025-04-28 21:22:01,087 INFO  L79                 Accepts]: Start accepts. Automaton has 113 states and 165 transitions. Word has length 85
[2025-04-28 21:22:01,088 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:22:01,089 INFO  L485      AbstractCegarLoop]: Abstraction has 113 states and 165 transitions.
[2025-04-28 21:22:01,090 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 15 states, 8 states have (on average 3.5) internal successors, (28), 15 states have internal predecessors, (28), 10 states have call successors, (17), 1 states have call predecessors, (17), 8 states have return successors, (18), 6 states have call predecessors, (18), 10 states have call successors, (18)
[2025-04-28 21:22:01,090 INFO  L278                IsEmpty]: Start isEmpty. Operand 113 states and 165 transitions.
[2025-04-28 21:22:01,097 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 118
[2025-04-28 21:22:01,097 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:22:01,097 INFO  L218           NwaCegarLoop]: trace histogram [9, 8, 6, 6, 6, 6, 4, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:22:01,103 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Ended with exit code 0
[2025-04-28 21:22:01,302 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable4,3 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:01,302 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:22:01,302 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:22:01,303 INFO  L85        PathProgramCache]: Analyzing trace with hash -1864832521, now seen corresponding path program 1 times
[2025-04-28 21:22:01,303 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:22:01,303 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1200333729]
[2025-04-28 21:22:01,303 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:22:01,304 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:22:01,320 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 117 statements into 1 equivalence classes.
[2025-04-28 21:22:01,362 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 117 of 117 statements.
[2025-04-28 21:22:01,364 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:01,364 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:01,683 INFO  L134       CoverageAnalysis]: Checked inductivity of 216 backedges. 23 proven. 41 refuted. 0 times theorem prover too weak. 152 trivial. 0 not checked.
[2025-04-28 21:22:01,683 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:22:01,683 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1200333729]
[2025-04-28 21:22:01,684 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1200333729] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:22:01,684 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1110369850]
[2025-04-28 21:22:01,684 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:22:01,684 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:01,686 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:22:01,688 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:22:01,693 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-04-28 21:22:01,784 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 117 statements into 1 equivalence classes.
[2025-04-28 21:22:01,857 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 117 of 117 statements.
[2025-04-28 21:22:01,857 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:01,857 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:01,861 INFO  L256         TraceCheckSpWp]: Trace formula consists of 446 conjuncts, 12 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:01,865 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:01,923 INFO  L134       CoverageAnalysis]: Checked inductivity of 216 backedges. 132 proven. 16 refuted. 0 times theorem prover too weak. 68 trivial. 0 not checked.
[2025-04-28 21:22:01,923 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:22:03,935 INFO  L134       CoverageAnalysis]: Checked inductivity of 216 backedges. 23 proven. 41 refuted. 0 times theorem prover too weak. 152 trivial. 0 not checked.
[2025-04-28 21:22:03,935 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1110369850] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:22:03,935 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:22:03,935 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [9, 8, 9] total 11
[2025-04-28 21:22:03,935 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2112567641]
[2025-04-28 21:22:03,935 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:22:03,936 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 11 states
[2025-04-28 21:22:03,936 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:22:03,939 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 11 interpolants.
[2025-04-28 21:22:03,939 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=24, Invalid=86, Unknown=0, NotChecked=0, Total=110
[2025-04-28 21:22:03,939 INFO  L87              Difference]: Start difference. First operand 113 states and 165 transitions. Second operand  has 11 states, 8 states have (on average 5.125) internal successors, (41), 10 states have internal predecessors, (41), 7 states have call successors, (25), 2 states have call predecessors, (25), 8 states have return successors, (29), 6 states have call predecessors, (29), 7 states have call successors, (29)
[2025-04-28 21:22:04,241 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:22:04,241 INFO  L93              Difference]: Finished difference Result 118 states and 178 transitions.
[2025-04-28 21:22:04,242 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-04-28 21:22:04,242 INFO  L79                 Accepts]: Start accepts. Automaton has  has 11 states, 8 states have (on average 5.125) internal successors, (41), 10 states have internal predecessors, (41), 7 states have call successors, (25), 2 states have call predecessors, (25), 8 states have return successors, (29), 6 states have call predecessors, (29), 7 states have call successors, (29) Word has length 117
[2025-04-28 21:22:04,243 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:22:04,244 INFO  L225             Difference]: With dead ends: 118
[2025-04-28 21:22:04,244 INFO  L226             Difference]: Without dead ends: 118
[2025-04-28 21:22:04,245 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 244 GetRequests, 228 SyntacticMatches, 6 SemanticMatches, 10 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 19 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=30, Invalid=102, Unknown=0, NotChecked=0, Total=132
[2025-04-28 21:22:04,245 INFO  L437           NwaCegarLoop]: 125 mSDtfsCounter, 2 mSDsluCounter, 1044 mSDsCounter, 0 mSdLazyCounter, 323 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 5 SdHoareTripleChecker+Valid, 1169 SdHoareTripleChecker+Invalid, 325 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 323 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.3s IncrementalHoareTripleChecker+Time
[2025-04-28 21:22:04,246 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [5 Valid, 1169 Invalid, 325 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 323 Invalid, 0 Unknown, 0 Unchecked, 0.3s Time]
[2025-04-28 21:22:04,247 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 118 states.
[2025-04-28 21:22:04,258 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 118 to 118.
[2025-04-28 21:22:04,259 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 118 states, 42 states have (on average 1.119047619047619) internal successors, (47), 47 states have internal predecessors, (47), 51 states have call successors, (51), 17 states have call predecessors, (51), 24 states have return successors, (80), 53 states have call predecessors, (80), 51 states have call successors, (80)
[2025-04-28 21:22:04,261 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 118 states to 118 states and 178 transitions.
[2025-04-28 21:22:04,261 INFO  L79                 Accepts]: Start accepts. Automaton has 118 states and 178 transitions. Word has length 117
[2025-04-28 21:22:04,261 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:22:04,261 INFO  L485      AbstractCegarLoop]: Abstraction has 118 states and 178 transitions.
[2025-04-28 21:22:04,261 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 11 states, 8 states have (on average 5.125) internal successors, (41), 10 states have internal predecessors, (41), 7 states have call successors, (25), 2 states have call predecessors, (25), 8 states have return successors, (29), 6 states have call predecessors, (29), 7 states have call successors, (29)
[2025-04-28 21:22:04,262 INFO  L278                IsEmpty]: Start isEmpty. Operand 118 states and 178 transitions.
[2025-04-28 21:22:04,264 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 150
[2025-04-28 21:22:04,264 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:22:04,264 INFO  L218           NwaCegarLoop]: trace histogram [12, 10, 8, 8, 8, 8, 5, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:22:04,271 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Ended with exit code 0
[2025-04-28 21:22:04,464 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable5,4 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:04,465 INFO  L403      AbstractCegarLoop]: === Iteration 6 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:22:04,465 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:22:04,465 INFO  L85        PathProgramCache]: Analyzing trace with hash 1613884808, now seen corresponding path program 2 times
[2025-04-28 21:22:04,465 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:22:04,465 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [173722389]
[2025-04-28 21:22:04,466 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:22:04,466 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:22:04,480 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 149 statements into 2 equivalence classes.
[2025-04-28 21:22:04,533 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 149 of 149 statements.
[2025-04-28 21:22:04,533 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:22:04,534 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:04,958 INFO  L134       CoverageAnalysis]: Checked inductivity of 402 backedges. 48 proven. 54 refuted. 0 times theorem prover too weak. 300 trivial. 0 not checked.
[2025-04-28 21:22:04,959 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:22:04,959 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [173722389]
[2025-04-28 21:22:04,959 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [173722389] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:22:04,959 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1903944852]
[2025-04-28 21:22:04,959 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-04-28 21:22:04,959 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:04,962 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:22:04,964 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:04,967 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Waiting until timeout for monitored process
[2025-04-28 21:22:05,080 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 149 statements into 2 equivalence classes.
[2025-04-28 21:22:05,161 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 149 of 149 statements.
[2025-04-28 21:22:05,161 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-04-28 21:22:05,161 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:05,164 INFO  L256         TraceCheckSpWp]: Trace formula consists of 570 conjuncts, 17 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:05,169 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:05,291 INFO  L134       CoverageAnalysis]: Checked inductivity of 402 backedges. 93 proven. 34 refuted. 0 times theorem prover too weak. 275 trivial. 0 not checked.
[2025-04-28 21:22:05,291 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:22:08,421 INFO  L134       CoverageAnalysis]: Checked inductivity of 402 backedges. 62 proven. 40 refuted. 0 times theorem prover too weak. 300 trivial. 0 not checked.
[2025-04-28 21:22:08,421 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1903944852] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:22:08,421 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:22:08,421 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [11, 13, 14] total 17
[2025-04-28 21:22:08,421 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1127853981]
[2025-04-28 21:22:08,421 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:22:08,422 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 17 states
[2025-04-28 21:22:08,422 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:22:08,423 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 17 interpolants.
[2025-04-28 21:22:08,423 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=38, Invalid=234, Unknown=0, NotChecked=0, Total=272
[2025-04-28 21:22:08,423 INFO  L87              Difference]: Start difference. First operand 118 states and 178 transitions. Second operand  has 17 states, 12 states have (on average 3.4166666666666665) internal successors, (41), 16 states have internal predecessors, (41), 9 states have call successors, (23), 2 states have call predecessors, (23), 12 states have return successors, (31), 10 states have call predecessors, (31), 9 states have call successors, (31)
[2025-04-28 21:22:08,991 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:22:08,991 INFO  L93              Difference]: Finished difference Result 148 states and 237 transitions.
[2025-04-28 21:22:08,992 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 17 states. 
[2025-04-28 21:22:08,992 INFO  L79                 Accepts]: Start accepts. Automaton has  has 17 states, 12 states have (on average 3.4166666666666665) internal successors, (41), 16 states have internal predecessors, (41), 9 states have call successors, (23), 2 states have call predecessors, (23), 12 states have return successors, (31), 10 states have call predecessors, (31), 9 states have call successors, (31) Word has length 149
[2025-04-28 21:22:08,993 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:22:08,999 INFO  L225             Difference]: With dead ends: 148
[2025-04-28 21:22:08,999 INFO  L226             Difference]: Without dead ends: 147
[2025-04-28 21:22:08,999 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 311 GetRequests, 283 SyntacticMatches, 10 SemanticMatches, 18 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 44 ImplicationChecksByTransitivity, 0.3s TimeCoverageRelationStatistics Valid=54, Invalid=326, Unknown=0, NotChecked=0, Total=380
[2025-04-28 21:22:09,000 INFO  L437           NwaCegarLoop]: 136 mSDtfsCounter, 9 mSDsluCounter, 1640 mSDsCounter, 0 mSdLazyCounter, 676 mSolverCounterSat, 14 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 15 SdHoareTripleChecker+Valid, 1776 SdHoareTripleChecker+Invalid, 690 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 14 IncrementalHoareTripleChecker+Valid, 676 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:22:09,002 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [15 Valid, 1776 Invalid, 690 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [14 Valid, 676 Invalid, 0 Unknown, 0 Unchecked, 0.5s Time]
[2025-04-28 21:22:09,003 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 147 states.
[2025-04-28 21:22:09,035 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 147 to 138.
[2025-04-28 21:22:09,036 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 138 states, 51 states have (on average 1.1176470588235294) internal successors, (57), 55 states have internal predecessors, (57), 58 states have call successors, (58), 22 states have call predecessors, (58), 28 states have return successors, (94), 60 states have call predecessors, (94), 58 states have call successors, (94)
[2025-04-28 21:22:09,041 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 138 states to 138 states and 209 transitions.
[2025-04-28 21:22:09,042 INFO  L79                 Accepts]: Start accepts. Automaton has 138 states and 209 transitions. Word has length 149
[2025-04-28 21:22:09,042 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:22:09,042 INFO  L485      AbstractCegarLoop]: Abstraction has 138 states and 209 transitions.
[2025-04-28 21:22:09,042 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 17 states, 12 states have (on average 3.4166666666666665) internal successors, (41), 16 states have internal predecessors, (41), 9 states have call successors, (23), 2 states have call predecessors, (23), 12 states have return successors, (31), 10 states have call predecessors, (31), 9 states have call successors, (31)
[2025-04-28 21:22:09,046 INFO  L278                IsEmpty]: Start isEmpty. Operand 138 states and 209 transitions.
[2025-04-28 21:22:09,050 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 278
[2025-04-28 21:22:09,050 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:22:09,053 INFO  L218           NwaCegarLoop]: trace histogram [24, 18, 16, 16, 16, 16, 9, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 6, 6, 6, 6, 6, 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:22:09,063 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Forceful destruction successful, exit code 0
[2025-04-28 21:22:09,254 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable6,5 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:09,254 INFO  L403      AbstractCegarLoop]: === Iteration 7 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:22:09,255 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:22:09,255 INFO  L85        PathProgramCache]: Analyzing trace with hash 2123335116, now seen corresponding path program 3 times
[2025-04-28 21:22:09,255 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:22:09,255 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [811157118]
[2025-04-28 21:22:09,255 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:22:09,255 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:22:09,295 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 277 statements into 19 equivalence classes.
[2025-04-28 21:22:09,326 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 5 check-sat command(s) and asserted 67 of 277 statements.
[2025-04-28 21:22:09,326 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 5 check-sat command(s)
[2025-04-28 21:22:09,326 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:09,809 INFO  L134       CoverageAnalysis]: Checked inductivity of 1726 backedges. 184 proven. 4 refuted. 0 times theorem prover too weak. 1538 trivial. 0 not checked.
[2025-04-28 21:22:09,810 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:22:09,810 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [811157118]
[2025-04-28 21:22:09,810 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [811157118] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:22:09,810 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1694157968]
[2025-04-28 21:22:09,810 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST2
[2025-04-28 21:22:09,810 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:09,813 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:22:09,815 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:22:09,822 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (6)] Waiting until timeout for monitored process
[2025-04-28 21:22:10,020 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 partitioned 277 statements into 19 equivalence classes.
[2025-04-28 21:22:10,063 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 5 check-sat command(s) and asserted 67 of 277 statements.
[2025-04-28 21:22:10,063 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST2 issued 5 check-sat command(s)
[2025-04-28 21:22:10,063 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:10,066 INFO  L256         TraceCheckSpWp]: Trace formula consists of 242 conjuncts, 31 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:10,080 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:10,326 INFO  L134       CoverageAnalysis]: Checked inductivity of 1726 backedges. 107 proven. 0 refuted. 0 times theorem prover too weak. 1619 trivial. 0 not checked.
[2025-04-28 21:22:10,327 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-04-28 21:22:10,327 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1694157968] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:22:10,327 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-04-28 21:22:10,327 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [14] imperfect sequences [16] total 22
[2025-04-28 21:22:10,327 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1935027523]
[2025-04-28 21:22:10,327 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:22:10,328 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 14 states
[2025-04-28 21:22:10,328 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:22:10,329 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 14 interpolants.
[2025-04-28 21:22:10,329 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=48, Invalid=414, Unknown=0, NotChecked=0, Total=462
[2025-04-28 21:22:10,329 INFO  L87              Difference]: Start difference. First operand 138 states and 209 transitions. Second operand  has 14 states, 9 states have (on average 3.0) internal successors, (27), 13 states have internal predecessors, (27), 8 states have call successors, (19), 1 states have call predecessors, (19), 9 states have return successors, (20), 11 states have call predecessors, (20), 8 states have call successors, (20)
[2025-04-28 21:22:10,818 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:22:10,818 INFO  L93              Difference]: Finished difference Result 159 states and 243 transitions.
[2025-04-28 21:22:10,819 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 14 states. 
[2025-04-28 21:22:10,819 INFO  L79                 Accepts]: Start accepts. Automaton has  has 14 states, 9 states have (on average 3.0) internal successors, (27), 13 states have internal predecessors, (27), 8 states have call successors, (19), 1 states have call predecessors, (19), 9 states have return successors, (20), 11 states have call predecessors, (20), 8 states have call successors, (20) Word has length 277
[2025-04-28 21:22:10,820 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:22:10,824 INFO  L225             Difference]: With dead ends: 159
[2025-04-28 21:22:10,824 INFO  L226             Difference]: Without dead ends: 159
[2025-04-28 21:22:10,825 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 296 GetRequests, 273 SyntacticMatches, 0 SemanticMatches, 23 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 45 ImplicationChecksByTransitivity, 0.3s TimeCoverageRelationStatistics Valid=62, Invalid=538, Unknown=0, NotChecked=0, Total=600
[2025-04-28 21:22:10,825 INFO  L437           NwaCegarLoop]: 120 mSDtfsCounter, 4 mSDsluCounter, 1354 mSDsCounter, 0 mSdLazyCounter, 465 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 9 SdHoareTripleChecker+Valid, 1474 SdHoareTripleChecker+Invalid, 466 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 465 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.4s IncrementalHoareTripleChecker+Time
[2025-04-28 21:22:10,826 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [9 Valid, 1474 Invalid, 466 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 465 Invalid, 0 Unknown, 0 Unchecked, 0.4s Time]
[2025-04-28 21:22:10,827 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 159 states.
[2025-04-28 21:22:10,841 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 159 to 142.
[2025-04-28 21:22:10,842 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 142 states, 52 states have (on average 1.1153846153846154) internal successors, (58), 56 states have internal predecessors, (58), 60 states have call successors, (60), 22 states have call predecessors, (60), 29 states have return successors, (98), 63 states have call predecessors, (98), 60 states have call successors, (98)
[2025-04-28 21:22:10,844 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 142 states to 142 states and 216 transitions.
[2025-04-28 21:22:10,844 INFO  L79                 Accepts]: Start accepts. Automaton has 142 states and 216 transitions. Word has length 277
[2025-04-28 21:22:10,845 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:22:10,845 INFO  L485      AbstractCegarLoop]: Abstraction has 142 states and 216 transitions.
[2025-04-28 21:22:10,846 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 14 states, 9 states have (on average 3.0) internal successors, (27), 13 states have internal predecessors, (27), 8 states have call successors, (19), 1 states have call predecessors, (19), 9 states have return successors, (20), 11 states have call predecessors, (20), 8 states have call successors, (20)
[2025-04-28 21:22:10,846 INFO  L278                IsEmpty]: Start isEmpty. Operand 142 states and 216 transitions.
[2025-04-28 21:22:10,908 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 1162
[2025-04-28 21:22:10,908 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:22:10,908 INFO  L218           NwaCegarLoop]: trace histogram [98, 80, 66, 66, 66, 66, 35, 34, 34, 34, 34, 34, 34, 34, 32, 32, 32, 32, 32, 32, 18, 18, 18, 18, 18, 7, 7, 7, 7, 7, 7, 6, 5, 5, 5, 4, 4, 4, 4, 4, 4, 4, 4, 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:22:10,916 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (6)] Ended with exit code 0
[2025-04-28 21:22:11,109 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable7,6 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:11,109 INFO  L403      AbstractCegarLoop]: === Iteration 8 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:22:11,110 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:22:11,110 INFO  L85        PathProgramCache]: Analyzing trace with hash 1699586185, now seen corresponding path program 1 times
[2025-04-28 21:22:11,110 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:22:11,110 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [16455113]
[2025-04-28 21:22:11,110 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:22:11,110 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:22:11,195 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 1161 statements into 1 equivalence classes.
[2025-04-28 21:22:11,617 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 1161 of 1161 statements.
[2025-04-28 21:22:11,618 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:11,618 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:15,292 INFO  L134       CoverageAnalysis]: Checked inductivity of 30423 backedges. 165 proven. 589 refuted. 0 times theorem prover too weak. 29669 trivial. 0 not checked.
[2025-04-28 21:22:15,292 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:22:15,292 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [16455113]
[2025-04-28 21:22:15,292 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [16455113] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:22:15,292 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1108515785]
[2025-04-28 21:22:15,292 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:22:15,293 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:22:15,295 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:22:15,297 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:22:15,300 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (7)] Waiting until timeout for monitored process
[2025-04-28 21:22:15,718 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 1161 statements into 1 equivalence classes.
[2025-04-28 21:22:16,373 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 1161 of 1161 statements.
[2025-04-28 21:22:16,373 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:22:16,373 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:22:16,389 INFO  L256         TraceCheckSpWp]: Trace formula consists of 4498 conjuncts, 17 conjuncts are in the unsatisfiable core
[2025-04-28 21:22:16,429 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:22:16,600 INFO  L134       CoverageAnalysis]: Checked inductivity of 30423 backedges. 15508 proven. 251 refuted. 0 times theorem prover too weak. 14664 trivial. 0 not checked.
[2025-04-28 21:22:16,600 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
