./chc-comp-wrapper.sh ../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/invariants/loop_nested_for.sol_1_no_adts_000.smt2 .


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-05-07 17:27:56,304 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-05-07 17:27:56,342 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_bd72f29f-2863-4696-9630-e2e3e0cf2c3a/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-05-07 17:27:56,345 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-05-07 17:27:56,346 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-05-07 17:27:56,359 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-05-07 17:27:56,359 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-05-07 17:27:56,359 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-05-07 17:27:56,359 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-05-07 17:27:56,359 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-05-07 17:27:56,360 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-05-07 17:27:56,360 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-05-07 17:27:56,360 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-05-07 17:27:56,360 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-05-07 17:27:56,360 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-05-07 17:27:56,360 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-05-07 17:27:56,360 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-05-07 17:27:56,360 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-05-07 17:27:56,360 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-05-07 17:27:56,361 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-05-07 17:27:56,361 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-05-07 17:27:56,361 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-05-07 17:27:56,361 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-05-07 17:27:56,361 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-05-07 17:27:56,361 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-05-07 17:27:56,362 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-05-07 17:27:56,362 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-05-07 17:27:56,539 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-05-07 17:27:56,545 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-05-07 17:27:56,547 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-05-07 17:27:56,548 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-05-07 17:27:56,548 INFO  L274        PluginConnector]: SmtParser initialized
[2025-05-07 17:27:56,549 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_bd72f29f-2863-4696-9630-e2e3e0cf2c3a/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/invariants/loop_nested_for.sol_1_no_adts_000.smt2
[2025-05-07 17:27:56,550 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-05-07 17:27:56,552 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-05-07 17:27:56,755 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_bd72f29f-2863-4696-9630-e2e3e0cf2c3a/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/invariants/loop_nested_for.sol_1_no_adts_000.smt2
[2025-05-07 17:27:56,758 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-05-07 17:27:56,759 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-05-07 17:27:56,760 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-05-07 17:27:56,761 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-05-07 17:27:56,761 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-05-07 17:27:56,763 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,800 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56 Unit
[2025-05-07 17:27:56,800 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-05-07 17:27:56,801 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-05-07 17:27:56,801 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-05-07 17:27:56,801 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-05-07 17:27:56,816 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,817 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,845 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,845 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,850 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,851 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,852 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,854 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,855 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,864 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-05-07 17:27:56,865 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-05-07 17:27:56,865 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-05-07 17:27:56,865 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-05-07 17:27:56,866 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (1/1) ...
[2025-05-07 17:27:56,867 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-05-07 17:27:56,875 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:27:56,884 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:27:56,887 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:27:56,895 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-05-07 17:27:56,895 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-05-07 17:27:56,895 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-05-07 17:27:56,895 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure error_target_4_0 given in one single declaration
[2025-05-07 17:27:56,895 INFO  L130     BoogieDeclarations]: Found specification of procedure error_target_4_0
[2025-05-07 17:27:56,895 INFO  L138     BoogieDeclarations]: Found implementation of procedure error_target_4_0
[2025-05-07 17:27:56,895 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_4_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,895 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_4_function_f__46_47_0
[2025-05-07 17:27:56,895 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_4_function_f__46_47_0
[2025-05-07 17:27:56,895 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_3_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,896 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_3_function_f__46_47_0
[2025-05-07 17:27:56,896 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_3_function_f__46_47_0
[2025-05-07 17:27:56,896 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_16_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,896 INFO  L130     BoogieDeclarations]: Found specification of procedure block_16_function_f__46_47_0
[2025-05-07 17:27:56,896 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_16_function_f__46_47_0
[2025-05-07 17:27:56,896 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_14_f_45_47_0 given in one single declaration
[2025-05-07 17:27:56,896 INFO  L130     BoogieDeclarations]: Found specification of procedure block_14_f_45_47_0
[2025-05-07 17:27:56,896 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_14_f_45_47_0
[2025-05-07 17:27:56,896 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_12_for_header_f_30_47_0 given in one single declaration
[2025-05-07 17:27:56,896 INFO  L130     BoogieDeclarations]: Found specification of procedure block_12_for_header_f_30_47_0
[2025-05-07 17:27:56,896 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_12_for_header_f_30_47_0
[2025-05-07 17:27:56,896 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_15_for_post_f_28_47_0 given in one single declaration
[2025-05-07 17:27:56,897 INFO  L130     BoogieDeclarations]: Found specification of procedure block_15_for_post_f_28_47_0
[2025-05-07 17:27:56,897 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_15_for_post_f_28_47_0
[2025-05-07 17:27:56,897 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_13_for_body_f_29_47_0 given in one single declaration
[2025-05-07 17:27:56,897 INFO  L130     BoogieDeclarations]: Found specification of procedure block_13_for_body_f_29_47_0
[2025-05-07 17:27:56,897 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_13_for_body_f_29_47_0
[2025-05-07 17:27:56,897 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_9_for_body_f_37_47_0 given in one single declaration
[2025-05-07 17:27:56,897 INFO  L130     BoogieDeclarations]: Found specification of procedure block_9_for_body_f_37_47_0
[2025-05-07 17:27:56,897 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_9_for_body_f_37_47_0
[2025-05-07 17:27:56,897 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_8_for_header_f_38_47_0 given in one single declaration
[2025-05-07 17:27:56,897 INFO  L130     BoogieDeclarations]: Found specification of procedure block_8_for_header_f_38_47_0
[2025-05-07 17:27:56,897 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_8_for_header_f_38_47_0
[2025-05-07 17:27:56,897 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_11_for_post_f_18_47_0 given in one single declaration
[2025-05-07 17:27:56,897 INFO  L130     BoogieDeclarations]: Found specification of procedure block_11_for_post_f_18_47_0
[2025-05-07 17:27:56,898 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_11_for_post_f_18_47_0
[2025-05-07 17:27:56,898 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_6_f_45_47_0 given in one single declaration
[2025-05-07 17:27:56,898 INFO  L130     BoogieDeclarations]: Found specification of procedure block_6_f_45_47_0
[2025-05-07 17:27:56,898 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_6_f_45_47_0
[2025-05-07 17:27:56,898 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_5_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,898 INFO  L130     BoogieDeclarations]: Found specification of procedure block_5_function_f__46_47_0
[2025-05-07 17:27:56,898 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_5_function_f__46_47_0
[2025-05-07 17:27:56,898 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_7_return_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,898 INFO  L130     BoogieDeclarations]: Found specification of procedure block_7_return_function_f__46_47_0
[2025-05-07 17:27:56,898 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_7_return_function_f__46_47_0
[2025-05-07 17:27:56,898 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_10_f_45_47_0 given in one single declaration
[2025-05-07 17:27:56,898 INFO  L130     BoogieDeclarations]: Found specification of procedure block_10_f_45_47_0
[2025-05-07 17:27:56,898 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_10_f_45_47_0
[2025-05-07 17:27:56,898 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_17_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,899 INFO  L130     BoogieDeclarations]: Found specification of procedure block_17_function_f__46_47_0
[2025-05-07 17:27:56,899 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_17_function_f__46_47_0
[2025-05-07 17:27:56,899 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_18_function_f__46_47_0 given in one single declaration
[2025-05-07 17:27:56,899 INFO  L130     BoogieDeclarations]: Found specification of procedure block_18_function_f__46_47_0
[2025-05-07 17:27:56,899 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_18_function_f__46_47_0
[2025-05-07 17:27:56,899 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure interface_0_Simple_47_0 given in one single declaration
[2025-05-07 17:27:56,899 INFO  L130     BoogieDeclarations]: Found specification of procedure interface_0_Simple_47_0
[2025-05-07 17:27:56,899 INFO  L138     BoogieDeclarations]: Found implementation of procedure interface_0_Simple_47_0
[2025-05-07 17:27:56,899 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_constructor_2_Simple_47_0 given in one single declaration
[2025-05-07 17:27:56,899 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_constructor_2_Simple_47_0
[2025-05-07 17:27:56,899 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_constructor_2_Simple_47_0
[2025-05-07 17:27:56,899 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_19_Simple_47_0 given in one single declaration
[2025-05-07 17:27:56,899 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_19_Simple_47_0
[2025-05-07 17:27:56,899 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_19_Simple_47_0
[2025-05-07 17:27:56,899 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_after_init_21_Simple_47_0 given in one single declaration
[2025-05-07 17:27:56,899 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_after_init_21_Simple_47_0
[2025-05-07 17:27:56,900 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_after_init_21_Simple_47_0
[2025-05-07 17:27:56,900 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_entry_20_Simple_47_0 given in one single declaration
[2025-05-07 17:27:56,900 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_entry_20_Simple_47_0
[2025-05-07 17:27:56,900 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_entry_20_Simple_47_0
[2025-05-07 17:27:56,900 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure implicit_constructor_entry_22_Simple_47_0 given in one single declaration
[2025-05-07 17:27:56,900 INFO  L130     BoogieDeclarations]: Found specification of procedure implicit_constructor_entry_22_Simple_47_0
[2025-05-07 17:27:56,900 INFO  L138     BoogieDeclarations]: Found implementation of procedure implicit_constructor_entry_22_Simple_47_0
[2025-05-07 17:27:56,900 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-05-07 17:27:56,900 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-05-07 17:27:56,900 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-05-07 17:27:57,022 INFO  L234             CfgBuilder]: Building ICFG
[2025-05-07 17:27:57,023 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-05-07 17:27:57,205 INFO  L?                        ?]: Removed 141 outVars from TransFormulas that were not future-live.
[2025-05-07 17:27:57,205 INFO  L283             CfgBuilder]: Performing block encoding
[2025-05-07 17:27:57,213 INFO  L304             CfgBuilder]: Using library mode
[2025-05-07 17:27:57,214 INFO  L312             CfgBuilder]: Removed 9 assume(true) statements.
[2025-05-07 17:27:57,214 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 07.05 05:27:57 BoogieIcfgContainer
[2025-05-07 17:27:57,214 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-05-07 17:27:57,215 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-05-07 17:27:57,216 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-05-07 17:27:57,218 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-05-07 17:27:57,218 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 07.05 05:27:56" (1/3) ...
[2025-05-07 17:27:57,219 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@3db39982 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 07.05 05:27:57, skipping insertion in model container
[2025-05-07 17:27:57,219 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:27:56" (2/3) ...
[2025-05-07 17:27:57,219 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@3db39982 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 07.05 05:27:57, skipping insertion in model container
[2025-05-07 17:27:57,219 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 07.05 05:27:57" (3/3) ...
[2025-05-07 17:27:57,220 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-05-07 17:27:57,230 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-05-07 17:27:57,232 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 25 procedures, 99 locations, 144 edges, 25 initial locations, 0 loop locations, and 1 error locations.
[2025-05-07 17:27:57,261 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-05-07 17:27:57,270 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;@1209a5f1, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-05-07 17:27:57,270 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-05-07 17:27:57,273 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 99 states, 43 states have (on average 1.1162790697674418) internal successors, (48), 48 states have internal predecessors, (48), 30 states have call successors, (32), 24 states have call predecessors, (32), 24 states have return successors, (32), 26 states have call predecessors, (32), 30 states have call successors, (32)
[2025-05-07 17:27:57,279 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 60
[2025-05-07 17:27:57,280 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:27:57,280 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]
[2025-05-07 17:27:57,280 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:27:57,284 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:27:57,284 INFO  L85        PathProgramCache]: Analyzing trace with hash -609946307, now seen corresponding path program 1 times
[2025-05-07 17:27:57,289 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:27:57,290 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1929535494]
[2025-05-07 17:27:57,290 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:27:57,290 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:27:57,332 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 59 statements into 1 equivalence classes.
[2025-05-07 17:27:57,350 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 59 of 59 statements.
[2025-05-07 17:27:57,350 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:27:57,350 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:27:57,566 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:27:57,566 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:27:57,567 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1929535494]
[2025-05-07 17:27:57,567 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1929535494] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:27:57,567 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:27:57,570 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [] total 4
[2025-05-07 17:27:57,571 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [2115697019]
[2025-05-07 17:27:57,572 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:27:57,576 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-05-07 17:27:57,576 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:27:57,610 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-05-07 17:27:57,610 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:27:57,615 INFO  L87              Difference]: Start difference. First operand  has 99 states, 43 states have (on average 1.1162790697674418) internal successors, (48), 48 states have internal predecessors, (48), 30 states have call successors, (32), 24 states have call predecessors, (32), 24 states have return successors, (32), 26 states have call predecessors, (32), 30 states have call successors, (32) Second operand  has 4 states, 3 states have (on average 9.0) internal successors, (27), 4 states have internal predecessors, (27), 4 states have call successors, (16), 1 states have call predecessors, (16), 3 states have return successors, (16), 3 states have call predecessors, (16), 4 states have call successors, (16)
[2025-05-07 17:27:57,654 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:27:57,654 INFO  L93              Difference]: Finished difference Result 101 states and 114 transitions.
[2025-05-07 17:27:57,656 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-05-07 17:27:57,657 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 9.0) internal successors, (27), 4 states have internal predecessors, (27), 4 states have call successors, (16), 1 states have call predecessors, (16), 3 states have return successors, (16), 3 states have call predecessors, (16), 4 states have call successors, (16) Word has length 59
[2025-05-07 17:27:57,657 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:27:57,663 INFO  L225             Difference]: With dead ends: 101
[2025-05-07 17:27:57,663 INFO  L226             Difference]: Without dead ends: 97
[2025-05-07 17:27:57,665 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 4 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 2 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:27:57,667 INFO  L437           NwaCegarLoop]: 110 mSDtfsCounter, 1 mSDsluCounter, 213 mSDsCounter, 0 mSdLazyCounter, 2 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 323 SdHoareTripleChecker+Invalid, 2 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 2 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:27:57,667 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 323 Invalid, 2 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 2 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:27:57,677 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 97 states.
[2025-05-07 17:27:57,694 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 97 to 95.
[2025-05-07 17:27:57,695 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 95 states, 42 states have (on average 1.0714285714285714) internal successors, (45), 45 states have internal predecessors, (45), 28 states have call successors, (30), 24 states have call predecessors, (30), 24 states have return successors, (30), 25 states have call predecessors, (30), 28 states have call successors, (30)
[2025-05-07 17:27:57,699 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 95 states to 95 states and 105 transitions.
[2025-05-07 17:27:57,700 INFO  L79                 Accepts]: Start accepts. Automaton has 95 states and 105 transitions. Word has length 59
[2025-05-07 17:27:57,700 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:27:57,701 INFO  L485      AbstractCegarLoop]: Abstraction has 95 states and 105 transitions.
[2025-05-07 17:27:57,701 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 9.0) internal successors, (27), 4 states have internal predecessors, (27), 4 states have call successors, (16), 1 states have call predecessors, (16), 3 states have return successors, (16), 3 states have call predecessors, (16), 4 states have call successors, (16)
[2025-05-07 17:27:57,701 INFO  L278                IsEmpty]: Start isEmpty. Operand 95 states and 105 transitions.
[2025-05-07 17:27:57,704 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 60
[2025-05-07 17:27:57,705 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:27:57,705 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]
[2025-05-07 17:27:57,705 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-05-07 17:27:57,705 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:27:57,706 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:27:57,706 INFO  L85        PathProgramCache]: Analyzing trace with hash 918944853, now seen corresponding path program 1 times
[2025-05-07 17:27:57,706 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:27:57,706 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [575063000]
[2025-05-07 17:27:57,706 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:27:57,707 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:27:57,743 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 59 statements into 1 equivalence classes.
[2025-05-07 17:27:57,772 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 59 of 59 statements.
[2025-05-07 17:27:57,772 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:27:57,772 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:27:58,095 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:27:58,096 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:27:58,096 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [575063000]
[2025-05-07 17:27:58,096 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [575063000] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:27:58,096 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:27:58,096 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [] total 4
[2025-05-07 17:27:58,096 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1383516234]
[2025-05-07 17:27:58,096 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:27:58,097 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-05-07 17:27:58,097 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:27:58,098 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-05-07 17:27:58,098 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:27:58,098 INFO  L87              Difference]: Start difference. First operand 95 states and 105 transitions. Second operand  has 4 states, 3 states have (on average 9.0) internal successors, (27), 4 states have internal predecessors, (27), 3 states have call successors, (16), 1 states have call predecessors, (16), 3 states have return successors, (16), 3 states have call predecessors, (16), 3 states have call successors, (16)
[2025-05-07 17:27:58,139 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:27:58,140 INFO  L93              Difference]: Finished difference Result 97 states and 107 transitions.
[2025-05-07 17:27:58,140 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-05-07 17:27:58,140 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 9.0) internal successors, (27), 4 states have internal predecessors, (27), 3 states have call successors, (16), 1 states have call predecessors, (16), 3 states have return successors, (16), 3 states have call predecessors, (16), 3 states have call successors, (16) Word has length 59
[2025-05-07 17:27:58,141 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:27:58,142 INFO  L225             Difference]: With dead ends: 97
[2025-05-07 17:27:58,142 INFO  L226             Difference]: Without dead ends: 97
[2025-05-07 17:27:58,142 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 6 GetRequests, 4 SyntacticMatches, 0 SemanticMatches, 2 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:27:58,143 INFO  L437           NwaCegarLoop]: 102 mSDtfsCounter, 1 mSDsluCounter, 194 mSDsCounter, 0 mSdLazyCounter, 14 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 296 SdHoareTripleChecker+Invalid, 14 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 14 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:27:58,143 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 296 Invalid, 14 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 14 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:27:58,144 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 97 states.
[2025-05-07 17:27:58,150 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 97 to 97.
[2025-05-07 17:27:58,151 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 97 states, 43 states have (on average 1.069767441860465) internal successors, (46), 46 states have internal predecessors, (46), 28 states have call successors, (30), 24 states have call predecessors, (30), 25 states have return successors, (31), 26 states have call predecessors, (31), 28 states have call successors, (31)
[2025-05-07 17:27:58,152 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 97 states to 97 states and 107 transitions.
[2025-05-07 17:27:58,152 INFO  L79                 Accepts]: Start accepts. Automaton has 97 states and 107 transitions. Word has length 59
[2025-05-07 17:27:58,153 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:27:58,153 INFO  L485      AbstractCegarLoop]: Abstraction has 97 states and 107 transitions.
[2025-05-07 17:27:58,153 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 9.0) internal successors, (27), 4 states have internal predecessors, (27), 3 states have call successors, (16), 1 states have call predecessors, (16), 3 states have return successors, (16), 3 states have call predecessors, (16), 3 states have call successors, (16)
[2025-05-07 17:27:58,154 INFO  L278                IsEmpty]: Start isEmpty. Operand 97 states and 107 transitions.
[2025-05-07 17:27:58,155 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 68
[2025-05-07 17:27:58,155 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:27:58,155 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]
[2025-05-07 17:27:58,155 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2
[2025-05-07 17:27:58,155 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:27:58,156 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:27:58,156 INFO  L85        PathProgramCache]: Analyzing trace with hash -540595372, now seen corresponding path program 1 times
[2025-05-07 17:27:58,156 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:27:58,156 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [146605382]
[2025-05-07 17:27:58,156 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:27:58,156 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:27:58,182 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 67 statements into 1 equivalence classes.
[2025-05-07 17:27:58,207 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 67 of 67 statements.
[2025-05-07 17:27:58,207 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:27:58,207 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:27:58,347 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:27:58,347 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:27:58,347 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [146605382]
[2025-05-07 17:27:58,347 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [146605382] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:27:58,347 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:27:58,347 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [] total 4
[2025-05-07 17:27:58,348 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [156672450]
[2025-05-07 17:27:58,348 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:27:58,348 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-05-07 17:27:58,348 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:27:58,349 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-05-07 17:27:58,349 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:27:58,349 INFO  L87              Difference]: Start difference. First operand 97 states and 107 transitions. Second operand  has 4 states, 3 states have (on average 10.333333333333334) internal successors, (31), 4 states have internal predecessors, (31), 3 states have call successors, (18), 1 states have call predecessors, (18), 3 states have return successors, (18), 3 states have call predecessors, (18), 3 states have call successors, (18)
[2025-05-07 17:27:58,386 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:27:58,386 INFO  L93              Difference]: Finished difference Result 99 states and 109 transitions.
[2025-05-07 17:27:58,386 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-05-07 17:27:58,387 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 10.333333333333334) internal successors, (31), 4 states have internal predecessors, (31), 3 states have call successors, (18), 1 states have call predecessors, (18), 3 states have return successors, (18), 3 states have call predecessors, (18), 3 states have call successors, (18) Word has length 67
[2025-05-07 17:27:58,387 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:27:58,388 INFO  L225             Difference]: With dead ends: 99
[2025-05-07 17:27:58,388 INFO  L226             Difference]: Without dead ends: 99
[2025-05-07 17:27:58,389 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 6 GetRequests, 4 SyntacticMatches, 0 SemanticMatches, 2 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:27:58,389 INFO  L437           NwaCegarLoop]: 102 mSDtfsCounter, 1 mSDsluCounter, 194 mSDsCounter, 0 mSdLazyCounter, 14 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 296 SdHoareTripleChecker+Invalid, 14 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 14 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:27:58,390 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 296 Invalid, 14 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 14 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:27:58,391 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 99 states.
[2025-05-07 17:27:58,398 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 99 to 99.
[2025-05-07 17:27:58,398 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 99 states, 44 states have (on average 1.0681818181818181) internal successors, (47), 47 states have internal predecessors, (47), 28 states have call successors, (30), 24 states have call predecessors, (30), 26 states have return successors, (32), 27 states have call predecessors, (32), 28 states have call successors, (32)
[2025-05-07 17:27:58,400 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 99 states to 99 states and 109 transitions.
[2025-05-07 17:27:58,400 INFO  L79                 Accepts]: Start accepts. Automaton has 99 states and 109 transitions. Word has length 67
[2025-05-07 17:27:58,401 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:27:58,401 INFO  L485      AbstractCegarLoop]: Abstraction has 99 states and 109 transitions.
[2025-05-07 17:27:58,401 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 10.333333333333334) internal successors, (31), 4 states have internal predecessors, (31), 3 states have call successors, (18), 1 states have call predecessors, (18), 3 states have return successors, (18), 3 states have call predecessors, (18), 3 states have call successors, (18)
[2025-05-07 17:27:58,401 INFO  L278                IsEmpty]: Start isEmpty. Operand 99 states and 109 transitions.
[2025-05-07 17:27:58,402 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 79
[2025-05-07 17:27:58,403 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:27:58,403 INFO  L218           NwaCegarLoop]: trace histogram [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, 1, 1, 1, 1, 1, 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:27:58,403 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3
[2025-05-07 17:27:58,403 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:27:58,403 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:27:58,403 INFO  L85        PathProgramCache]: Analyzing trace with hash 1518187876, now seen corresponding path program 1 times
[2025-05-07 17:27:58,403 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:27:58,404 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1386353045]
[2025-05-07 17:27:58,404 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:27:58,404 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:27:58,424 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 78 statements into 1 equivalence classes.
[2025-05-07 17:27:58,437 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 78 of 78 statements.
[2025-05-07 17:27:58,437 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:27:58,437 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:27:58,699 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-05-07 17:27:58,699 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:27:58,699 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1386353045]
[2025-05-07 17:27:58,699 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1386353045] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:27:58,699 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [2071793235]
[2025-05-07 17:27:58,699 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:27:58,700 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:27:58,701 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:27:58,703 INFO  L229       MonitoredProcess]: Starting monitored process 2 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-05-07 17:27:58,704 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-05-07 17:27:58,874 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 78 statements into 1 equivalence classes.
[2025-05-07 17:27:58,995 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 78 of 78 statements.
[2025-05-07 17:27:58,995 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:27:58,995 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:27:59,000 INFO  L256         TraceCheckSpWp]: Trace formula consists of 985 conjuncts, 13 conjuncts are in the unsatisfiable core
[2025-05-07 17:27:59,005 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:27:59,062 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-05-07 17:27:59,062 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-05-07 17:28:00,397 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 2 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-05-07 17:28:00,397 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [2071793235] provided 0 perfect and 2 imperfect interpolant sequences
[2025-05-07 17:28:00,397 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-05-07 17:28:00,397 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [8, 8, 8] total 10
[2025-05-07 17:28:00,397 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1584363495]
[2025-05-07 17:28:00,397 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-05-07 17:28:00,398 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-05-07 17:28:00,398 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:28:00,398 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-05-07 17:28:00,398 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=22, Invalid=68, Unknown=0, NotChecked=0, Total=90
[2025-05-07 17:28:00,398 INFO  L87              Difference]: Start difference. First operand 99 states and 109 transitions. Second operand  has 10 states, 6 states have (on average 6.333333333333333) internal successors, (38), 10 states have internal predecessors, (38), 6 states have call successors, (23), 1 states have call predecessors, (23), 6 states have return successors, (23), 6 states have call predecessors, (23), 6 states have call successors, (23)
[2025-05-07 17:28:00,479 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:28:00,479 INFO  L93              Difference]: Finished difference Result 105 states and 115 transitions.
[2025-05-07 17:28:00,479 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-05-07 17:28:00,480 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 6 states have (on average 6.333333333333333) internal successors, (38), 10 states have internal predecessors, (38), 6 states have call successors, (23), 1 states have call predecessors, (23), 6 states have return successors, (23), 6 states have call predecessors, (23), 6 states have call successors, (23) Word has length 78
[2025-05-07 17:28:00,480 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:28:00,481 INFO  L225             Difference]: With dead ends: 105
[2025-05-07 17:28:00,481 INFO  L226             Difference]: Without dead ends: 105
[2025-05-07 17:28:00,481 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 166 GetRequests, 153 SyntacticMatches, 4 SemanticMatches, 9 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 13 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=27, Invalid=83, Unknown=0, NotChecked=0, Total=110
[2025-05-07 17:28:00,481 INFO  L437           NwaCegarLoop]: 100 mSDtfsCounter, 4 mSDsluCounter, 579 mSDsCounter, 0 mSdLazyCounter, 59 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 679 SdHoareTripleChecker+Invalid, 60 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 59 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:28:00,481 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 679 Invalid, 60 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 59 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:28:00,482 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 105 states.
[2025-05-07 17:28:00,486 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 105 to 105.
[2025-05-07 17:28:00,486 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 105 states, 47 states have (on average 1.0638297872340425) internal successors, (50), 50 states have internal predecessors, (50), 28 states have call successors, (30), 24 states have call predecessors, (30), 29 states have return successors, (35), 30 states have call predecessors, (35), 28 states have call successors, (35)
[2025-05-07 17:28:00,487 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 105 states to 105 states and 115 transitions.
[2025-05-07 17:28:00,487 INFO  L79                 Accepts]: Start accepts. Automaton has 105 states and 115 transitions. Word has length 78
[2025-05-07 17:28:00,487 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:28:00,487 INFO  L485      AbstractCegarLoop]: Abstraction has 105 states and 115 transitions.
[2025-05-07 17:28:00,487 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 6 states have (on average 6.333333333333333) internal successors, (38), 10 states have internal predecessors, (38), 6 states have call successors, (23), 1 states have call predecessors, (23), 6 states have return successors, (23), 6 states have call predecessors, (23), 6 states have call successors, (23)
[2025-05-07 17:28:00,487 INFO  L278                IsEmpty]: Start isEmpty. Operand 105 states and 115 transitions.
[2025-05-07 17:28:00,488 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 90
[2025-05-07 17:28:00,488 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:28:00,488 INFO  L218           NwaCegarLoop]: trace histogram [3, 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:28:00,495 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-05-07 17:28:00,689 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable4,2 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:00,690 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:28:00,691 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:28:00,691 INFO  L85        PathProgramCache]: Analyzing trace with hash -1966208148, now seen corresponding path program 2 times
[2025-05-07 17:28:00,692 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:28:00,692 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1871502424]
[2025-05-07 17:28:00,692 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-05-07 17:28:00,692 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:28:00,756 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 89 statements into 2 equivalence classes.
[2025-05-07 17:28:00,778 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 89 of 89 statements.
[2025-05-07 17:28:00,778 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-05-07 17:28:00,778 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:01,077 INFO  L134       CoverageAnalysis]: Checked inductivity of 17 backedges. 0 proven. 10 refuted. 0 times theorem prover too weak. 7 trivial. 0 not checked.
[2025-05-07 17:28:01,078 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:28:01,078 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1871502424]
[2025-05-07 17:28:01,078 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1871502424] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:28:01,078 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [514570630]
[2025-05-07 17:28:01,078 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-05-07 17:28:01,078 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:01,080 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:28:01,082 INFO  L229       MonitoredProcess]: Starting monitored process 3 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-05-07 17:28:01,083 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-05-07 17:28:01,291 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 89 statements into 2 equivalence classes.
[2025-05-07 17:28:01,406 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 89 of 89 statements.
[2025-05-07 17:28:01,406 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-05-07 17:28:01,406 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:01,410 INFO  L256         TraceCheckSpWp]: Trace formula consists of 1142 conjuncts, 21 conjuncts are in the unsatisfiable core
[2025-05-07 17:28:01,414 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:28:01,481 INFO  L134       CoverageAnalysis]: Checked inductivity of 17 backedges. 8 proven. 2 refuted. 0 times theorem prover too weak. 7 trivial. 0 not checked.
[2025-05-07 17:28:01,482 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-05-07 17:28:03,326 INFO  L134       CoverageAnalysis]: Checked inductivity of 17 backedges. 8 proven. 2 refuted. 0 times theorem prover too weak. 7 trivial. 0 not checked.
[2025-05-07 17:28:03,326 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [514570630] provided 0 perfect and 2 imperfect interpolant sequences
[2025-05-07 17:28:03,327 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-05-07 17:28:03,327 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [11, 9, 9] total 17
[2025-05-07 17:28:03,327 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [880578388]
[2025-05-07 17:28:03,327 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-05-07 17:28:03,327 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 17 states
[2025-05-07 17:28:03,327 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:28:03,328 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 17 interpolants.
[2025-05-07 17:28:03,328 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=49, Invalid=223, Unknown=0, NotChecked=0, Total=272
[2025-05-07 17:28:03,328 INFO  L87              Difference]: Start difference. First operand 105 states and 115 transitions. Second operand  has 17 states, 13 states have (on average 3.923076923076923) internal successors, (51), 17 states have internal predecessors, (51), 7 states have call successors, (26), 1 states have call predecessors, (26), 13 states have return successors, (34), 13 states have call predecessors, (34), 7 states have call successors, (34)
[2025-05-07 17:28:03,437 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:28:03,437 INFO  L93              Difference]: Finished difference Result 111 states and 124 transitions.
[2025-05-07 17:28:03,437 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 17 states. 
[2025-05-07 17:28:03,437 INFO  L79                 Accepts]: Start accepts. Automaton has  has 17 states, 13 states have (on average 3.923076923076923) internal successors, (51), 17 states have internal predecessors, (51), 7 states have call successors, (26), 1 states have call predecessors, (26), 13 states have return successors, (34), 13 states have call predecessors, (34), 7 states have call successors, (34) Word has length 89
[2025-05-07 17:28:03,438 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:28:03,439 INFO  L225             Difference]: With dead ends: 111
[2025-05-07 17:28:03,439 INFO  L226             Difference]: Without dead ends: 109
[2025-05-07 17:28:03,439 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 194 GetRequests, 172 SyntacticMatches, 4 SemanticMatches, 18 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 56 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=70, Invalid=310, Unknown=0, NotChecked=0, Total=380
[2025-05-07 17:28:03,440 INFO  L437           NwaCegarLoop]: 99 mSDtfsCounter, 4 mSDsluCounter, 771 mSDsCounter, 0 mSdLazyCounter, 90 mSolverCounterSat, 5 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 870 SdHoareTripleChecker+Invalid, 95 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 5 IncrementalHoareTripleChecker+Valid, 90 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:28:03,440 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 870 Invalid, 95 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [5 Valid, 90 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:28:03,441 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 109 states.
[2025-05-07 17:28:03,447 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 109 to 109.
[2025-05-07 17:28:03,448 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 109 states, 49 states have (on average 1.0816326530612246) internal successors, (53), 52 states have internal predecessors, (53), 28 states have call successors, (29), 24 states have call predecessors, (29), 31 states have return successors, (37), 32 states have call predecessors, (37), 28 states have call successors, (37)
[2025-05-07 17:28:03,449 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 109 states to 109 states and 119 transitions.
[2025-05-07 17:28:03,449 INFO  L79                 Accepts]: Start accepts. Automaton has 109 states and 119 transitions. Word has length 89
[2025-05-07 17:28:03,449 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:28:03,449 INFO  L485      AbstractCegarLoop]: Abstraction has 109 states and 119 transitions.
[2025-05-07 17:28:03,449 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 17 states, 13 states have (on average 3.923076923076923) internal successors, (51), 17 states have internal predecessors, (51), 7 states have call successors, (26), 1 states have call predecessors, (26), 13 states have return successors, (34), 13 states have call predecessors, (34), 7 states have call successors, (34)
[2025-05-07 17:28:03,449 INFO  L278                IsEmpty]: Start isEmpty. Operand 109 states and 119 transitions.
[2025-05-07 17:28:03,451 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 113
[2025-05-07 17:28:03,451 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:28:03,451 INFO  L218           NwaCegarLoop]: trace histogram [4, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 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, 1, 1, 1, 1, 1, 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:28:03,455 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Ended with exit code 0
[2025-05-07 17:28:03,651 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable5,3 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:03,652 INFO  L403      AbstractCegarLoop]: === Iteration 6 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:28:03,653 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:28:03,654 INFO  L85        PathProgramCache]: Analyzing trace with hash 1578488643, now seen corresponding path program 1 times
[2025-05-07 17:28:03,654 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:28:03,654 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [546036757]
[2025-05-07 17:28:03,655 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:28:03,655 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:28:03,716 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 112 statements into 1 equivalence classes.
[2025-05-07 17:28:03,741 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 112 of 112 statements.
[2025-05-07 17:28:03,741 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:28:03,741 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:03,837 INFO  L134       CoverageAnalysis]: Checked inductivity of 45 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 45 trivial. 0 not checked.
[2025-05-07 17:28:03,837 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:28:03,837 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [546036757]
[2025-05-07 17:28:03,837 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [546036757] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:28:03,837 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:28:03,837 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [] total 6
[2025-05-07 17:28:03,837 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1486315100]
[2025-05-07 17:28:03,837 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:28:03,838 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-05-07 17:28:03,838 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:28:03,838 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-05-07 17:28:03,838 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=9, Invalid=21, Unknown=0, NotChecked=0, Total=30
[2025-05-07 17:28:03,839 INFO  L87              Difference]: Start difference. First operand 109 states and 119 transitions. Second operand  has 6 states, 5 states have (on average 8.0) internal successors, (40), 6 states have internal predecessors, (40), 3 states have call successors, (24), 1 states have call predecessors, (24), 5 states have return successors, (24), 6 states have call predecessors, (24), 3 states have call successors, (24)
[2025-05-07 17:28:03,862 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:28:03,863 INFO  L93              Difference]: Finished difference Result 113 states and 123 transitions.
[2025-05-07 17:28:03,863 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-05-07 17:28:03,863 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 5 states have (on average 8.0) internal successors, (40), 6 states have internal predecessors, (40), 3 states have call successors, (24), 1 states have call predecessors, (24), 5 states have return successors, (24), 6 states have call predecessors, (24), 3 states have call successors, (24) Word has length 112
[2025-05-07 17:28:03,863 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:28:03,864 INFO  L225             Difference]: With dead ends: 113
[2025-05-07 17:28:03,864 INFO  L226             Difference]: Without dead ends: 113
[2025-05-07 17:28:03,864 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:28:03,865 INFO  L437           NwaCegarLoop]: 97 mSDtfsCounter, 1 mSDsluCounter, 378 mSDsCounter, 0 mSdLazyCounter, 17 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 475 SdHoareTripleChecker+Invalid, 17 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 17 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:28:03,865 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 475 Invalid, 17 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 17 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:28:03,865 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 113 states.
[2025-05-07 17:28:03,869 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 113 to 113.
[2025-05-07 17:28:03,869 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 113 states, 51 states have (on average 1.0784313725490196) internal successors, (55), 54 states have internal predecessors, (55), 28 states have call successors, (29), 24 states have call predecessors, (29), 33 states have return successors, (39), 34 states have call predecessors, (39), 28 states have call successors, (39)
[2025-05-07 17:28:03,870 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 113 states to 113 states and 123 transitions.
[2025-05-07 17:28:03,870 INFO  L79                 Accepts]: Start accepts. Automaton has 113 states and 123 transitions. Word has length 112
[2025-05-07 17:28:03,870 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:28:03,870 INFO  L485      AbstractCegarLoop]: Abstraction has 113 states and 123 transitions.
[2025-05-07 17:28:03,871 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 5 states have (on average 8.0) internal successors, (40), 6 states have internal predecessors, (40), 3 states have call successors, (24), 1 states have call predecessors, (24), 5 states have return successors, (24), 6 states have call predecessors, (24), 3 states have call successors, (24)
[2025-05-07 17:28:03,871 INFO  L278                IsEmpty]: Start isEmpty. Operand 113 states and 123 transitions.
[2025-05-07 17:28:03,871 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 113
[2025-05-07 17:28:03,872 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:28:03,872 INFO  L218           NwaCegarLoop]: trace histogram [4, 3, 3, 3, 3, 3, 3, 3, 3, 3, 3, 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, 1, 1, 1, 1, 1, 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:28:03,872 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable6
[2025-05-07 17:28:03,872 INFO  L403      AbstractCegarLoop]: === Iteration 7 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:28:03,872 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:28:03,872 INFO  L85        PathProgramCache]: Analyzing trace with hash 1491471363, now seen corresponding path program 1 times
[2025-05-07 17:28:03,872 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:28:03,872 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1591184339]
[2025-05-07 17:28:03,872 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:28:03,872 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:28:03,898 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 112 statements into 1 equivalence classes.
[2025-05-07 17:28:03,916 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 112 of 112 statements.
[2025-05-07 17:28:03,917 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:28:03,917 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:04,576 INFO  L134       CoverageAnalysis]: Checked inductivity of 45 backedges. 10 proven. 18 refuted. 0 times theorem prover too weak. 17 trivial. 0 not checked.
[2025-05-07 17:28:04,576 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:28:04,576 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1591184339]
[2025-05-07 17:28:04,576 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1591184339] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:28:04,576 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [261822736]
[2025-05-07 17:28:04,576 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:28:04,576 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:04,578 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:28:04,579 INFO  L229       MonitoredProcess]: Starting monitored process 4 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-05-07 17:28:04,580 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-05-07 17:28:04,777 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 112 statements into 1 equivalence classes.
[2025-05-07 17:28:04,892 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 112 of 112 statements.
[2025-05-07 17:28:04,892 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:28:04,892 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:04,896 INFO  L256         TraceCheckSpWp]: Trace formula consists of 1468 conjuncts, 23 conjuncts are in the unsatisfiable core
[2025-05-07 17:28:04,900 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:28:05,157 INFO  L134       CoverageAnalysis]: Checked inductivity of 45 backedges. 2 proven. 24 refuted. 0 times theorem prover too weak. 19 trivial. 0 not checked.
[2025-05-07 17:28:05,157 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-05-07 17:28:14,558 INFO  L134       CoverageAnalysis]: Checked inductivity of 45 backedges. 2 proven. 27 refuted. 0 times theorem prover too weak. 16 trivial. 0 not checked.
[2025-05-07 17:28:14,558 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [261822736] provided 0 perfect and 2 imperfect interpolant sequences
[2025-05-07 17:28:14,558 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-05-07 17:28:14,558 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [21, 14, 16] total 37
[2025-05-07 17:28:14,559 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [975419929]
[2025-05-07 17:28:14,559 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-05-07 17:28:14,559 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 37 states
[2025-05-07 17:28:14,560 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:28:14,561 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 37 interpolants.
[2025-05-07 17:28:14,562 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=101, Invalid=1231, Unknown=0, NotChecked=0, Total=1332
[2025-05-07 17:28:14,562 INFO  L87              Difference]: Start difference. First operand 113 states and 123 transitions. Second operand  has 37 states, 27 states have (on average 2.740740740740741) internal successors, (74), 37 states have internal predecessors, (74), 13 states have call successors, (35), 1 states have call predecessors, (35), 27 states have return successors, (50), 27 states have call predecessors, (50), 13 states have call successors, (50)
[2025-05-07 17:28:15,111 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:28:15,111 INFO  L93              Difference]: Finished difference Result 153 states and 166 transitions.
[2025-05-07 17:28:15,112 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 35 states. 
[2025-05-07 17:28:15,112 INFO  L79                 Accepts]: Start accepts. Automaton has  has 37 states, 27 states have (on average 2.740740740740741) internal successors, (74), 37 states have internal predecessors, (74), 13 states have call successors, (35), 1 states have call predecessors, (35), 27 states have return successors, (50), 27 states have call predecessors, (50), 13 states have call successors, (50) Word has length 112
[2025-05-07 17:28:15,112 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:28:15,113 INFO  L225             Difference]: With dead ends: 153
[2025-05-07 17:28:15,113 INFO  L226             Difference]: Without dead ends: 153
[2025-05-07 17:28:15,114 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 268 GetRequests, 203 SyntacticMatches, 10 SemanticMatches, 55 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 499 ImplicationChecksByTransitivity, 0.8s TimeCoverageRelationStatistics Valid=278, Invalid=2914, Unknown=0, NotChecked=0, Total=3192
[2025-05-07 17:28:15,114 INFO  L437           NwaCegarLoop]: 95 mSDtfsCounter, 37 mSDsluCounter, 2374 mSDsCounter, 0 mSdLazyCounter, 552 mSolverCounterSat, 40 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 42 SdHoareTripleChecker+Valid, 2469 SdHoareTripleChecker+Invalid, 592 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 40 IncrementalHoareTripleChecker+Valid, 552 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.3s IncrementalHoareTripleChecker+Time
[2025-05-07 17:28:15,114 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [42 Valid, 2469 Invalid, 592 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [40 Valid, 552 Invalid, 0 Unknown, 0 Unchecked, 0.3s Time]
[2025-05-07 17:28:15,115 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 153 states.
[2025-05-07 17:28:15,119 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 153 to 153.
[2025-05-07 17:28:15,120 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 153 states, 71 states have (on average 1.0422535211267605) internal successors, (74), 74 states have internal predecessors, (74), 28 states have call successors, (29), 24 states have call predecessors, (29), 53 states have return successors, (61), 54 states have call predecessors, (61), 28 states have call successors, (61)
[2025-05-07 17:28:15,120 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 153 states to 153 states and 164 transitions.
[2025-05-07 17:28:15,121 INFO  L79                 Accepts]: Start accepts. Automaton has 153 states and 164 transitions. Word has length 112
[2025-05-07 17:28:15,121 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:28:15,121 INFO  L485      AbstractCegarLoop]: Abstraction has 153 states and 164 transitions.
[2025-05-07 17:28:15,121 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 37 states, 27 states have (on average 2.740740740740741) internal successors, (74), 37 states have internal predecessors, (74), 13 states have call successors, (35), 1 states have call predecessors, (35), 27 states have return successors, (50), 27 states have call predecessors, (50), 13 states have call successors, (50)
[2025-05-07 17:28:15,121 INFO  L278                IsEmpty]: Start isEmpty. Operand 153 states and 164 transitions.
[2025-05-07 17:28:15,122 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 188
[2025-05-07 17:28:15,122 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:28:15,122 INFO  L218           NwaCegarLoop]: trace histogram [10, 8, 8, 8, 8, 8, 8, 8, 8, 8, 8, 3, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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:28:15,127 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Ended with exit code 0
[2025-05-07 17:28:15,323 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable7,4 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:15,324 INFO  L403      AbstractCegarLoop]: === Iteration 8 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:28:15,325 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:28:15,325 INFO  L85        PathProgramCache]: Analyzing trace with hash 1252441165, now seen corresponding path program 2 times
[2025-05-07 17:28:15,325 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:28:15,326 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [897457526]
[2025-05-07 17:28:15,326 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-05-07 17:28:15,326 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:28:15,407 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 187 statements into 2 equivalence classes.
[2025-05-07 17:28:15,446 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 187 of 187 statements.
[2025-05-07 17:28:15,446 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-05-07 17:28:15,447 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:16,232 INFO  L134       CoverageAnalysis]: Checked inductivity of 382 backedges. 0 proven. 6 refuted. 0 times theorem prover too weak. 376 trivial. 0 not checked.
[2025-05-07 17:28:16,233 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:28:16,233 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [897457526]
[2025-05-07 17:28:16,233 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [897457526] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:28:16,233 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1167286503]
[2025-05-07 17:28:16,233 INFO  L95    rtionOrderModulation]: Changing assertion order to OUTSIDE_LOOP_FIRST1
[2025-05-07 17:28:16,233 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:16,234 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:28:16,236 INFO  L229       MonitoredProcess]: Starting monitored process 5 with /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (exit command is (exit), workingDir is null)
[2025-05-07 17:28:16,237 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Waiting until timeout for monitored process
[2025-05-07 17:28:16,550 INFO  L108    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 partitioned 187 statements into 2 equivalence classes.
[2025-05-07 17:28:16,777 INFO  L111    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s) and asserted 187 of 187 statements.
[2025-05-07 17:28:16,778 INFO  L114    AnnotateAndAsserter]: Assert order OUTSIDE_LOOP_FIRST1 issued 2 check-sat command(s)
[2025-05-07 17:28:16,778 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:28:16,785 INFO  L256         TraceCheckSpWp]: Trace formula consists of 2534 conjuncts, 28 conjuncts are in the unsatisfiable core
[2025-05-07 17:28:16,798 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:28:17,076 INFO  L134       CoverageAnalysis]: Checked inductivity of 382 backedges. 122 proven. 62 refuted. 0 times theorem prover too weak. 198 trivial. 0 not checked.
[2025-05-07 17:28:17,076 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-05-07 17:28:35,479 INFO  L134       CoverageAnalysis]: Checked inductivity of 382 backedges. 122 proven. 68 refuted. 0 times theorem prover too weak. 192 trivial. 0 not checked.
[2025-05-07 17:28:35,479 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1167286503] provided 0 perfect and 2 imperfect interpolant sequences
[2025-05-07 17:28:35,479 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-05-07 17:28:35,479 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [19, 17, 20] total 39
[2025-05-07 17:28:35,480 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1910949104]
[2025-05-07 17:28:35,480 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-05-07 17:28:35,480 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 39 states
[2025-05-07 17:28:35,480 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:28:35,481 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 39 interpolants.
[2025-05-07 17:28:35,481 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=118, Invalid=1364, Unknown=0, NotChecked=0, Total=1482
[2025-05-07 17:28:35,481 INFO  L87              Difference]: Start difference. First operand 153 states and 164 transitions. Second operand  has 39 states, 29 states have (on average 2.8275862068965516) internal successors, (82), 39 states have internal predecessors, (82), 13 states have call successors, (37), 1 states have call predecessors, (37), 29 states have return successors, (63), 30 states have call predecessors, (63), 13 states have call successors, (63)
[2025-05-07 17:28:35,878 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:28:35,879 INFO  L93              Difference]: Finished difference Result 159 states and 172 transitions.
[2025-05-07 17:28:35,879 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 35 states. 
[2025-05-07 17:28:35,880 INFO  L79                 Accepts]: Start accepts. Automaton has  has 39 states, 29 states have (on average 2.8275862068965516) internal successors, (82), 39 states have internal predecessors, (82), 13 states have call successors, (37), 1 states have call predecessors, (37), 29 states have return successors, (63), 30 states have call predecessors, (63), 13 states have call successors, (63) Word has length 187
[2025-05-07 17:28:35,881 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:28:35,881 INFO  L225             Difference]: With dead ends: 159
[2025-05-07 17:28:35,881 INFO  L226             Difference]: Without dead ends: 0
[2025-05-07 17:28:35,881 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 436 GetRequests, 369 SyntacticMatches, 13 SemanticMatches, 54 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 443 ImplicationChecksByTransitivity, 0.8s TimeCoverageRelationStatistics Valid=259, Invalid=2821, Unknown=0, NotChecked=0, Total=3080
[2025-05-07 17:28:35,882 INFO  L437           NwaCegarLoop]: 82 mSDtfsCounter, 11 mSDsluCounter, 1983 mSDsCounter, 0 mSdLazyCounter, 438 mSolverCounterSat, 3 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.2s Time, 0 mProtectedPredicate, 0 mProtectedAction, 19 SdHoareTripleChecker+Valid, 2065 SdHoareTripleChecker+Invalid, 441 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 3 IncrementalHoareTripleChecker+Valid, 438 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.2s IncrementalHoareTripleChecker+Time
[2025-05-07 17:28:35,882 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [19 Valid, 2065 Invalid, 441 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [3 Valid, 438 Invalid, 0 Unknown, 0 Unchecked, 0.2s Time]
[2025-05-07 17:28:35,882 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 0 states.
[2025-05-07 17:28:35,882 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 0 to 0.
[2025-05-07 17:28:35,883 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:28:35,883 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 0 states to 0 states and 0 transitions.
[2025-05-07 17:28:35,883 INFO  L79                 Accepts]: Start accepts. Automaton has 0 states and 0 transitions. Word has length 187
[2025-05-07 17:28:35,883 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:28:35,883 INFO  L485      AbstractCegarLoop]: Abstraction has 0 states and 0 transitions.
[2025-05-07 17:28:35,883 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 39 states, 29 states have (on average 2.8275862068965516) internal successors, (82), 39 states have internal predecessors, (82), 13 states have call successors, (37), 1 states have call predecessors, (37), 29 states have return successors, (63), 30 states have call predecessors, (63), 13 states have call successors, (63)
[2025-05-07 17:28:35,883 INFO  L278                IsEmpty]: Start isEmpty. Operand 0 states and 0 transitions.
[2025-05-07 17:28:35,883 INFO  L284                IsEmpty]: Finished isEmpty. No accepting run.
[2025-05-07 17:28:35,885 INFO  L790   garLoopResultBuilder]: Registering result SAFE for location Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY (0 of 1 remaining)
[2025-05-07 17:28:35,891 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (5)] Ended with exit code 0
[2025-05-07 17:28:36,086 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable8,5 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:28:36,095 INFO  L422         BasicCegarLoop]: Path program histogram: [2, 2, 1, 1, 1, 1]
[2025-05-07 17:28:36,101 INFO  L171   ceAbstractionStarter]: Computing trace abstraction results
[2025-05-07 17:28:36,110 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction CFG 07.05 05:28:36 BoogieIcfgContainer
[2025-05-07 17:28:36,110 INFO  L131        PluginConnector]: ------------------------ END TraceAbstraction----------------------------
[2025-05-07 17:28:36,112 INFO  L158              Benchmark]: Toolchain (without parser) took 39351.88ms. Allocated memory was 234.9MB in the beginning and 436.2MB in the end (delta: 201.3MB). Free memory was 152.6MB in the beginning and 257.3MB in the end (delta: -104.8MB). Peak memory consumption was 83.5MB. Max. memory is 33.6GB.
[2025-05-07 17:28:36,113 INFO  L158              Benchmark]: SmtParser took 0.22ms. Allocated memory is still 234.9MB. Free memory is still 173.8MB. There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:28:36,114 INFO  L158              Benchmark]: ChcToBoogie took 40.17ms. Allocated memory is still 234.9MB. Free memory was 152.4MB in the beginning and 149.9MB in the end (delta: 2.6MB). There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:28:36,114 INFO  L158              Benchmark]: Boogie Preprocessor took 63.54ms. Allocated memory is still 234.9MB. Free memory was 149.9MB in the beginning and 146.7MB in the end (delta: 3.2MB). There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:28:36,115 INFO  L158              Benchmark]: RCFGBuilder took 349.11ms. Allocated memory is still 234.9MB. Free memory was 146.7MB in the beginning and 188.4MB in the end (delta: -41.8MB). Peak memory consumption was 43.2MB. Max. memory is 33.6GB.
[2025-05-07 17:28:36,117 INFO  L158              Benchmark]: TraceAbstraction took 38895.01ms. Allocated memory was 234.9MB in the beginning and 436.2MB in the end (delta: 201.3MB). Free memory was 187.8MB in the beginning and 257.3MB in the end (delta: -69.5MB). Peak memory consumption was 124.2MB. Max. memory is 33.6GB.
[2025-05-07 17:28:36,119 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.22ms. Allocated memory is still 234.9MB. Free memory is still 173.8MB. There was no memory consumed. Max. memory is 33.6GB.
 * ChcToBoogie took 40.17ms. Allocated memory is still 234.9MB. Free memory was 152.4MB in the beginning and 149.9MB in the end (delta: 2.6MB). There was no memory consumed. Max. memory is 33.6GB.
 * Boogie Preprocessor took 63.54ms. Allocated memory is still 234.9MB. Free memory was 149.9MB in the beginning and 146.7MB in the end (delta: 3.2MB). There was no memory consumed. Max. memory is 33.6GB.
 * RCFGBuilder took 349.11ms. Allocated memory is still 234.9MB. Free memory was 146.7MB in the beginning and 188.4MB in the end (delta: -41.8MB). Peak memory consumption was 43.2MB. Max. memory is 33.6GB.
 * TraceAbstraction took 38895.01ms. Allocated memory was 234.9MB in the beginning and 436.2MB in the end (delta: 201.3MB). Free memory was 187.8MB in the beginning and 257.3MB in the end (delta: -69.5MB). Peak memory consumption was 124.2MB. 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, 99 locations, 144 edges, 1 error locations. Started 1 CEGAR loops. OverallTime: 38.8s, OverallIterations: 8, TraceHistogramMax: 10, PathProgramHistogramMax: 2, EmptinessCheckTime: 0.0s, AutomataDifference: 1.4s, DeadEndRemovalTime: 0.0s, HoareAnnotationTime: 0.0s, InitialAbstractionConstructionTime: 0.0s, HoareTripleCheckerStatistics: 0 mSolverCounterUnknown, 83 SdHoareTripleChecker+Valid, 0.7s IncrementalHoareTripleChecker+Time, 0 mSdLazyCounter, 60 mSDsluCounter, 7473 SdHoareTripleChecker+Invalid, 0.6s Time, 0 mProtectedAction, 0 SdHoareTripleChecker+Unchecked, 0 IncrementalHoareTripleChecker+Unchecked, 6686 mSDsCounter, 49 IncrementalHoareTripleChecker+Valid, 0 mProtectedPredicate, 1186 IncrementalHoareTripleChecker+Invalid, 1235 SdHoareTripleChecker+Unknown, 0 mSolverCounterNotChecked, 49 mSolverCounterUnsat, 787 mSDtfsCounter, 1186 mSolverCounterSat, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Unknown, PredicateUnifierStatistics: 0 DeclaredPredicates, 1086 GetRequests, 909 SyntacticMatches, 31 SemanticMatches, 146 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 1011 ImplicationChecksByTransitivity, 1.9s Time, 0.0s BasicInterpolantAutomatonTime, BiggestAbstraction: size=153occurred in iteration=7, InterpolantAutomatonStates: 113, traceCheckStatistics: No data available, InterpolantConsolidationStatistics: No data available, PathInvariantsStatistics: No data available, 0/0 InterpolantCoveringCapability, TotalInterpolationStatistics: No data available, 0.0s DumpTime, AutomataMinimizationStatistics: 0.1s AutomataMinimizationTime, 8 MinimizatonAttempts, 2 StatesRemovedByMinimization, 1 NontrivialMinimizations, HoareAnnotationStatistics: No data available, RefinementEngineStatistics: TRACE_CHECK: 0.3s SsaConstructionTime, 0.8s SatisfiabilityAnalysisTime, 34.5s InterpolantComputationTime, 1229 NumberOfCodeBlocks, 1229 NumberOfCodeBlocksAsserted, 16 NumberOfCheckSat, 1679 ConstructedInterpolants, 0 QuantifiedInterpolants, 2465 SizeOfPredicates, 51 NumberOfNonLiveVariables, 6129 ConjunctsInSsa, 85 ConjunctsInUnsatCore, 16 InterpolantComputations, 4 PerfectInterpolantSequences, 1161/1386 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:28:36,140 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
