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


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-04-28 21:21:30,167 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-04-28 21:21:30,275 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_af519ed7-46f9-4557-b7a4-638709c62c08/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-04-28 21:21:30,281 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-04-28 21:21:30,282 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-04-28 21:21:30,321 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-04-28 21:21:30,322 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-04-28 21:21:30,322 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-04-28 21:21:30,324 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-04-28 21:21:30,324 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-04-28 21:21:30,324 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-04-28 21:21:30,325 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-04-28 21:21:30,325 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-04-28 21:21:30,325 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-04-28 21:21:30,326 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-04-28 21:21:30,327 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-04-28 21:21:30,327 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-04-28 21:21:30,327 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-04-28 21:21:30,327 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:30,327 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-04-28 21:21:30,327 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-04-28 21:21:30,327 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-04-28 21:21:30,328 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-04-28 21:21:30,328 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-04-28 21:21:30,328 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-04-28 21:21:30,329 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-04-28 21:21:30,329 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-04-28 21:21:30,694 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-04-28 21:21:30,705 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-04-28 21:21:30,708 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-04-28 21:21:30,710 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-04-28 21:21:30,711 INFO  L274        PluginConnector]: SmtParser initialized
[2025-04-28 21:21:30,713 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_af519ed7-46f9-4557-b7a4-638709c62c08/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-124.smt2
[2025-04-28 21:21:30,716 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-04-28 21:21:30,720 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-04-28 21:21:31,115 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_af519ed7-46f9-4557-b7a4-638709c62c08/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp24-benchmarks/LIA/chc-comp24-LIA-124.smt2
[2025-04-28 21:21:31,119 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-04-28 21:21:31,120 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-04-28 21:21:31,121 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-04-28 21:21:31,121 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-04-28 21:21:31,121 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-04-28 21:21:31,124 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,181 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31 Unit
[2025-04-28 21:21:31,181 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-04-28 21:21:31,182 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-04-28 21:21:31,182 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-04-28 21:21:31,182 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-04-28 21:21:31,198 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,199 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,231 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,232 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,246 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,248 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,251 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,253 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,254 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,274 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-04-28 21:21:31,275 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-04-28 21:21:31,275 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-04-28 21:21:31,275 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-04-28 21:21:31,276 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (1/1) ...
[2025-04-28 21:21:31,279 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-04-28 21:21:31,292 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:31,306 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:31,314 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:31,329 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-04-28 21:21:31,329 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-04-28 21:21:31,329 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-04-28 21:21:31,329 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN28 given in one single declaration
[2025-04-28 21:21:31,329 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN28
[2025-04-28 21:21:31,330 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN28
[2025-04-28 21:21:31,330 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure print_string.DLRunknown.CLN66 given in one single declaration
[2025-04-28 21:21:31,330 INFO  L130     BoogieDeclarations]: Found specification of procedure print_string.DLRunknown.CLN66
[2025-04-28 21:21:31,330 INFO  L138     BoogieDeclarations]: Found implementation of procedure print_string.DLRunknown.CLN66
[2025-04-28 21:21:31,330 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN3.DSHdotsPrint.DLRunknown.CLN22 given in one single declaration
[2025-04-28 21:21:31,330 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN3.DSHdotsPrint.DLRunknown.CLN22
[2025-04-28 21:21:31,330 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN3.DSHdotsPrint.DLRunknown.CLN22
[2025-04-28 21:21:31,330 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN30 given in one single declaration
[2025-04-28 21:21:31,330 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN30
[2025-04-28 21:21:31,330 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN30
[2025-04-28 21:21:31,330 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN8.DSHloop.DLRunknown.CLN55 given in one single declaration
[2025-04-28 21:21:31,331 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN8.DSHloop.DLRunknown.CLN55
[2025-04-28 21:21:31,331 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN8.DSHloop.DLRunknown.CLN55
[2025-04-28 21:21:31,331 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure queen.DLRunknown.CLN67 given in one single declaration
[2025-04-28 21:21:31,331 INFO  L130     BoogieDeclarations]: Found specification of procedure queen.DLRunknown.CLN67
[2025-04-28 21:21:31,331 INFO  L138     BoogieDeclarations]: Found implementation of procedure queen.DLRunknown.CLN67
[2025-04-28 21:21:31,331 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN7.DSHtest.DLRunknown.CLN51 given in one single declaration
[2025-04-28 21:21:31,331 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN7.DSHtest.DLRunknown.CLN51
[2025-04-28 21:21:31,331 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN7.DSHtest.DLRunknown.CLN51
[2025-04-28 21:21:31,331 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN7.DSHtest.DLRunknown.CLN50 given in one single declaration
[2025-04-28 21:21:31,331 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN7.DSHtest.DLRunknown.CLN50
[2025-04-28 21:21:31,331 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN7.DSHtest.DLRunknown.CLN50
[2025-04-28 21:21:31,331 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN2.DSHassign.DLRunknown.CLN17 given in one single declaration
[2025-04-28 21:21:31,332 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN2.DSHassign.DLRunknown.CLN17
[2025-04-28 21:21:31,332 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN2.DSHassign.DLRunknown.CLN17
[2025-04-28 21:21:31,332 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN75 given in one single declaration
[2025-04-28 21:21:31,332 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN75
[2025-04-28 21:21:31,332 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN75
[2025-04-28 21:21:31,332 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN8 given in one single declaration
[2025-04-28 21:21:31,332 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN8
[2025-04-28 21:21:31,332 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN8
[2025-04-28 21:21:31,332 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN4 given in one single declaration
[2025-04-28 21:21:31,332 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN4
[2025-04-28 21:21:31,332 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN1.DSHa.DLRunknown.CLN4
[2025-04-28 21:21:31,333 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure update.DLRunknown.CLN72 given in one single declaration
[2025-04-28 21:21:31,333 INFO  L130     BoogieDeclarations]: Found specification of procedure update.DLRunknown.CLN72
[2025-04-28 21:21:31,333 INFO  L138     BoogieDeclarations]: Found implementation of procedure update.DLRunknown.CLN72
[2025-04-28 21:21:31,333 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN2.DSHassign.DLRunknown.CLN15 given in one single declaration
[2025-04-28 21:21:31,333 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN2.DSHassign.DLRunknown.CLN15
[2025-04-28 21:21:31,333 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN2.DSHassign.DLRunknown.CLN15
[2025-04-28 21:21:31,333 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN6.DSHaux2.DLRunknown.CLN44 given in one single declaration
[2025-04-28 21:21:31,333 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN6.DSHaux2.DLRunknown.CLN44
[2025-04-28 21:21:31,333 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN6.DSHaux2.DLRunknown.CLN44
[2025-04-28 21:21:31,333 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure abs.DLRunknown.CLN60 given in one single declaration
[2025-04-28 21:21:31,333 INFO  L130     BoogieDeclarations]: Found specification of procedure abs.DLRunknown.CLN60
[2025-04-28 21:21:31,333 INFO  L138     BoogieDeclarations]: Found implementation of procedure abs.DLRunknown.CLN60
[2025-04-28 21:21:31,334 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN6.DSHaux2.DLRunknown.CLN41 given in one single declaration
[2025-04-28 21:21:31,334 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN6.DSHaux2.DLRunknown.CLN41
[2025-04-28 21:21:31,334 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN6.DSHaux2.DLRunknown.CLN41
[2025-04-28 21:21:31,334 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN8.DSHloop.DLRunknown.CLN57 given in one single declaration
[2025-04-28 21:21:31,334 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN8.DSHloop.DLRunknown.CLN57
[2025-04-28 21:21:31,334 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN8.DSHloop.DLRunknown.CLN57
[2025-04-28 21:21:31,334 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN35 given in one single declaration
[2025-04-28 21:21:31,334 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN35
[2025-04-28 21:21:31,334 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN35
[2025-04-28 21:21:31,334 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN29 given in one single declaration
[2025-04-28 21:21:31,334 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN29
[2025-04-28 21:21:31,334 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN29
[2025-04-28 21:21:31,335 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure make_array.DLRunknown.CLN64 given in one single declaration
[2025-04-28 21:21:31,335 INFO  L130     BoogieDeclarations]: Found specification of procedure make_array.DLRunknown.CLN64
[2025-04-28 21:21:31,335 INFO  L138     BoogieDeclarations]: Found implementation of procedure make_array.DLRunknown.CLN64
[2025-04-28 21:21:31,335 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN27 given in one single declaration
[2025-04-28 21:21:31,335 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN27
[2025-04-28 21:21:31,335 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN4.DSHaux1.DLRunknown.CLN27
[2025-04-28 21:21:31,335 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN34 given in one single declaration
[2025-04-28 21:21:31,335 INFO  L130     BoogieDeclarations]: Found specification of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN34
[2025-04-28 21:21:31,335 INFO  L138     BoogieDeclarations]: Found implementation of procedure .DLRinnerFunc.CLN5.DSHqueenPrint.DLRunknown.CLN34
[2025-04-28 21:21:31,335 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-04-28 21:21:31,335 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-04-28 21:21:31,335 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-04-28 21:21:31,435 INFO  L234             CfgBuilder]: Building ICFG
[2025-04-28 21:21:31,437 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-04-28 21:21:31,901 INFO  L?                        ?]: Removed 74 outVars from TransFormulas that were not future-live.
[2025-04-28 21:21:31,901 INFO  L283             CfgBuilder]: Performing block encoding
[2025-04-28 21:21:31,928 INFO  L304             CfgBuilder]: Using library mode
[2025-04-28 21:21:31,929 INFO  L312             CfgBuilder]: Removed 2 assume(true) statements.
[2025-04-28 21:21:31,929 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:31 BoogieIcfgContainer
[2025-04-28 21:21:31,929 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-04-28 21:21:31,934 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-04-28 21:21:31,934 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-04-28 21:21:31,939 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-04-28 21:21:31,939 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 28.04 09:21:31" (1/3) ...
[2025-04-28 21:21:31,940 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@7b8735ec and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 28.04 09:21:31, skipping insertion in model container
[2025-04-28 21:21:31,940 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 28.04 09:21:31" (2/3) ...
[2025-04-28 21:21:31,940 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@7b8735ec and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 28.04 09:21:31, skipping insertion in model container
[2025-04-28 21:21:31,941 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 28.04 09:21:31" (3/3) ...
[2025-04-28 21:21:31,942 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-04-28 21:21:31,957 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-04-28 21:21:31,959 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 25 procedures, 156 locations, 311 edges, 25 initial locations, 0 loop locations, and 1 error locations.
[2025-04-28 21:21:32,013 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-04-28 21:21:32,039 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;@47c39a8a, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-04-28 21:21:32,039 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-04-28 21:21:32,043 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 156 states, 48 states have (on average 1.3541666666666667) internal successors, (65), 64 states have internal predecessors, (65), 82 states have call successors, (82), 24 states have call predecessors, (82), 24 states have return successors, (82), 71 states have call predecessors, (82), 82 states have call successors, (82)
[2025-04-28 21:21:32,055 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 6
[2025-04-28 21:21:32,055 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:32,056 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1]
[2025-04-28 21:21:32,057 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:32,063 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:32,064 INFO  L85        PathProgramCache]: Analyzing trace with hash 369116334, now seen corresponding path program 1 times
[2025-04-28 21:21:32,072 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:32,072 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [228543653]
[2025-04-28 21:21:32,073 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:32,073 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:32,102 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 5 statements into 1 equivalence classes.
[2025-04-28 21:21:32,104 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 5 of 5 statements.
[2025-04-28 21:21:32,104 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:32,105 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:32,138 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:32,139 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:32,139 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [228543653]
[2025-04-28 21:21:32,140 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [228543653] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:32,140 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-04-28 21:21:32,143 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [2] imperfect sequences [] total 2
[2025-04-28 21:21:32,145 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [486384918]
[2025-04-28 21:21:32,145 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:32,149 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 2 states
[2025-04-28 21:21:32,149 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:32,181 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 2 interpolants.
[2025-04-28 21:21:32,181 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=1, Invalid=1, Unknown=0, NotChecked=0, Total=2
[2025-04-28 21:21:32,184 INFO  L87              Difference]: Start difference. First operand  has 156 states, 48 states have (on average 1.3541666666666667) internal successors, (65), 64 states have internal predecessors, (65), 82 states have call successors, (82), 24 states have call predecessors, (82), 24 states have return successors, (82), 71 states have call predecessors, (82), 82 states have call successors, (82) 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:32,222 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:32,223 INFO  L93              Difference]: Finished difference Result 154 states and 226 transitions.
[2025-04-28 21:21:32,223 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 2 states. 
[2025-04-28 21:21:32,225 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:32,225 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:32,236 INFO  L225             Difference]: With dead ends: 154
[2025-04-28 21:21:32,236 INFO  L226             Difference]: Without dead ends: 154
[2025-04-28 21:21:32,238 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:32,241 INFO  L437           NwaCegarLoop]: 226 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, 226 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:32,242 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [0 Valid, 226 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:32,259 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 154 states.
[2025-04-28 21:21:32,322 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 154 to 154.
[2025-04-28 21:21:32,323 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 154 states, 47 states have (on average 1.3191489361702127) internal successors, (62), 61 states have internal predecessors, (62), 82 states have call successors, (82), 24 states have call predecessors, (82), 24 states have return successors, (82), 71 states have call predecessors, (82), 82 states have call successors, (82)
[2025-04-28 21:21:32,331 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 154 states to 154 states and 226 transitions.
[2025-04-28 21:21:32,332 INFO  L79                 Accepts]: Start accepts. Automaton has 154 states and 226 transitions. Word has length 5
[2025-04-28 21:21:32,332 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:32,333 INFO  L485      AbstractCegarLoop]: Abstraction has 154 states and 226 transitions.
[2025-04-28 21:21:32,333 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:32,333 INFO  L278                IsEmpty]: Start isEmpty. Operand 154 states and 226 transitions.
[2025-04-28 21:21:32,349 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 382
[2025-04-28 21:21:32,350 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:32,350 INFO  L218           NwaCegarLoop]: trace histogram [24, 24, 14, 14, 14, 14, 14, 14, 14, 14, 10, 10, 10, 10, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 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]
[2025-04-28 21:21:32,350 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-04-28 21:21:32,350 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:32,352 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:32,352 INFO  L85        PathProgramCache]: Analyzing trace with hash -1753259810, now seen corresponding path program 1 times
[2025-04-28 21:21:32,352 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:32,352 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1201036970]
[2025-04-28 21:21:32,352 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:32,353 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:32,415 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 381 statements into 1 equivalence classes.
[2025-04-28 21:21:32,806 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 381 of 381 statements.
[2025-04-28 21:21:32,806 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:32,806 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:35,268 INFO  L134       CoverageAnalysis]: Checked inductivity of 1904 backedges. 7 proven. 196 refuted. 0 times theorem prover too weak. 1701 trivial. 0 not checked.
[2025-04-28 21:21:35,268 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:35,268 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1201036970]
[2025-04-28 21:21:35,268 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1201036970] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:35,268 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [461053933]
[2025-04-28 21:21:35,269 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:35,269 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:35,272 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:35,276 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:35,279 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-04-28 21:21:35,495 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 381 statements into 1 equivalence classes.
[2025-04-28 21:21:35,800 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 381 of 381 statements.
[2025-04-28 21:21:35,800 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:35,800 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:35,808 INFO  L256         TraceCheckSpWp]: Trace formula consists of 1337 conjuncts, 18 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:35,834 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:36,215 INFO  L134       CoverageAnalysis]: Checked inductivity of 1904 backedges. 809 proven. 22 refuted. 0 times theorem prover too weak. 1073 trivial. 0 not checked.
[2025-04-28 21:21:36,216 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:44,970 INFO  L134       CoverageAnalysis]: Checked inductivity of 1904 backedges. 10 proven. 190 refuted. 0 times theorem prover too weak. 1704 trivial. 0 not checked.
[2025-04-28 21:21:44,971 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [461053933] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:44,971 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:44,971 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [17, 15, 15] total 24
[2025-04-28 21:21:44,972 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [401556210]
[2025-04-28 21:21:44,972 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:44,974 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 24 states
[2025-04-28 21:21:44,975 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:44,976 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 24 interpolants.
[2025-04-28 21:21:44,976 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=54, Invalid=498, Unknown=0, NotChecked=0, Total=552
[2025-04-28 21:21:44,977 INFO  L87              Difference]: Start difference. First operand 154 states and 226 transitions. Second operand  has 24 states, 16 states have (on average 5.4375) internal successors, (87), 23 states have internal predecessors, (87), 14 states have call successors, (71), 2 states have call predecessors, (71), 16 states have return successors, (78), 14 states have call predecessors, (78), 14 states have call successors, (78)
[2025-04-28 21:21:45,724 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:45,724 INFO  L93              Difference]: Finished difference Result 160 states and 255 transitions.
[2025-04-28 21:21:45,727 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 12 states. 
[2025-04-28 21:21:45,729 INFO  L79                 Accepts]: Start accepts. Automaton has  has 24 states, 16 states have (on average 5.4375) internal successors, (87), 23 states have internal predecessors, (87), 14 states have call successors, (71), 2 states have call predecessors, (71), 16 states have return successors, (78), 14 states have call predecessors, (78), 14 states have call successors, (78) Word has length 381
[2025-04-28 21:21:45,729 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:45,738 INFO  L225             Difference]: With dead ends: 160
[2025-04-28 21:21:45,738 INFO  L226             Difference]: Without dead ends: 160
[2025-04-28 21:21:45,738 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 784 GetRequests, 747 SyntacticMatches, 10 SemanticMatches, 27 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 58 ImplicationChecksByTransitivity, 0.7s TimeCoverageRelationStatistics Valid=90, Invalid=722, Unknown=0, NotChecked=0, Total=812
[2025-04-28 21:21:45,739 INFO  L437           NwaCegarLoop]: 208 mSDtfsCounter, 6 mSDsluCounter, 4219 mSDsCounter, 0 mSdLazyCounter, 522 mSolverCounterSat, 25 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.4s Time, 0 mProtectedPredicate, 0 mProtectedAction, 18 SdHoareTripleChecker+Valid, 4427 SdHoareTripleChecker+Invalid, 547 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 25 IncrementalHoareTripleChecker+Valid, 522 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.5s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:45,740 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [18 Valid, 4427 Invalid, 547 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [25 Valid, 522 Invalid, 0 Unknown, 0 Unchecked, 0.5s Time]
[2025-04-28 21:21:45,744 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 160 states.
[2025-04-28 21:21:45,764 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 160 to 156.
[2025-04-28 21:21:45,765 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 156 states, 48 states have (on average 1.3125) internal successors, (63), 62 states have internal predecessors, (63), 82 states have call successors, (82), 24 states have call predecessors, (82), 25 states have return successors, (94), 72 states have call predecessors, (94), 82 states have call successors, (94)
[2025-04-28 21:21:45,769 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 156 states to 156 states and 239 transitions.
[2025-04-28 21:21:45,769 INFO  L79                 Accepts]: Start accepts. Automaton has 156 states and 239 transitions. Word has length 381
[2025-04-28 21:21:45,770 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:45,770 INFO  L485      AbstractCegarLoop]: Abstraction has 156 states and 239 transitions.
[2025-04-28 21:21:45,770 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 24 states, 16 states have (on average 5.4375) internal successors, (87), 23 states have internal predecessors, (87), 14 states have call successors, (71), 2 states have call predecessors, (71), 16 states have return successors, (78), 14 states have call predecessors, (78), 14 states have call successors, (78)
[2025-04-28 21:21:45,770 INFO  L278                IsEmpty]: Start isEmpty. Operand 156 states and 239 transitions.
[2025-04-28 21:21:45,785 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 382
[2025-04-28 21:21:45,785 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:45,785 INFO  L218           NwaCegarLoop]: trace histogram [24, 24, 14, 14, 14, 14, 14, 14, 14, 14, 10, 10, 10, 10, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 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]
[2025-04-28 21:21:45,792 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-04-28 21:21:45,990 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2,2 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:45,990 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:45,991 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:45,991 INFO  L85        PathProgramCache]: Analyzing trace with hash -1508932790, now seen corresponding path program 1 times
[2025-04-28 21:21:45,991 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:45,992 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [57392890]
[2025-04-28 21:21:45,992 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:45,992 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:46,029 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 381 statements into 1 equivalence classes.
[2025-04-28 21:21:46,141 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 381 of 381 statements.
[2025-04-28 21:21:46,141 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:46,141 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:46,983 INFO  L134       CoverageAnalysis]: Checked inductivity of 1904 backedges. 0 proven. 83 refuted. 0 times theorem prover too weak. 1821 trivial. 0 not checked.
[2025-04-28 21:21:46,983 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:46,983 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [57392890]
[2025-04-28 21:21:46,983 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [57392890] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:46,983 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [888811409]
[2025-04-28 21:21:46,984 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:46,984 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:46,986 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:46,988 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:46,992 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-04-28 21:21:47,204 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 381 statements into 1 equivalence classes.
[2025-04-28 21:21:47,398 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 381 of 381 statements.
[2025-04-28 21:21:47,399 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:47,399 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:47,405 INFO  L256         TraceCheckSpWp]: Trace formula consists of 1333 conjuncts, 22 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:47,417 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:47,739 INFO  L134       CoverageAnalysis]: Checked inductivity of 1904 backedges. 6 proven. 12 refuted. 0 times theorem prover too weak. 1886 trivial. 0 not checked.
[2025-04-28 21:21:47,740 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-04-28 21:21:51,403 INFO  L134       CoverageAnalysis]: Checked inductivity of 1904 backedges. 6 proven. 12 refuted. 0 times theorem prover too weak. 1886 trivial. 0 not checked.
[2025-04-28 21:21:51,403 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [888811409] provided 0 perfect and 2 imperfect interpolant sequences
[2025-04-28 21:21:51,403 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-04-28 21:21:51,403 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [11, 11, 11] total 26
[2025-04-28 21:21:51,403 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1601759884]
[2025-04-28 21:21:51,404 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-04-28 21:21:51,405 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 26 states
[2025-04-28 21:21:51,405 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:51,406 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 26 interpolants.
[2025-04-28 21:21:51,406 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=62, Invalid=588, Unknown=0, NotChecked=0, Total=650
[2025-04-28 21:21:51,407 INFO  L87              Difference]: Start difference. First operand 156 states and 239 transitions. Second operand  has 26 states, 18 states have (on average 3.111111111111111) internal successors, (56), 24 states have internal predecessors, (56), 16 states have call successors, (45), 1 states have call predecessors, (45), 18 states have return successors, (52), 19 states have call predecessors, (52), 16 states have call successors, (52)
[2025-04-28 21:21:52,264 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:52,264 INFO  L93              Difference]: Finished difference Result 184 states and 301 transitions.
[2025-04-28 21:21:52,265 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 20 states. 
[2025-04-28 21:21:52,265 INFO  L79                 Accepts]: Start accepts. Automaton has  has 26 states, 18 states have (on average 3.111111111111111) internal successors, (56), 24 states have internal predecessors, (56), 16 states have call successors, (45), 1 states have call predecessors, (45), 18 states have return successors, (52), 19 states have call predecessors, (52), 16 states have call successors, (52) Word has length 381
[2025-04-28 21:21:52,267 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:52,270 INFO  L225             Difference]: With dead ends: 184
[2025-04-28 21:21:52,271 INFO  L226             Difference]: Without dead ends: 183
[2025-04-28 21:21:52,271 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 777 GetRequests, 746 SyntacticMatches, 2 SemanticMatches, 29 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 52 ImplicationChecksByTransitivity, 0.6s TimeCoverageRelationStatistics Valid=87, Invalid=843, Unknown=0, NotChecked=0, Total=930
[2025-04-28 21:21:52,272 INFO  L437           NwaCegarLoop]: 198 mSDtfsCounter, 8 mSDsluCounter, 3845 mSDsCounter, 0 mSdLazyCounter, 789 mSolverCounterSat, 8 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.6s Time, 0 mProtectedPredicate, 0 mProtectedAction, 36 SdHoareTripleChecker+Valid, 4043 SdHoareTripleChecker+Invalid, 797 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 8 IncrementalHoareTripleChecker+Valid, 789 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.7s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:52,272 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [36 Valid, 4043 Invalid, 797 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [8 Valid, 789 Invalid, 0 Unknown, 0 Unchecked, 0.7s Time]
[2025-04-28 21:21:52,273 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 183 states.
[2025-04-28 21:21:52,314 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 183 to 177.
[2025-04-28 21:21:52,318 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 177 states, 56 states have (on average 1.2678571428571428) internal successors, (71), 70 states have internal predecessors, (71), 87 states have call successors, (87), 24 states have call predecessors, (87), 33 states have return successors, (121), 84 states have call predecessors, (121), 87 states have call successors, (121)
[2025-04-28 21:21:52,321 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 177 states to 177 states and 279 transitions.
[2025-04-28 21:21:52,321 INFO  L79                 Accepts]: Start accepts. Automaton has 177 states and 279 transitions. Word has length 381
[2025-04-28 21:21:52,324 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:52,324 INFO  L485      AbstractCegarLoop]: Abstraction has 177 states and 279 transitions.
[2025-04-28 21:21:52,324 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 26 states, 18 states have (on average 3.111111111111111) internal successors, (56), 24 states have internal predecessors, (56), 16 states have call successors, (45), 1 states have call predecessors, (45), 18 states have return successors, (52), 19 states have call predecessors, (52), 16 states have call successors, (52)
[2025-04-28 21:21:52,324 INFO  L278                IsEmpty]: Start isEmpty. Operand 177 states and 279 transitions.
[2025-04-28 21:21:52,338 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 588
[2025-04-28 21:21:52,338 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:52,339 INFO  L218           NwaCegarLoop]: trace histogram [38, 38, 24, 22, 22, 22, 22, 22, 22, 22, 16, 16, 16, 16, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 6, 6, 6, 6, 6, 6, 6, 6, 6, 6, 5, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 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, 1]
[2025-04-28 21:21:52,347 INFO  L540       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Forceful destruction successful, exit code 0
[2025-04-28 21:21:52,543 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3,3 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:52,543 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:52,544 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:52,544 INFO  L85        PathProgramCache]: Analyzing trace with hash -552889194, now seen corresponding path program 1 times
[2025-04-28 21:21:52,544 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:52,544 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [2107598876]
[2025-04-28 21:21:52,544 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:52,544 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:52,589 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 587 statements into 1 equivalence classes.
[2025-04-28 21:21:52,599 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 587 of 587 statements.
[2025-04-28 21:21:52,600 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:52,600 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:53,159 INFO  L134       CoverageAnalysis]: Checked inductivity of 5040 backedges. 6 proven. 133 refuted. 0 times theorem prover too weak. 4901 trivial. 0 not checked.
[2025-04-28 21:21:53,159 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:53,159 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [2107598876]
[2025-04-28 21:21:53,159 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [2107598876] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:53,159 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [182271635]
[2025-04-28 21:21:53,160 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:53,160 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:53,162 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:53,164 INFO  L229       MonitoredProcess]: Starting monitored process 4 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:53,167 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-04-28 21:21:53,413 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 587 statements into 1 equivalence classes.
[2025-04-28 21:21:53,725 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 587 of 587 statements.
[2025-04-28 21:21:53,725 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:53,725 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:53,731 INFO  L256         TraceCheckSpWp]: Trace formula consists of 2058 conjuncts, 12 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:53,741 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:53,853 INFO  L134       CoverageAnalysis]: Checked inductivity of 5040 backedges. 309 proven. 0 refuted. 0 times theorem prover too weak. 4731 trivial. 0 not checked.
[2025-04-28 21:21:53,853 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-04-28 21:21:53,853 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [182271635] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:53,854 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-04-28 21:21:53,854 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [8] imperfect sequences [4] total 10
[2025-04-28 21:21:53,854 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1495337336]
[2025-04-28 21:21:53,854 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:53,855 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 8 states
[2025-04-28 21:21:53,855 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:53,856 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 8 interpolants.
[2025-04-28 21:21:53,856 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=18, Invalid=72, Unknown=0, NotChecked=0, Total=90
[2025-04-28 21:21:53,856 INFO  L87              Difference]: Start difference. First operand 177 states and 279 transitions. Second operand  has 8 states, 5 states have (on average 9.0) internal successors, (45), 7 states have internal predecessors, (45), 5 states have call successors, (38), 2 states have call predecessors, (38), 4 states have return successors, (38), 3 states have call predecessors, (38), 5 states have call successors, (38)
[2025-04-28 21:21:54,105 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:54,105 INFO  L93              Difference]: Finished difference Result 179 states and 292 transitions.
[2025-04-28 21:21:54,105 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-04-28 21:21:54,106 INFO  L79                 Accepts]: Start accepts. Automaton has  has 8 states, 5 states have (on average 9.0) internal successors, (45), 7 states have internal predecessors, (45), 5 states have call successors, (38), 2 states have call predecessors, (38), 4 states have return successors, (38), 3 states have call predecessors, (38), 5 states have call successors, (38) Word has length 587
[2025-04-28 21:21:54,106 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:54,109 INFO  L225             Difference]: With dead ends: 179
[2025-04-28 21:21:54,109 INFO  L226             Difference]: Without dead ends: 179
[2025-04-28 21:21:54,109 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 593 GetRequests, 582 SyntacticMatches, 0 SemanticMatches, 11 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 3 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=32, Invalid=124, Unknown=0, NotChecked=0, Total=156
[2025-04-28 21:21:54,110 INFO  L437           NwaCegarLoop]: 213 mSDtfsCounter, 3 mSDsluCounter, 1012 mSDsCounter, 0 mSdLazyCounter, 195 mSolverCounterSat, 8 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 4 SdHoareTripleChecker+Valid, 1225 SdHoareTripleChecker+Invalid, 203 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 8 IncrementalHoareTripleChecker+Valid, 195 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:54,111 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [4 Valid, 1225 Invalid, 203 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [8 Valid, 195 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-04-28 21:21:54,112 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 179 states.
[2025-04-28 21:21:54,130 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 179 to 177.
[2025-04-28 21:21:54,130 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 177 states, 56 states have (on average 1.2678571428571428) internal successors, (71), 70 states have internal predecessors, (71), 87 states have call successors, (87), 24 states have call predecessors, (87), 33 states have return successors, (120), 84 states have call predecessors, (120), 87 states have call successors, (120)
[2025-04-28 21:21:54,134 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 177 states to 177 states and 278 transitions.
[2025-04-28 21:21:54,134 INFO  L79                 Accepts]: Start accepts. Automaton has 177 states and 278 transitions. Word has length 587
[2025-04-28 21:21:54,134 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:54,134 INFO  L485      AbstractCegarLoop]: Abstraction has 177 states and 278 transitions.
[2025-04-28 21:21:54,135 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 8 states, 5 states have (on average 9.0) internal successors, (45), 7 states have internal predecessors, (45), 5 states have call successors, (38), 2 states have call predecessors, (38), 4 states have return successors, (38), 3 states have call predecessors, (38), 5 states have call successors, (38)
[2025-04-28 21:21:54,135 INFO  L278                IsEmpty]: Start isEmpty. Operand 177 states and 278 transitions.
[2025-04-28 21:21:54,141 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 608
[2025-04-28 21:21:54,141 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:54,141 INFO  L218           NwaCegarLoop]: trace histogram [39, 39, 24, 23, 23, 23, 23, 23, 23, 23, 16, 16, 16, 16, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 6, 6, 6, 6, 6, 6, 6, 6, 6, 6, 5, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 4, 2, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-04-28 21:21:54,150 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Ended with exit code 0
[2025-04-28 21:21:54,342 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable4,4 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:54,342 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:54,343 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:54,343 INFO  L85        PathProgramCache]: Analyzing trace with hash -454883173, now seen corresponding path program 1 times
[2025-04-28 21:21:54,343 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:54,343 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [756327834]
[2025-04-28 21:21:54,343 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:54,343 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:54,378 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 607 statements into 1 equivalence classes.
[2025-04-28 21:21:54,441 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 607 of 607 statements.
[2025-04-28 21:21:54,441 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:54,441 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:56,419 INFO  L134       CoverageAnalysis]: Checked inductivity of 5303 backedges. 16 proven. 333 refuted. 0 times theorem prover too weak. 4954 trivial. 0 not checked.
[2025-04-28 21:21:56,419 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-04-28 21:21:56,419 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [756327834]
[2025-04-28 21:21:56,420 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [756327834] provided 0 perfect and 1 imperfect interpolant sequences
[2025-04-28 21:21:56,420 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1124395180]
[2025-04-28 21:21:56,420 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:56,420 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-04-28 21:21:56,423 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-04-28 21:21:56,425 INFO  L229       MonitoredProcess]: Starting monitored process 5 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-04-28 21:21:56,431 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Waiting until timeout for monitored process
[2025-04-28 21:21:56,725 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 607 statements into 1 equivalence classes.
[2025-04-28 21:21:57,221 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 607 of 607 statements.
[2025-04-28 21:21:57,221 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:57,221 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-04-28 21:21:57,228 INFO  L256         TraceCheckSpWp]: Trace formula consists of 2119 conjuncts, 5 conjuncts are in the unsatisfiable core
[2025-04-28 21:21:57,243 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-04-28 21:21:57,372 INFO  L134       CoverageAnalysis]: Checked inductivity of 5303 backedges. 2147 proven. 0 refuted. 0 times theorem prover too weak. 3156 trivial. 0 not checked.
[2025-04-28 21:21:57,373 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-04-28 21:21:57,373 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1124395180] provided 1 perfect and 0 imperfect interpolant sequences
[2025-04-28 21:21:57,373 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-04-28 21:21:57,373 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [17] total 21
[2025-04-28 21:21:57,373 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1348368736]
[2025-04-28 21:21:57,373 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-04-28 21:21:57,374 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-04-28 21:21:57,374 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-04-28 21:21:57,375 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-04-28 21:21:57,375 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=39, Invalid=381, Unknown=0, NotChecked=0, Total=420
[2025-04-28 21:21:57,376 INFO  L87              Difference]: Start difference. First operand 177 states and 278 transitions. Second operand  has 6 states, 4 states have (on average 15.0) internal successors, (60), 6 states have internal predecessors, (60), 5 states have call successors, (51), 2 states have call predecessors, (51), 4 states have return successors, (51), 4 states have call predecessors, (51), 5 states have call successors, (51)
[2025-04-28 21:21:57,503 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-04-28 21:21:57,503 INFO  L93              Difference]: Finished difference Result 184 states and 305 transitions.
[2025-04-28 21:21:57,504 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-04-28 21:21:57,504 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 4 states have (on average 15.0) internal successors, (60), 6 states have internal predecessors, (60), 5 states have call successors, (51), 2 states have call predecessors, (51), 4 states have return successors, (51), 4 states have call predecessors, (51), 5 states have call successors, (51) Word has length 607
[2025-04-28 21:21:57,505 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-04-28 21:21:57,508 INFO  L225             Difference]: With dead ends: 184
[2025-04-28 21:21:57,508 INFO  L226             Difference]: Without dead ends: 184
[2025-04-28 21:21:57,508 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 624 GetRequests, 604 SyntacticMatches, 0 SemanticMatches, 20 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.3s TimeCoverageRelationStatistics Valid=43, Invalid=419, Unknown=0, NotChecked=0, Total=462
[2025-04-28 21:21:57,509 INFO  L437           NwaCegarLoop]: 232 mSDtfsCounter, 3 mSDsluCounter, 896 mSDsCounter, 0 mSdLazyCounter, 65 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 1128 SdHoareTripleChecker+Invalid, 66 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 65 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-04-28 21:21:57,510 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 1128 Invalid, 66 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 65 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-04-28 21:21:57,511 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 184 states.
[2025-04-28 21:21:57,530 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 184 to 182.
[2025-04-28 21:21:57,531 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 182 states, 58 states have (on average 1.2586206896551724) internal successors, (73), 72 states have internal predecessors, (73), 88 states have call successors, (88), 24 states have call predecessors, (88), 35 states have return successors, (130), 86 states have call predecessors, (130), 88 states have call successors, (130)
[2025-04-28 21:21:57,534 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 182 states to 182 states and 291 transitions.
[2025-04-28 21:21:57,535 INFO  L79                 Accepts]: Start accepts. Automaton has 182 states and 291 transitions. Word has length 607
[2025-04-28 21:21:57,535 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-04-28 21:21:57,536 INFO  L485      AbstractCegarLoop]: Abstraction has 182 states and 291 transitions.
[2025-04-28 21:21:57,536 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 4 states have (on average 15.0) internal successors, (60), 6 states have internal predecessors, (60), 5 states have call successors, (51), 2 states have call predecessors, (51), 4 states have return successors, (51), 4 states have call predecessors, (51), 5 states have call successors, (51)
[2025-04-28 21:21:57,536 INFO  L278                IsEmpty]: Start isEmpty. Operand 182 states and 291 transitions.
[2025-04-28 21:21:57,546 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 904
[2025-04-28 21:21:57,546 INFO  L210           NwaCegarLoop]: Found error trace
[2025-04-28 21:21:57,547 INFO  L218           NwaCegarLoop]: trace histogram [58, 58, 36, 34, 34, 34, 34, 34, 34, 34, 24, 24, 24, 24, 12, 12, 12, 12, 12, 12, 12, 12, 12, 12, 12, 10, 10, 10, 10, 10, 10, 10, 10, 10, 10, 9, 7, 7, 7, 7, 7, 7, 7, 7, 5, 5, 5, 5, 5, 5, 5, 4, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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,557 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Ended with exit code 0
[2025-04-28 21:21:57,747 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 5 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable5
[2025-04-28 21:21:57,747 INFO  L403      AbstractCegarLoop]: === Iteration 6 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-04-28 21:21:57,748 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-04-28 21:21:57,748 INFO  L85        PathProgramCache]: Analyzing trace with hash -21552575, now seen corresponding path program 1 times
[2025-04-28 21:21:57,748 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-04-28 21:21:57,748 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [845627067]
[2025-04-28 21:21:57,748 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-04-28 21:21:57,748 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-04-28 21:21:57,798 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 903 statements into 1 equivalence classes.
[2025-04-28 21:21:57,974 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 903 of 903 statements.
[2025-04-28 21:21:57,974 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-04-28 21:21:57,975 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
