./chc-comp-wrapper.sh ../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/special/tx_vars_chc_internal.sol_0_no_adts_000.smt2 .


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-05-07 17:29:14,130 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-05-07 17:29:14,167 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_927932a5-65b7-4f54-aa39-85a96450af12/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-05-07 17:29:14,170 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-05-07 17:29:14,171 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-05-07 17:29:14,183 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-05-07 17:29:14,183 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-05-07 17:29:14,184 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-05-07 17:29:14,184 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-05-07 17:29:14,184 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-05-07 17:29:14,184 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-05-07 17:29:14,184 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-05-07 17:29:14,184 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-05-07 17:29:14,184 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-05-07 17:29:14,184 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-05-07 17:29:14,185 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-05-07 17:29:14,185 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-05-07 17:29:14,185 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-05-07 17:29:14,186 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-05-07 17:29:14,186 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-05-07 17:29:14,372 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-05-07 17:29:14,378 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-05-07 17:29:14,379 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-05-07 17:29:14,380 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-05-07 17:29:14,380 INFO  L274        PluginConnector]: SmtParser initialized
[2025-05-07 17:29:14,382 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_927932a5-65b7-4f54-aa39-85a96450af12/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/special/tx_vars_chc_internal.sol_0_no_adts_000.smt2
[2025-05-07 17:29:14,383 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-05-07 17:29:14,385 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-05-07 17:29:14,676 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_927932a5-65b7-4f54-aa39-85a96450af12/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/special/tx_vars_chc_internal.sol_0_no_adts_000.smt2
[2025-05-07 17:29:14,678 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-05-07 17:29:14,679 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-05-07 17:29:14,680 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-05-07 17:29:14,680 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-05-07 17:29:14,680 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-05-07 17:29:14,682 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,712 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14 Unit
[2025-05-07 17:29:14,712 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-05-07 17:29:14,713 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-05-07 17:29:14,713 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-05-07 17:29:14,713 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-05-07 17:29:14,724 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,724 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,745 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,746 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,750 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,751 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,752 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,754 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,755 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,766 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-05-07 17:29:14,766 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-05-07 17:29:14,766 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-05-07 17:29:14,766 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-05-07 17:29:14,767 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (1/1) ...
[2025-05-07 17:29:14,769 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-05-07 17:29:14,779 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:29:14,788 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-05-07 17:29:14,790 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000 (1)] Waiting until timeout for monitored process
[2025-05-07 17:29:14,797 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-05-07 17:29:14,797 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-05-07 17:29:14,797 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-05-07 17:29:14,797 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure error_target_7_0 given in one single declaration
[2025-05-07 17:29:14,798 INFO  L130     BoogieDeclarations]: Found specification of procedure error_target_7_0
[2025-05-07 17:29:14,798 INFO  L138     BoogieDeclarations]: Found implementation of procedure error_target_7_0
[2025-05-07 17:29:14,798 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure interface_0_C_65_0 given in one single declaration
[2025-05-07 17:29:14,798 INFO  L130     BoogieDeclarations]: Found specification of procedure interface_0_C_65_0
[2025-05-07 17:29:14,798 INFO  L138     BoogieDeclarations]: Found implementation of procedure interface_0_C_65_0
[2025-05-07 17:29:14,798 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_constructor_2_C_65_0 given in one single declaration
[2025-05-07 17:29:14,798 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_constructor_2_C_65_0
[2025-05-07 17:29:14,798 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_constructor_2_C_65_0
[2025-05-07 17:29:14,798 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure implicit_constructor_entry_22_C_65_0 given in one single declaration
[2025-05-07 17:29:14,798 INFO  L130     BoogieDeclarations]: Found specification of procedure implicit_constructor_entry_22_C_65_0
[2025-05-07 17:29:14,798 INFO  L138     BoogieDeclarations]: Found implementation of procedure implicit_constructor_entry_22_C_65_0
[2025-05-07 17:29:14,799 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_19_C_65_0 given in one single declaration
[2025-05-07 17:29:14,799 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_19_C_65_0
[2025-05-07 17:29:14,799 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_19_C_65_0
[2025-05-07 17:29:14,799 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_after_init_21_C_65_0 given in one single declaration
[2025-05-07 17:29:14,799 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_after_init_21_C_65_0
[2025-05-07 17:29:14,799 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_after_init_21_C_65_0
[2025-05-07 17:29:14,799 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_entry_20_C_65_0 given in one single declaration
[2025-05-07 17:29:14,799 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_entry_20_C_65_0
[2025-05-07 17:29:14,799 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_entry_20_C_65_0
[2025-05-07 17:29:14,799 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_4_function_f__21_65_0 given in one single declaration
[2025-05-07 17:29:14,799 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_4_function_f__21_65_0
[2025-05-07 17:29:14,800 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_4_function_f__21_65_0
[2025-05-07 17:29:14,800 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_3_function_f__21_65_0 given in one single declaration
[2025-05-07 17:29:14,800 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_3_function_f__21_65_0
[2025-05-07 17:29:14,800 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_3_function_f__21_65_0
[2025-05-07 17:29:14,800 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_7_f_20_65_0 given in one single declaration
[2025-05-07 17:29:14,800 INFO  L130     BoogieDeclarations]: Found specification of procedure block_7_f_20_65_0
[2025-05-07 17:29:14,800 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_7_f_20_65_0
[2025-05-07 17:29:14,800 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_6_function_f__21_65_0 given in one single declaration
[2025-05-07 17:29:14,800 INFO  L130     BoogieDeclarations]: Found specification of procedure block_6_function_f__21_65_0
[2025-05-07 17:29:14,800 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_6_function_f__21_65_0
[2025-05-07 17:29:14,800 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_9_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,800 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_9_function_g__64_65_0
[2025-05-07 17:29:14,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_9_function_g__64_65_0
[2025-05-07 17:29:14,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_5_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,801 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_5_function_g__64_65_0
[2025-05-07 17:29:14,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_5_function_g__64_65_0
[2025-05-07 17:29:14,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_15_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,801 INFO  L130     BoogieDeclarations]: Found specification of procedure block_15_function_g__64_65_0
[2025-05-07 17:29:14,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_15_function_g__64_65_0
[2025-05-07 17:29:14,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_12_g_63_65_0 given in one single declaration
[2025-05-07 17:29:14,801 INFO  L130     BoogieDeclarations]: Found specification of procedure block_12_g_63_65_0
[2025-05-07 17:29:14,801 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_12_g_63_65_0
[2025-05-07 17:29:14,801 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_11_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,801 INFO  L130     BoogieDeclarations]: Found specification of procedure block_11_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_11_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_13_return_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,802 INFO  L130     BoogieDeclarations]: Found specification of procedure block_13_return_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_13_return_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_16_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,802 INFO  L130     BoogieDeclarations]: Found specification of procedure block_16_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_16_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_14_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,802 INFO  L130     BoogieDeclarations]: Found specification of procedure block_14_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_14_function_g__64_65_0
[2025-05-07 17:29:14,802 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_18_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,802 INFO  L130     BoogieDeclarations]: Found specification of procedure block_18_function_g__64_65_0
[2025-05-07 17:29:14,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_18_function_g__64_65_0
[2025-05-07 17:29:14,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_17_function_g__64_65_0 given in one single declaration
[2025-05-07 17:29:14,803 INFO  L130     BoogieDeclarations]: Found specification of procedure block_17_function_g__64_65_0
[2025-05-07 17:29:14,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_17_function_g__64_65_0
[2025-05-07 17:29:14,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_8_return_function_f__21_65_0 given in one single declaration
[2025-05-07 17:29:14,803 INFO  L130     BoogieDeclarations]: Found specification of procedure block_8_return_function_f__21_65_0
[2025-05-07 17:29:14,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_8_return_function_f__21_65_0
[2025-05-07 17:29:14,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_10_function_f__21_65_0 given in one single declaration
[2025-05-07 17:29:14,803 INFO  L130     BoogieDeclarations]: Found specification of procedure block_10_function_f__21_65_0
[2025-05-07 17:29:14,803 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_10_function_f__21_65_0
[2025-05-07 17:29:14,803 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-05-07 17:29:14,803 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-05-07 17:29:14,804 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-05-07 17:29:14,957 INFO  L234             CfgBuilder]: Building ICFG
[2025-05-07 17:29:14,959 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-05-07 17:29:15,163 INFO  L?                        ?]: Removed 222 outVars from TransFormulas that were not future-live.
[2025-05-07 17:29:15,163 INFO  L283             CfgBuilder]: Performing block encoding
[2025-05-07 17:29:15,171 INFO  L304             CfgBuilder]: Using library mode
[2025-05-07 17:29:15,171 INFO  L312             CfgBuilder]: Removed 14 assume(true) statements.
[2025-05-07 17:29:15,171 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 07.05 05:29:15 BoogieIcfgContainer
[2025-05-07 17:29:15,171 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-05-07 17:29:15,173 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-05-07 17:29:15,173 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-05-07 17:29:15,175 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-05-07 17:29:15,175 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 07.05 05:29:14" (1/3) ...
[2025-05-07 17:29:15,176 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@34843525 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 07.05 05:29:15, skipping insertion in model container
[2025-05-07 17:29:15,176 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:29:14" (2/3) ...
[2025-05-07 17:29:15,176 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@34843525 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 07.05 05:29:15, skipping insertion in model container
[2025-05-07 17:29:15,176 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 07.05 05:29:15" (3/3) ...
[2025-05-07 17:29:15,177 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-05-07 17:29:15,187 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-05-07 17:29:15,188 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 25 procedures, 97 locations, 150 edges, 25 initial locations, 0 loop locations, and 1 error locations.
[2025-05-07 17:29:15,216 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-05-07 17:29:15,224 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;@5694df75, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-05-07 17:29:15,224 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-05-07 17:29:15,226 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 97 states, 42 states have (on average 1.0714285714285714) internal successors, (45), 45 states have internal predecessors, (45), 30 states have call successors, (35), 24 states have call predecessors, (35), 24 states have return successors, (35), 27 states have call predecessors, (35), 30 states have call successors, (35)
[2025-05-07 17:29:15,233 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 66
[2025-05-07 17:29:15,233 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:29:15,233 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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-05-07 17:29:15,234 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:29:15,237 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:29:15,237 INFO  L85        PathProgramCache]: Analyzing trace with hash 2082254570, now seen corresponding path program 1 times
[2025-05-07 17:29:15,242 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:29:15,242 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [495239269]
[2025-05-07 17:29:15,242 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:29:15,243 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:29:15,289 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 65 statements into 1 equivalence classes.
[2025-05-07 17:29:15,332 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 65 of 65 statements.
[2025-05-07 17:29:15,332 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:29:15,332 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:29:15,757 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-05-07 17:29:15,758 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:29:15,758 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [495239269]
[2025-05-07 17:29:15,759 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [495239269] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:29:15,759 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:29:15,761 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [] total 6
[2025-05-07 17:29:15,762 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [752019580]
[2025-05-07 17:29:15,762 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:29:15,771 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-05-07 17:29:15,771 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:29:15,799 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-05-07 17:29:15,799 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=9, Invalid=21, Unknown=0, NotChecked=0, Total=30
[2025-05-07 17:29:15,802 INFO  L87              Difference]: Start difference. First operand  has 97 states, 42 states have (on average 1.0714285714285714) internal successors, (45), 45 states have internal predecessors, (45), 30 states have call successors, (35), 24 states have call predecessors, (35), 24 states have return successors, (35), 27 states have call predecessors, (35), 30 states have call successors, (35) Second operand  has 6 states, 5 states have (on average 5.8) internal successors, (29), 6 states have internal predecessors, (29), 4 states have call successors, (18), 1 states have call predecessors, (18), 5 states have return successors, (18), 5 states have call predecessors, (18), 4 states have call successors, (18)
[2025-05-07 17:29:15,892 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:29:15,893 INFO  L93              Difference]: Finished difference Result 95 states and 109 transitions.
[2025-05-07 17:29:15,894 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-05-07 17:29:15,895 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 5 states have (on average 5.8) internal successors, (29), 6 states have internal predecessors, (29), 4 states have call successors, (18), 1 states have call predecessors, (18), 5 states have return successors, (18), 5 states have call predecessors, (18), 4 states have call successors, (18) Word has length 65
[2025-05-07 17:29:15,896 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:29:15,903 INFO  L225             Difference]: With dead ends: 95
[2025-05-07 17:29:15,904 INFO  L226             Difference]: Without dead ends: 93
[2025-05-07 17:29:15,906 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 6 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 4 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=9, Invalid=21, Unknown=0, NotChecked=0, Total=30
[2025-05-07 17:29:15,909 INFO  L437           NwaCegarLoop]: 103 mSDtfsCounter, 1 mSDsluCounter, 399 mSDsCounter, 0 mSdLazyCounter, 23 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 502 SdHoareTripleChecker+Invalid, 23 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 23 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:29:15,910 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 502 Invalid, 23 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 23 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:29:15,922 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 93 states.
[2025-05-07 17:29:15,938 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 93 to 91.
[2025-05-07 17:29:15,939 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 91 states, 39 states have (on average 1.0512820512820513) internal successors, (41), 41 states have internal predecessors, (41), 28 states have call successors, (31), 22 states have call predecessors, (31), 24 states have return successors, (33), 27 states have call predecessors, (33), 28 states have call successors, (33)
[2025-05-07 17:29:15,941 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 91 states to 91 states and 105 transitions.
[2025-05-07 17:29:15,942 INFO  L79                 Accepts]: Start accepts. Automaton has 91 states and 105 transitions. Word has length 65
[2025-05-07 17:29:15,943 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:29:15,943 INFO  L485      AbstractCegarLoop]: Abstraction has 91 states and 105 transitions.
[2025-05-07 17:29:15,943 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 5 states have (on average 5.8) internal successors, (29), 6 states have internal predecessors, (29), 4 states have call successors, (18), 1 states have call predecessors, (18), 5 states have return successors, (18), 5 states have call predecessors, (18), 4 states have call successors, (18)
[2025-05-07 17:29:15,943 INFO  L278                IsEmpty]: Start isEmpty. Operand 91 states and 105 transitions.
[2025-05-07 17:29:15,945 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 66
[2025-05-07 17:29:15,945 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:29:15,945 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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-05-07 17:29:15,945 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-05-07 17:29:15,946 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:29:15,946 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:29:15,946 INFO  L85        PathProgramCache]: Analyzing trace with hash 1363206048, now seen corresponding path program 1 times
[2025-05-07 17:29:15,946 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:29:15,946 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [760180658]
[2025-05-07 17:29:15,947 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:29:15,947 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:29:15,976 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 65 statements into 1 equivalence classes.
[2025-05-07 17:29:15,991 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 65 of 65 statements.
[2025-05-07 17:29:15,991 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:29:15,991 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:29:16,228 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-05-07 17:29:16,228 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:29:16,228 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [760180658]
[2025-05-07 17:29:16,228 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [760180658] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:29:16,228 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:29:16,228 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [5] imperfect sequences [] total 5
[2025-05-07 17:29:16,228 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1984742206]
[2025-05-07 17:29:16,228 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:29:16,229 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 5 states
[2025-05-07 17:29:16,230 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:29:16,230 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 5 interpolants.
[2025-05-07 17:29:16,230 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=7, Invalid=13, Unknown=0, NotChecked=0, Total=20
[2025-05-07 17:29:16,231 INFO  L87              Difference]: Start difference. First operand 91 states and 105 transitions. Second operand  has 5 states, 4 states have (on average 7.25) internal successors, (29), 5 states have internal predecessors, (29), 4 states have call successors, (18), 1 states have call predecessors, (18), 4 states have return successors, (18), 4 states have call predecessors, (18), 4 states have call successors, (18)
[2025-05-07 17:29:16,276 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:29:16,276 INFO  L93              Difference]: Finished difference Result 95 states and 109 transitions.
[2025-05-07 17:29:16,276 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 5 states. 
[2025-05-07 17:29:16,277 INFO  L79                 Accepts]: Start accepts. Automaton has  has 5 states, 4 states have (on average 7.25) internal successors, (29), 5 states have internal predecessors, (29), 4 states have call successors, (18), 1 states have call predecessors, (18), 4 states have return successors, (18), 4 states have call predecessors, (18), 4 states have call successors, (18) Word has length 65
[2025-05-07 17:29:16,277 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:29:16,278 INFO  L225             Difference]: With dead ends: 95
[2025-05-07 17:29:16,278 INFO  L226             Difference]: Without dead ends: 91
[2025-05-07 17:29:16,278 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 8 GetRequests, 5 SyntacticMatches, 0 SemanticMatches, 3 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=7, Invalid=13, Unknown=0, NotChecked=0, Total=20
[2025-05-07 17:29:16,278 INFO  L437           NwaCegarLoop]: 97 mSDtfsCounter, 1 mSDsluCounter, 277 mSDsCounter, 0 mSdLazyCounter, 22 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 374 SdHoareTripleChecker+Invalid, 22 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 22 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:29:16,279 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 374 Invalid, 22 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 22 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:29:16,279 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 91 states.
[2025-05-07 17:29:16,283 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 91 to 89.
[2025-05-07 17:29:16,284 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 89 states, 39 states have (on average 1.0256410256410255) internal successors, (40), 40 states have internal predecessors, (40), 26 states have call successors, (29), 22 states have call predecessors, (29), 24 states have return successors, (31), 26 states have call predecessors, (31), 26 states have call successors, (31)
[2025-05-07 17:29:16,285 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 89 states to 89 states and 100 transitions.
[2025-05-07 17:29:16,285 INFO  L79                 Accepts]: Start accepts. Automaton has 89 states and 100 transitions. Word has length 65
[2025-05-07 17:29:16,285 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:29:16,285 INFO  L485      AbstractCegarLoop]: Abstraction has 89 states and 100 transitions.
[2025-05-07 17:29:16,285 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 5 states, 4 states have (on average 7.25) internal successors, (29), 5 states have internal predecessors, (29), 4 states have call successors, (18), 1 states have call predecessors, (18), 4 states have return successors, (18), 4 states have call predecessors, (18), 4 states have call successors, (18)
[2025-05-07 17:29:16,285 INFO  L278                IsEmpty]: Start isEmpty. Operand 89 states and 100 transitions.
[2025-05-07 17:29:16,286 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 66
[2025-05-07 17:29:16,286 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:29:16,286 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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-05-07 17:29:16,286 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2
[2025-05-07 17:29:16,287 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:29:16,287 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:29:16,287 INFO  L85        PathProgramCache]: Analyzing trace with hash 615327896, now seen corresponding path program 1 times
[2025-05-07 17:29:16,287 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:29:16,287 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1818975540]
[2025-05-07 17:29:16,287 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:29:16,287 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:29:16,310 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 65 statements into 1 equivalence classes.
[2025-05-07 17:29:16,322 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 65 of 65 statements.
[2025-05-07 17:29:16,322 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:29:16,323 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:29:16,459 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-05-07 17:29:16,459 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:29:16,459 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1818975540]
[2025-05-07 17:29:16,459 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1818975540] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:29:16,459 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:29:16,459 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [8] imperfect sequences [] total 8
[2025-05-07 17:29:16,460 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2089401870]
[2025-05-07 17:29:16,460 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:29:16,460 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 8 states
[2025-05-07 17:29:16,460 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:29:16,461 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 8 interpolants.
[2025-05-07 17:29:16,461 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:29:16,461 INFO  L87              Difference]: Start difference. First operand 89 states and 100 transitions. Second operand  has 8 states, 7 states have (on average 4.142857142857143) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 7 states have return successors, (18), 7 states have call predecessors, (18), 5 states have call successors, (18)
[2025-05-07 17:29:16,540 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:29:16,540 INFO  L93              Difference]: Finished difference Result 98 states and 111 transitions.
[2025-05-07 17:29:16,541 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-05-07 17:29:16,541 INFO  L79                 Accepts]: Start accepts. Automaton has  has 8 states, 7 states have (on average 4.142857142857143) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 7 states have return successors, (18), 7 states have call predecessors, (18), 5 states have call successors, (18) Word has length 65
[2025-05-07 17:29:16,541 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:29:16,542 INFO  L225             Difference]: With dead ends: 98
[2025-05-07 17:29:16,542 INFO  L226             Difference]: Without dead ends: 98
[2025-05-07 17:29:16,542 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 8 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 6 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:29:16,543 INFO  L437           NwaCegarLoop]: 96 mSDtfsCounter, 1 mSDsluCounter, 560 mSDsCounter, 0 mSdLazyCounter, 46 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 656 SdHoareTripleChecker+Invalid, 46 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 46 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:29:16,543 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 656 Invalid, 46 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 46 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:29:16,544 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 98 states.
[2025-05-07 17:29:16,549 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 98 to 98.
[2025-05-07 17:29:16,549 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 98 states, 43 states have (on average 1.0232558139534884) internal successors, (44), 44 states have internal predecessors, (44), 27 states have call successors, (30), 22 states have call predecessors, (30), 28 states have return successors, (37), 31 states have call predecessors, (37), 27 states have call successors, (37)
[2025-05-07 17:29:16,550 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 98 states to 98 states and 111 transitions.
[2025-05-07 17:29:16,550 INFO  L79                 Accepts]: Start accepts. Automaton has 98 states and 111 transitions. Word has length 65
[2025-05-07 17:29:16,550 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:29:16,550 INFO  L485      AbstractCegarLoop]: Abstraction has 98 states and 111 transitions.
[2025-05-07 17:29:16,550 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 8 states, 7 states have (on average 4.142857142857143) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 7 states have return successors, (18), 7 states have call predecessors, (18), 5 states have call successors, (18)
[2025-05-07 17:29:16,551 INFO  L278                IsEmpty]: Start isEmpty. Operand 98 states and 111 transitions.
[2025-05-07 17:29:16,552 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 66
[2025-05-07 17:29:16,552 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:29:16,552 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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-05-07 17:29:16,552 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3
[2025-05-07 17:29:16,552 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:29:16,553 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:29:16,553 INFO  L85        PathProgramCache]: Analyzing trace with hash 634075684, now seen corresponding path program 1 times
[2025-05-07 17:29:16,553 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:29:16,553 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [825094540]
[2025-05-07 17:29:16,553 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:29:16,553 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:29:16,586 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 65 statements into 1 equivalence classes.
[2025-05-07 17:29:16,600 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 65 of 65 statements.
[2025-05-07 17:29:16,600 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:29:16,600 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:29:16,775 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-05-07 17:29:16,775 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:29:16,775 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [825094540]
[2025-05-07 17:29:16,775 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [825094540] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:29:16,775 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:29:16,775 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [8] imperfect sequences [] total 8
[2025-05-07 17:29:16,775 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1380787161]
[2025-05-07 17:29:16,775 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:29:16,776 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 8 states
[2025-05-07 17:29:16,776 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:29:16,777 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 8 interpolants.
[2025-05-07 17:29:16,777 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=14, Invalid=42, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:29:16,777 INFO  L87              Difference]: Start difference. First operand 98 states and 111 transitions. Second operand  has 8 states, 6 states have (on average 4.833333333333333) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 6 states have return successors, (18), 6 states have call predecessors, (18), 5 states have call successors, (18)
[2025-05-07 17:29:16,889 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:29:16,889 INFO  L93              Difference]: Finished difference Result 104 states and 117 transitions.
[2025-05-07 17:29:16,889 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-05-07 17:29:16,890 INFO  L79                 Accepts]: Start accepts. Automaton has  has 8 states, 6 states have (on average 4.833333333333333) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 6 states have return successors, (18), 6 states have call predecessors, (18), 5 states have call successors, (18) Word has length 65
[2025-05-07 17:29:16,890 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:29:16,891 INFO  L225             Difference]: With dead ends: 104
[2025-05-07 17:29:16,891 INFO  L226             Difference]: Without dead ends: 104
[2025-05-07 17:29:16,892 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 8 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 6 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 2 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=14, Invalid=42, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:29:16,892 INFO  L437           NwaCegarLoop]: 92 mSDtfsCounter, 1 mSDsluCounter, 530 mSDsCounter, 0 mSdLazyCounter, 63 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 622 SdHoareTripleChecker+Invalid, 63 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 63 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:29:16,892 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 622 Invalid, 63 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 63 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:29:16,893 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 104 states.
[2025-05-07 17:29:16,900 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 104 to 98.
[2025-05-07 17:29:16,900 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 98 states, 43 states have (on average 1.0232558139534884) internal successors, (44), 44 states have internal predecessors, (44), 27 states have call successors, (30), 22 states have call predecessors, (30), 28 states have return successors, (37), 31 states have call predecessors, (37), 27 states have call successors, (37)
[2025-05-07 17:29:16,901 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 98 states to 98 states and 111 transitions.
[2025-05-07 17:29:16,901 INFO  L79                 Accepts]: Start accepts. Automaton has 98 states and 111 transitions. Word has length 65
[2025-05-07 17:29:16,902 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:29:16,902 INFO  L485      AbstractCegarLoop]: Abstraction has 98 states and 111 transitions.
[2025-05-07 17:29:16,902 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 8 states, 6 states have (on average 4.833333333333333) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 6 states have return successors, (18), 6 states have call predecessors, (18), 5 states have call successors, (18)
[2025-05-07 17:29:16,902 INFO  L278                IsEmpty]: Start isEmpty. Operand 98 states and 111 transitions.
[2025-05-07 17:29:16,903 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 66
[2025-05-07 17:29:16,903 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:29:16,903 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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-05-07 17:29:16,904 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable4
[2025-05-07 17:29:16,904 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:29:16,904 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:29:16,904 INFO  L85        PathProgramCache]: Analyzing trace with hash -1735629542, now seen corresponding path program 1 times
[2025-05-07 17:29:16,904 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:29:16,904 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1715507219]
[2025-05-07 17:29:16,904 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:29:16,905 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:29:16,934 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 65 statements into 1 equivalence classes.
[2025-05-07 17:29:16,945 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 65 of 65 statements.
[2025-05-07 17:29:16,945 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:29:16,945 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:29:17,048 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-05-07 17:29:17,049 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:29:17,049 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1715507219]
[2025-05-07 17:29:17,049 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1715507219] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:29:17,049 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:29:17,049 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [8] imperfect sequences [] total 8
[2025-05-07 17:29:17,049 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [537038630]
[2025-05-07 17:29:17,049 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:29:17,050 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 8 states
[2025-05-07 17:29:17,050 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:29:17,050 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 8 interpolants.
[2025-05-07 17:29:17,050 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:29:17,050 INFO  L87              Difference]: Start difference. First operand 98 states and 111 transitions. Second operand  has 8 states, 7 states have (on average 4.142857142857143) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 7 states have return successors, (18), 7 states have call predecessors, (18), 5 states have call successors, (18)
[2025-05-07 17:29:17,115 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:29:17,115 INFO  L93              Difference]: Finished difference Result 102 states and 115 transitions.
[2025-05-07 17:29:17,115 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-05-07 17:29:17,115 INFO  L79                 Accepts]: Start accepts. Automaton has  has 8 states, 7 states have (on average 4.142857142857143) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 7 states have return successors, (18), 7 states have call predecessors, (18), 5 states have call successors, (18) Word has length 65
[2025-05-07 17:29:17,116 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:29:17,116 INFO  L225             Difference]: With dead ends: 102
[2025-05-07 17:29:17,117 INFO  L226             Difference]: Without dead ends: 102
[2025-05-07 17:29:17,117 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 8 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 6 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:29:17,117 INFO  L437           NwaCegarLoop]: 94 mSDtfsCounter, 1 mSDsluCounter, 549 mSDsCounter, 0 mSdLazyCounter, 46 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 643 SdHoareTripleChecker+Invalid, 46 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 46 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:29:17,118 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 643 Invalid, 46 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 46 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:29:17,118 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 102 states.
[2025-05-07 17:29:17,122 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 102 to 93.
[2025-05-07 17:29:17,122 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 93 states, 41 states have (on average 1.024390243902439) internal successors, (42), 42 states have internal predecessors, (42), 26 states have call successors, (29), 22 states have call predecessors, (29), 26 states have return successors, (33), 28 states have call predecessors, (33), 26 states have call successors, (33)
[2025-05-07 17:29:17,123 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 93 states to 93 states and 104 transitions.
[2025-05-07 17:29:17,123 INFO  L79                 Accepts]: Start accepts. Automaton has 93 states and 104 transitions. Word has length 65
[2025-05-07 17:29:17,123 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:29:17,123 INFO  L485      AbstractCegarLoop]: Abstraction has 93 states and 104 transitions.
[2025-05-07 17:29:17,123 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 8 states, 7 states have (on average 4.142857142857143) internal successors, (29), 8 states have internal predecessors, (29), 5 states have call successors, (18), 1 states have call predecessors, (18), 7 states have return successors, (18), 7 states have call predecessors, (18), 5 states have call successors, (18)
[2025-05-07 17:29:17,123 INFO  L278                IsEmpty]: Start isEmpty. Operand 93 states and 104 transitions.
[2025-05-07 17:29:17,124 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 69
[2025-05-07 17:29:17,124 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:29:17,124 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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-05-07 17:29:17,124 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable5
[2025-05-07 17:29:17,124 INFO  L403      AbstractCegarLoop]: === Iteration 6 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:29:17,125 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:29:17,125 INFO  L85        PathProgramCache]: Analyzing trace with hash 1705702874, now seen corresponding path program 1 times
[2025-05-07 17:29:17,125 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:29:17,125 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [286727913]
[2025-05-07 17:29:17,125 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:29:17,125 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:29:17,152 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 68 statements into 1 equivalence classes.
[2025-05-07 17:29:17,161 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 68 of 68 statements.
[2025-05-07 17:29:17,162 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:29:17,162 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:29:17,230 INFO  L134       CoverageAnalysis]: Checked inductivity of 0 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 0 trivial. 0 not checked.
[2025-05-07 17:29:17,230 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:29:17,230 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [286727913]
[2025-05-07 17:29:17,230 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [286727913] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:29:17,230 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:29:17,230 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [] total 6
[2025-05-07 17:29:17,230 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [442146353]
[2025-05-07 17:29:17,231 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:29:17,231 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-05-07 17:29:17,231 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:29:17,231 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-05-07 17:29:17,231 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=9, Invalid=21, Unknown=0, NotChecked=0, Total=30
[2025-05-07 17:29:17,232 INFO  L87              Difference]: Start difference. First operand 93 states and 104 transitions. Second operand  has 6 states, 5 states have (on average 6.0) internal successors, (30), 6 states have internal predecessors, (30), 4 states have call successors, (19), 1 states have call predecessors, (19), 5 states have return successors, (19), 5 states have call predecessors, (19), 4 states have call successors, (19)
[2025-05-07 17:29:17,253 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:29:17,254 INFO  L93              Difference]: Finished difference Result 63 states and 70 transitions.
[2025-05-07 17:29:17,254 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-05-07 17:29:17,254 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 5 states have (on average 6.0) internal successors, (30), 6 states have internal predecessors, (30), 4 states have call successors, (19), 1 states have call predecessors, (19), 5 states have return successors, (19), 5 states have call predecessors, (19), 4 states have call successors, (19) Word has length 68
[2025-05-07 17:29:17,255 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:29:17,255 INFO  L225             Difference]: With dead ends: 63
[2025-05-07 17:29:17,255 INFO  L226             Difference]: Without dead ends: 0
[2025-05-07 17:29:17,255 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 6 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 4 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=9, Invalid=21, Unknown=0, NotChecked=0, Total=30
[2025-05-07 17:29:17,255 INFO  L437           NwaCegarLoop]: 64 mSDtfsCounter, 0 mSDsluCounter, 245 mSDsCounter, 0 mSdLazyCounter, 12 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 0 SdHoareTripleChecker+Valid, 309 SdHoareTripleChecker+Invalid, 12 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 12 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:29:17,255 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [0 Valid, 309 Invalid, 12 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 12 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:29:17,256 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 0 states.
[2025-05-07 17:29:17,256 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 0 to 0.
[2025-05-07 17:29:17,256 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 0 states, 0 states have (on average 0.0) internal successors, (0), 0 states have internal predecessors, (0), 0 states have call successors, (0), 0 states have call predecessors, (0), 0 states have return successors, (0), 0 states have call predecessors, (0), 0 states have call successors, (0)
[2025-05-07 17:29:17,256 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 0 states to 0 states and 0 transitions.
[2025-05-07 17:29:17,256 INFO  L79                 Accepts]: Start accepts. Automaton has 0 states and 0 transitions. Word has length 68
[2025-05-07 17:29:17,256 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:29:17,256 INFO  L485      AbstractCegarLoop]: Abstraction has 0 states and 0 transitions.
[2025-05-07 17:29:17,257 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 5 states have (on average 6.0) internal successors, (30), 6 states have internal predecessors, (30), 4 states have call successors, (19), 1 states have call predecessors, (19), 5 states have return successors, (19), 5 states have call predecessors, (19), 4 states have call successors, (19)
[2025-05-07 17:29:17,257 INFO  L278                IsEmpty]: Start isEmpty. Operand 0 states and 0 transitions.
[2025-05-07 17:29:17,257 INFO  L284                IsEmpty]: Finished isEmpty. No accepting run.
[2025-05-07 17:29:17,259 INFO  L790   garLoopResultBuilder]: Registering result SAFE for location Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY (0 of 1 remaining)
[2025-05-07 17:29:17,259 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable6
[2025-05-07 17:29:17,261 INFO  L422         BasicCegarLoop]: Path program histogram: [1, 1, 1, 1, 1, 1]
[2025-05-07 17:29:17,263 INFO  L171   ceAbstractionStarter]: Computing trace abstraction results
[2025-05-07 17:29:17,265 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction CFG 07.05 05:29:17 BoogieIcfgContainer
[2025-05-07 17:29:17,266 INFO  L131        PluginConnector]: ------------------------ END TraceAbstraction----------------------------
[2025-05-07 17:29:17,266 INFO  L158              Benchmark]: Toolchain (without parser) took 2586.76ms. Allocated memory is still 234.9MB. Free memory was 145.7MB in the beginning and 80.6MB in the end (delta: 65.0MB). Peak memory consumption was 78.6MB. Max. memory is 33.6GB.
[2025-05-07 17:29:17,266 INFO  L158              Benchmark]: SmtParser took 0.23ms. Allocated memory is still 234.9MB. Free memory is still 173.3MB. There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:29:17,266 INFO  L158              Benchmark]: ChcToBoogie took 32.41ms. Allocated memory is still 234.9MB. Free memory was 145.7MB in the beginning and 142.4MB in the end (delta: 3.3MB). There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:29:17,267 INFO  L158              Benchmark]: Boogie Preprocessor took 53.05ms. Allocated memory is still 234.9MB. Free memory was 142.4MB in the beginning and 139.0MB in the end (delta: 3.4MB). There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:29:17,267 INFO  L158              Benchmark]: RCFGBuilder took 405.18ms. Allocated memory was 234.9MB in the beginning and 302.0MB in the end (delta: 67.1MB). Free memory was 138.9MB in the beginning and 236.7MB in the end (delta: -97.8MB). Peak memory consumption was 43.9MB. Max. memory is 33.6GB.
[2025-05-07 17:29:17,267 INFO  L158              Benchmark]: TraceAbstraction took 2092.87ms. Allocated memory was 302.0MB in the beginning and 234.9MB in the end (delta: -67.1MB). Free memory was 236.1MB in the beginning and 80.6MB in the end (delta: 155.5MB). Peak memory consumption was 85.0MB. Max. memory is 33.6GB.
[2025-05-07 17:29:17,268 INFO  L338   ainManager$Toolchain]: #######################  End [Toolchain 1] #######################
 --- Results ---
 * Results from de.uni_freiburg.informatik.ultimate.core:
  - StatisticsResult: Toolchain Benchmarks
    Benchmark results are:
 * SmtParser took 0.23ms. Allocated memory is still 234.9MB. Free memory is still 173.3MB. There was no memory consumed. Max. memory is 33.6GB.
 * ChcToBoogie took 32.41ms. Allocated memory is still 234.9MB. Free memory was 145.7MB in the beginning and 142.4MB in the end (delta: 3.3MB). There was no memory consumed. Max. memory is 33.6GB.
 * Boogie Preprocessor took 53.05ms. Allocated memory is still 234.9MB. Free memory was 142.4MB in the beginning and 139.0MB in the end (delta: 3.4MB). There was no memory consumed. Max. memory is 33.6GB.
 * RCFGBuilder took 405.18ms. Allocated memory was 234.9MB in the beginning and 302.0MB in the end (delta: 67.1MB). Free memory was 138.9MB in the beginning and 236.7MB in the end (delta: -97.8MB). Peak memory consumption was 43.9MB. Max. memory is 33.6GB.
 * TraceAbstraction took 2092.87ms. Allocated memory was 302.0MB in the beginning and 234.9MB in the end (delta: -67.1MB). Free memory was 236.1MB in the beginning and 80.6MB in the end (delta: 155.5MB). Peak memory consumption was 85.0MB. Max. memory is 33.6GB.
 * Results from de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction:
  - StatisticsResult: ErrorAutomatonStatistics
    NumberErrorTraces: 0, NumberStatementsAllTraces: 0, NumberRelevantStatements: 0, 0.0s ErrorAutomatonConstructionTimeTotal, 0.0s FaulLocalizationTime, NumberStatementsFirstTrace: -1, TraceLengthAvg: 0, 0.0s ErrorAutomatonConstructionTimeAvg, 0.0s ErrorAutomatonDifferenceTimeAvg, 0.0s ErrorAutomatonDifferenceTimeTotal, NumberOfNoEnhancement: 0, NumberOfFiniteEnhancement: 0, NumberOfInfiniteEnhancement: 0
  - PositiveResult [Unknown line] : the set of constraint Horn clauses is satisfiable
    For all program executions holds that the set of constraint Horn clauses is satisfiable at this location
  - StatisticsResult: Ultimate Automizer benchmark data
    CFG has 25 procedures, 97 locations, 150 edges, 1 error locations. Started 1 CEGAR loops. OverallTime: 2.1s, OverallIterations: 6, TraceHistogramMax: 1, PathProgramHistogramMax: 1, EmptinessCheckTime: 0.0s, AutomataDifference: 0.5s, DeadEndRemovalTime: 0.0s, HoareAnnotationTime: 0.0s, InitialAbstractionConstructionTime: 0.0s, HoareTripleCheckerStatistics: 0 mSolverCounterUnknown, 14 SdHoareTripleChecker+Valid, 0.3s IncrementalHoareTripleChecker+Time, 0 mSdLazyCounter, 5 mSDsluCounter, 3106 SdHoareTripleChecker+Invalid, 0.3s Time, 0 mProtectedAction, 0 SdHoareTripleChecker+Unchecked, 0 IncrementalHoareTripleChecker+Unchecked, 2560 mSDsCounter, 0 IncrementalHoareTripleChecker+Valid, 0 mProtectedPredicate, 212 IncrementalHoareTripleChecker+Invalid, 212 SdHoareTripleChecker+Unknown, 0 mSolverCounterNotChecked, 0 mSolverCounterUnsat, 546 mSDtfsCounter, 212 mSolverCounterSat, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Unknown, PredicateUnifierStatistics: 0 DeclaredPredicates, 44 GetRequests, 15 SyntacticMatches, 0 SemanticMatches, 29 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 2 ImplicationChecksByTransitivity, 0.1s Time, 0.0s BasicInterpolantAutomatonTime, BiggestAbstraction: size=98occurred in iteration=3, InterpolantAutomatonStates: 41, traceCheckStatistics: No data available, InterpolantConsolidationStatistics: No data available, PathInvariantsStatistics: No data available, 0/0 InterpolantCoveringCapability, TotalInterpolationStatistics: No data available, 0.0s DumpTime, AutomataMinimizationStatistics: 0.0s AutomataMinimizationTime, 6 MinimizatonAttempts, 19 StatesRemovedByMinimization, 4 NontrivialMinimizations, HoareAnnotationStatistics: No data available, RefinementEngineStatistics: TRACE_CHECK: 0.0s SsaConstructionTime, 0.1s SatisfiabilityAnalysisTime, 1.1s InterpolantComputationTime, 393 NumberOfCodeBlocks, 393 NumberOfCodeBlocksAsserted, 6 NumberOfCheckSat, 387 ConstructedInterpolants, 0 QuantifiedInterpolants, 523 SizeOfPredicates, 0 NumberOfNonLiveVariables, 0 ConjunctsInSsa, 0 ConjunctsInUnsatCore, 6 InterpolantComputations, 6 PerfectInterpolantSequences, 0/0 InterpolantCoveringCapability, INVARIANT_SYNTHESIS: No data available, INTERPOLANT_CONSOLIDATION: No data available, ABSTRACT_INTERPRETATION: No data available, PDR: No data available, ACCELERATED_INTERPOLATION: No data available, SIFA: No data available, ReuseStatistics: No data available, ConComCheckerStatistics: No data available
  - AllSpecificationsHoldResult: All specifications hold
    1 specifications checked. All of them hold
RESULT: Ultimate proved your program to be correct!
[2025-05-07 17:29:17,278 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000 (1)] Ended with exit code 0
Received shutdown request...
sat
