./chc-comp-wrapper.sh ../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/external_calls/external_hash.sol_1_no_adts_000.smt2 .


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


This is Ultimate 0.3.0-dev-42d8767-m
[2025-05-07 17:23:52,770 INFO  L188        SettingsManager]: Resetting all preferences to default values...
[2025-05-07 17:23:52,806 INFO  L114        SettingsManager]: Loading settings from /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_dc1a7e99-3fa0-4c04-ba19-acf2988f0f0f/chc-comp25-scripts/participants/UltimateUnihorn/./chccomp-Unihorn_Default.epf
[2025-05-07 17:23:52,809 WARN  L101        SettingsManager]: Preference file contains the following unknown settings:
[2025-05-07 17:23:52,809 WARN  L103        SettingsManager]:   * de.uni_freiburg.informatik.ultimate.core.Log level for class
[2025-05-07 17:23:52,821 INFO  L130        SettingsManager]: Preferences different from defaults after loading the file:
[2025-05-07 17:23:52,822 INFO  L151        SettingsManager]: Preferences of UltimateCore differ from their defaults:
[2025-05-07 17:23:52,822 INFO  L153        SettingsManager]:  * Log level for class=de.uni_freiburg.informatik.ultimate.lib.smtlibutils.quantifier.QuantifierPusher=ERROR;
[2025-05-07 17:23:52,822 INFO  L151        SettingsManager]: Preferences of Boogie Procedure Inliner differ from their defaults:
[2025-05-07 17:23:52,822 INFO  L153        SettingsManager]:  * Ignore calls to procedures called more than once=ONLY_FOR_SEQUENTIAL_PROGRAMS
[2025-05-07 17:23:52,822 INFO  L151        SettingsManager]: Preferences of BlockEncodingV2 differ from their defaults:
[2025-05-07 17:23:52,822 INFO  L153        SettingsManager]:  * Create parallel compositions if possible=false
[2025-05-07 17:23:52,822 INFO  L153        SettingsManager]:  * Use SBE=true
[2025-05-07 17:23:52,822 INFO  L151        SettingsManager]: Preferences of ChcToBoogie differ from their defaults:
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Use one large procedure with gotos to replace tail recursive calls=false
[2025-05-07 17:23:52,823 INFO  L151        SettingsManager]: Preferences of RCFGBuilder differ from their defaults:
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Size of a code block=SequenceOfStatements
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * SMT solver=External_DefaultMode
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-05-07 17:23:52,823 INFO  L151        SettingsManager]: Preferences of TraceAbstraction differ from their defaults:
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Compute Interpolants along a Counterexample=FPandBP
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Trace refinement strategy=CAMEL
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Command for external solver=z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * Automaton type used in concurrency analysis=PETRI_NET
[2025-05-07 17:23:52,823 INFO  L153        SettingsManager]:  * SMT solver=External_ModelsAndUnsatCoreMode
[2025-05-07 17:23:52,824 INFO  L151        SettingsManager]: Preferences of SmtParser differ from their defaults:
[2025-05-07 17:23:52,824 INFO  L153        SettingsManager]:  * SmtParser Mode=UltimateTreeAutomizer
[2025-05-07 17:23:53,016 INFO  L75    nceAwareModelManager]: Repository-Root is: /tmp
[2025-05-07 17:23:53,024 INFO  L261   ainManager$Toolchain]: [Toolchain 1]: Applicable parser(s) successfully (re)initialized
[2025-05-07 17:23:53,026 INFO  L217   ainManager$Toolchain]: [Toolchain 1]: Toolchain selected.
[2025-05-07 17:23:53,027 INFO  L270        PluginConnector]: Initializing SmtParser...
[2025-05-07 17:23:53,027 INFO  L274        PluginConnector]: SmtParser initialized
[2025-05-07 17:23:53,028 INFO  L431   ainManager$Toolchain]: [Toolchain 1]: Parsing single file: /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_dc1a7e99-3fa0-4c04-ba19-acf2988f0f0f/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/external_calls/external_hash.sol_1_no_adts_000.smt2
[2025-05-07 17:23:53,029 INFO  L314              SmtParser]: Parsing .smt2 file as a set of Horn Clauses
[2025-05-07 17:23:53,031 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
unknown
[2025-05-07 17:23:53,322 INFO  L339              SmtParser]: Successfully executed SMT file /tmp/vcloud_worker_vcloud-master_on_vcloud-master/run_dir_dc1a7e99-3fa0-4c04-ba19-acf2988f0f0f/chc-comp25-scripts/participants/UltimateUnihorn/../../../chc-comp25-benchmarks/solidity/no_adts/unit_tests/external_calls/external_hash.sol_1_no_adts_000.smt2
[2025-05-07 17:23:53,325 INFO  L299   ainManager$Toolchain]: ####################### [Toolchain 1] #######################
[2025-05-07 17:23:53,326 INFO  L133        ToolchainWalker]: Walking toolchain with 4 elements.
[2025-05-07 17:23:53,326 INFO  L112        PluginConnector]: ------------------------ChcToBoogie----------------------------
[2025-05-07 17:23:53,326 INFO  L270        PluginConnector]: Initializing ChcToBoogie...
[2025-05-07 17:23:53,327 INFO  L274        PluginConnector]: ChcToBoogie initialized
[2025-05-07 17:23:53,328 INFO  L184        PluginConnector]: Executing the observer ChcToBoogieObserver from plugin ChcToBoogie for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,362 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53 Unit
[2025-05-07 17:23:53,362 INFO  L131        PluginConnector]: ------------------------ END ChcToBoogie----------------------------
[2025-05-07 17:23:53,363 INFO  L112        PluginConnector]: ------------------------Boogie Preprocessor----------------------------
[2025-05-07 17:23:53,363 INFO  L270        PluginConnector]: Initializing Boogie Preprocessor...
[2025-05-07 17:23:53,363 INFO  L274        PluginConnector]: Boogie Preprocessor initialized
[2025-05-07 17:23:53,374 INFO  L184        PluginConnector]: Executing the observer EnsureBoogieModelObserver from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,374 INFO  L184        PluginConnector]: Executing the observer TypeChecker from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,396 INFO  L184        PluginConnector]: Executing the observer ConstExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,396 INFO  L184        PluginConnector]: Executing the observer StructExpander from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,401 INFO  L184        PluginConnector]: Executing the observer ReplaceArrayAssignments from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,402 INFO  L184        PluginConnector]: Executing the observer UnstructureCode from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,404 INFO  L184        PluginConnector]: Executing the observer FunctionInliner from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,406 INFO  L184        PluginConnector]: Executing the observer LTLStepAnnotator from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,407 INFO  L184        PluginConnector]: Executing the observer BoogieSymbolTableConstructor from plugin Boogie Preprocessor for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,418 INFO  L131        PluginConnector]: ------------------------ END Boogie Preprocessor----------------------------
[2025-05-07 17:23:53,419 INFO  L112        PluginConnector]: ------------------------RCFGBuilder----------------------------
[2025-05-07 17:23:53,419 INFO  L270        PluginConnector]: Initializing RCFGBuilder...
[2025-05-07 17:23:53,419 INFO  L274        PluginConnector]: RCFGBuilder initialized
[2025-05-07 17:23:53,420 INFO  L184        PluginConnector]: Executing the observer RCFGBuilderObserver from plugin RCFGBuilder for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (1/1) ...
[2025-05-07 17:23:53,422 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 SMTLIB2_COMPLIANT=true -memory:2024 -smt2 -in -t:2000
[2025-05-07 17:23:53,431 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:23:53,440 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:23:53,442 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:23:53,450 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure False given in one single declaration
[2025-05-07 17:23:53,450 INFO  L130     BoogieDeclarations]: Found specification of procedure False
[2025-05-07 17:23:53,450 INFO  L138     BoogieDeclarations]: Found implementation of procedure False
[2025-05-07 17:23:53,450 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure error_target_5_0 given in one single declaration
[2025-05-07 17:23:53,450 INFO  L130     BoogieDeclarations]: Found specification of procedure error_target_5_0
[2025-05-07 17:23:53,451 INFO  L138     BoogieDeclarations]: Found implementation of procedure error_target_5_0
[2025-05-07 17:23:53,451 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_10_function_f1__56_67_0 given in one single declaration
[2025-05-07 17:23:53,451 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_10_function_f1__56_67_0
[2025-05-07 17:23:53,451 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_10_function_f1__56_67_0
[2025-05-07 17:23:53,451 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_23_function_f1__56_67_0 given in one single declaration
[2025-05-07 17:23:53,451 INFO  L130     BoogieDeclarations]: Found specification of procedure block_23_function_f1__56_67_0
[2025-05-07 17:23:53,451 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_23_function_f1__56_67_0
[2025-05-07 17:23:53,451 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_9_function_f1__56_67_0 given in one single declaration
[2025-05-07 17:23:53,451 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_9_function_f1__56_67_0
[2025-05-07 17:23:53,451 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_9_function_f1__56_67_0
[2025-05-07 17:23:53,451 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure nondet_call_21_0 given in one single declaration
[2025-05-07 17:23:53,451 INFO  L130     BoogieDeclarations]: Found specification of procedure nondet_call_21_0
[2025-05-07 17:23:53,451 INFO  L138     BoogieDeclarations]: Found implementation of procedure nondet_call_21_0
[2025-05-07 17:23:53,452 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure nondet_interface_6_C_67_0 given in one single declaration
[2025-05-07 17:23:53,452 INFO  L130     BoogieDeclarations]: Found specification of procedure nondet_interface_6_C_67_0
[2025-05-07 17:23:53,452 INFO  L138     BoogieDeclarations]: Found implementation of procedure nondet_interface_6_C_67_0
[2025-05-07 17:23:53,452 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_12_function_inv__66_67_0 given in one single declaration
[2025-05-07 17:23:53,452 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_12_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_12_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_28_function_inv__66_67_0 given in one single declaration
[2025-05-07 17:23:53,452 INFO  L130     BoogieDeclarations]: Found specification of procedure block_28_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_28_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_11_function_inv__66_67_0 given in one single declaration
[2025-05-07 17:23:53,452 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_11_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_11_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_26_return_function_inv__66_67_0 given in one single declaration
[2025-05-07 17:23:53,452 INFO  L130     BoogieDeclarations]: Found specification of procedure block_26_return_function_inv__66_67_0
[2025-05-07 17:23:53,452 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_26_return_function_inv__66_67_0
[2025-05-07 17:23:53,453 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_25_inv_65_67_0 given in one single declaration
[2025-05-07 17:23:53,453 INFO  L130     BoogieDeclarations]: Found specification of procedure block_25_inv_65_67_0
[2025-05-07 17:23:53,453 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_25_inv_65_67_0
[2025-05-07 17:23:53,453 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_24_function_inv__66_67_0 given in one single declaration
[2025-05-07 17:23:53,453 INFO  L130     BoogieDeclarations]: Found specification of procedure block_24_function_inv__66_67_0
[2025-05-07 17:23:53,453 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_24_function_inv__66_67_0
[2025-05-07 17:23:53,453 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_27_function_inv__66_67_0 given in one single declaration
[2025-05-07 17:23:53,453 INFO  L130     BoogieDeclarations]: Found specification of procedure block_27_function_inv__66_67_0
[2025-05-07 17:23:53,453 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_27_function_inv__66_67_0
[2025-05-07 17:23:53,453 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_22_function_f1__56_67_0 given in one single declaration
[2025-05-07 17:23:53,453 INFO  L130     BoogieDeclarations]: Found specification of procedure block_22_function_f1__56_67_0
[2025-05-07 17:23:53,453 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_22_function_f1__56_67_0
[2025-05-07 17:23:53,453 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_18_f1_55_67_0 given in one single declaration
[2025-05-07 17:23:53,453 INFO  L130     BoogieDeclarations]: Found specification of procedure block_18_f1_55_67_0
[2025-05-07 17:23:53,454 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_18_f1_55_67_0
[2025-05-07 17:23:53,454 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_17_function_f1__56_67_0 given in one single declaration
[2025-05-07 17:23:53,454 INFO  L130     BoogieDeclarations]: Found specification of procedure block_17_function_f1__56_67_0
[2025-05-07 17:23:53,454 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_17_function_f1__56_67_0
[2025-05-07 17:23:53,454 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure nondet_call_20_0 given in one single declaration
[2025-05-07 17:23:53,454 INFO  L130     BoogieDeclarations]: Found specification of procedure nondet_call_20_0
[2025-05-07 17:23:53,454 INFO  L138     BoogieDeclarations]: Found implementation of procedure nondet_call_20_0
[2025-05-07 17:23:53,454 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_19_return_function_f1__56_67_0 given in one single declaration
[2025-05-07 17:23:53,454 INFO  L130     BoogieDeclarations]: Found specification of procedure block_19_return_function_f1__56_67_0
[2025-05-07 17:23:53,454 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_19_return_function_f1__56_67_0
[2025-05-07 17:23:53,454 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure interface_5_C_67_0 given in one single declaration
[2025-05-07 17:23:53,454 INFO  L130     BoogieDeclarations]: Found specification of procedure interface_5_C_67_0
[2025-05-07 17:23:53,454 INFO  L138     BoogieDeclarations]: Found implementation of procedure interface_5_C_67_0
[2025-05-07 17:23:53,454 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_constructor_7_C_67_0 given in one single declaration
[2025-05-07 17:23:53,454 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_constructor_7_C_67_0
[2025-05-07 17:23:53,454 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_constructor_7_C_67_0
[2025-05-07 17:23:53,455 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_32_C_67_0 given in one single declaration
[2025-05-07 17:23:53,455 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_32_C_67_0
[2025-05-07 17:23:53,455 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_32_C_67_0
[2025-05-07 17:23:53,455 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure summary_8_constructor_26_67_0 given in one single declaration
[2025-05-07 17:23:53,455 INFO  L130     BoogieDeclarations]: Found specification of procedure summary_8_constructor_26_67_0
[2025-05-07 17:23:53,455 INFO  L138     BoogieDeclarations]: Found implementation of procedure summary_8_constructor_26_67_0
[2025-05-07 17:23:53,455 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_31_return_constructor_26_67_0 given in one single declaration
[2025-05-07 17:23:53,455 INFO  L130     BoogieDeclarations]: Found specification of procedure block_31_return_constructor_26_67_0
[2025-05-07 17:23:53,455 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_31_return_constructor_26_67_0
[2025-05-07 17:23:53,455 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_30__25_67_0 given in one single declaration
[2025-05-07 17:23:53,455 INFO  L130     BoogieDeclarations]: Found specification of procedure block_30__25_67_0
[2025-05-07 17:23:53,455 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_30__25_67_0
[2025-05-07 17:23:53,455 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure block_29_constructor_26_67_0 given in one single declaration
[2025-05-07 17:23:53,456 INFO  L130     BoogieDeclarations]: Found specification of procedure block_29_constructor_26_67_0
[2025-05-07 17:23:53,456 INFO  L138     BoogieDeclarations]: Found implementation of procedure block_29_constructor_26_67_0
[2025-05-07 17:23:53,456 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_after_init_34_C_67_0 given in one single declaration
[2025-05-07 17:23:53,456 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_after_init_34_C_67_0
[2025-05-07 17:23:53,456 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_after_init_34_C_67_0
[2025-05-07 17:23:53,456 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure contract_initializer_entry_33_C_67_0 given in one single declaration
[2025-05-07 17:23:53,456 INFO  L130     BoogieDeclarations]: Found specification of procedure contract_initializer_entry_33_C_67_0
[2025-05-07 17:23:53,456 INFO  L138     BoogieDeclarations]: Found implementation of procedure contract_initializer_entry_33_C_67_0
[2025-05-07 17:23:53,456 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure implicit_constructor_entry_35_C_67_0 given in one single declaration
[2025-05-07 17:23:53,456 INFO  L130     BoogieDeclarations]: Found specification of procedure implicit_constructor_entry_35_C_67_0
[2025-05-07 17:23:53,456 INFO  L138     BoogieDeclarations]: Found implementation of procedure implicit_constructor_entry_35_C_67_0
[2025-05-07 17:23:53,456 INFO  L124     BoogieDeclarations]: Specification and implementation of procedure Ultimate.START given in one single declaration
[2025-05-07 17:23:53,456 INFO  L130     BoogieDeclarations]: Found specification of procedure Ultimate.START
[2025-05-07 17:23:53,456 INFO  L138     BoogieDeclarations]: Found implementation of procedure Ultimate.START
[2025-05-07 17:23:53,638 INFO  L234             CfgBuilder]: Building ICFG
[2025-05-07 17:23:53,640 INFO  L260             CfgBuilder]: Building CFG for each procedure with an implementation
[2025-05-07 17:23:53,878 INFO  L?                        ?]: Removed 261 outVars from TransFormulas that were not future-live.
[2025-05-07 17:23:53,878 INFO  L283             CfgBuilder]: Performing block encoding
[2025-05-07 17:23:53,887 INFO  L304             CfgBuilder]: Using library mode
[2025-05-07 17:23:53,887 INFO  L312             CfgBuilder]: Removed 12 assume(true) statements.
[2025-05-07 17:23:53,887 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 07.05 05:23:53 BoogieIcfgContainer
[2025-05-07 17:23:53,887 INFO  L131        PluginConnector]: ------------------------ END RCFGBuilder----------------------------
[2025-05-07 17:23:53,889 INFO  L112        PluginConnector]: ------------------------TraceAbstraction----------------------------
[2025-05-07 17:23:53,889 INFO  L270        PluginConnector]: Initializing TraceAbstraction...
[2025-05-07 17:23:53,891 INFO  L274        PluginConnector]: TraceAbstraction initialized
[2025-05-07 17:23:53,892 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.source.smtparser OTHER 07.05 05:23:53" (1/3) ...
[2025-05-07 17:23:53,892 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@7574adc7 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction OTHER 07.05 05:23:53, skipping insertion in model container
[2025-05-07 17:23:53,892 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.chctoboogie AST 07.05 05:23:53" (2/3) ...
[2025-05-07 17:23:53,892 INFO  L204        PluginConnector]: Invalid model from TraceAbstraction for observer de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction.TraceAbstractionObserver@7574adc7 and model type de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction AST 07.05 05:23:53, skipping insertion in model container
[2025-05-07 17:23:53,892 INFO  L184        PluginConnector]: Executing the observer TraceAbstractionObserver from plugin TraceAbstraction for "de.uni_freiburg.informatik.ultimate.plugins.generator.rcfgbuilder CFG 07.05 05:23:53" (3/3) ...
[2025-05-07 17:23:53,893 INFO  L128   eAbstractionObserver]: Analyzing ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver
[2025-05-07 17:23:53,904 INFO  L217   ceAbstractionStarter]: Automizer settings: Hoare:None NWA Interpolation:FPandBP Determinization: PREDICATE_ABSTRACTION
[2025-05-07 17:23:53,906 INFO  L151   ceAbstractionStarter]: Applying trace abstraction to ICFG de.uni_freiburg.informatik.ultimate.plugins.chctoboogie.ChcToBoogieObserver that has 30 procedures, 129 locations, 209 edges, 30 initial locations, 0 loop locations, and 1 error locations.
[2025-05-07 17:23:53,936 INFO  L339      AbstractCegarLoop]: ======== Iteration 0 == of CEGAR loop == AllErrorsAtOnce ========
[2025-05-07 17:23:53,944 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;@18d92d7e, mLbeIndependenceSettings=[IndependenceType=SEMANTIC, AbstractionType=NONE, UseConditional=false, UseSemiCommutativity=true, Solver=Z3, SolverTimeout=1000ms]
[2025-05-07 17:23:53,944 INFO  L341      AbstractCegarLoop]: Starting to check reachability of 1 error locations.
[2025-05-07 17:23:53,946 INFO  L278                IsEmpty]: Start isEmpty. Operand  has 129 states, 51 states have (on average 1.1568627450980393) internal successors, (59), 59 states have internal predecessors, (59), 48 states have call successors, (50), 29 states have call predecessors, (50), 29 states have return successors, (50), 41 states have call predecessors, (50), 48 states have call successors, (50)
[2025-05-07 17:23:53,955 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 72
[2025-05-07 17:23:53,955 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:53,955 INFO  L218           NwaCegarLoop]: trace histogram [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:23:53,956 INFO  L403      AbstractCegarLoop]: === Iteration 1 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:53,959 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:53,959 INFO  L85        PathProgramCache]: Analyzing trace with hash -469046687, now seen corresponding path program 1 times
[2025-05-07 17:23:53,964 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:53,965 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [2054905466]
[2025-05-07 17:23:53,965 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:53,965 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:54,012 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 71 statements into 1 equivalence classes.
[2025-05-07 17:23:54,096 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 71 of 71 statements.
[2025-05-07 17:23:54,096 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:54,096 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:54,331 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:23:54,331 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:54,331 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [2054905466]
[2025-05-07 17:23:54,332 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [2054905466] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:54,332 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:54,334 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [5] imperfect sequences [] total 5
[2025-05-07 17:23:54,335 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1566553369]
[2025-05-07 17:23:54,336 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:54,338 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 5 states
[2025-05-07 17:23:54,339 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:54,364 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 5 interpolants.
[2025-05-07 17:23:54,365 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=7, Invalid=13, Unknown=0, NotChecked=0, Total=20
[2025-05-07 17:23:54,367 INFO  L87              Difference]: Start difference. First operand  has 129 states, 51 states have (on average 1.1568627450980393) internal successors, (59), 59 states have internal predecessors, (59), 48 states have call successors, (50), 29 states have call predecessors, (50), 29 states have return successors, (50), 41 states have call predecessors, (50), 48 states have call successors, (50) Second operand  has 5 states, 4 states have (on average 8.25) internal successors, (33), 5 states have internal predecessors, (33), 3 states have call successors, (19), 1 states have call predecessors, (19), 4 states have return successors, (19), 3 states have call predecessors, (19), 3 states have call successors, (19)
[2025-05-07 17:23:54,463 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:54,464 INFO  L93              Difference]: Finished difference Result 128 states and 158 transitions.
[2025-05-07 17:23:54,465 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 5 states. 
[2025-05-07 17:23:54,466 INFO  L79                 Accepts]: Start accepts. Automaton has  has 5 states, 4 states have (on average 8.25) internal successors, (33), 5 states have internal predecessors, (33), 3 states have call successors, (19), 1 states have call predecessors, (19), 4 states have return successors, (19), 3 states have call predecessors, (19), 3 states have call successors, (19) Word has length 71
[2025-05-07 17:23:54,467 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:54,475 INFO  L225             Difference]: With dead ends: 128
[2025-05-07 17:23:54,475 INFO  L226             Difference]: Without dead ends: 127
[2025-05-07 17:23:54,476 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 5 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 3 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=7, Invalid=13, Unknown=0, NotChecked=0, Total=20
[2025-05-07 17:23:54,479 INFO  L437           NwaCegarLoop]: 144 mSDtfsCounter, 1 mSDsluCounter, 417 mSDsCounter, 0 mSdLazyCounter, 34 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 561 SdHoareTripleChecker+Invalid, 35 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 34 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:54,480 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 561 Invalid, 35 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 34 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:23:54,493 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 127 states.
[2025-05-07 17:23:54,517 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 127 to 125.
[2025-05-07 17:23:54,518 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 125 states, 50 states have (on average 1.14) internal successors, (57), 57 states have internal predecessors, (57), 45 states have call successors, (46), 28 states have call predecessors, (46), 30 states have return successors, (52), 39 states have call predecessors, (52), 45 states have call successors, (52)
[2025-05-07 17:23:54,521 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 125 states to 125 states and 155 transitions.
[2025-05-07 17:23:54,522 INFO  L79                 Accepts]: Start accepts. Automaton has 125 states and 155 transitions. Word has length 71
[2025-05-07 17:23:54,522 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:54,522 INFO  L485      AbstractCegarLoop]: Abstraction has 125 states and 155 transitions.
[2025-05-07 17:23:54,523 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 5 states, 4 states have (on average 8.25) internal successors, (33), 5 states have internal predecessors, (33), 3 states have call successors, (19), 1 states have call predecessors, (19), 4 states have return successors, (19), 3 states have call predecessors, (19), 3 states have call successors, (19)
[2025-05-07 17:23:54,523 INFO  L278                IsEmpty]: Start isEmpty. Operand 125 states and 155 transitions.
[2025-05-07 17:23:54,525 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 80
[2025-05-07 17:23:54,525 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:54,525 INFO  L218           NwaCegarLoop]: trace histogram [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, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:23:54,525 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable1
[2025-05-07 17:23:54,525 INFO  L403      AbstractCegarLoop]: === Iteration 2 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:54,526 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:54,526 INFO  L85        PathProgramCache]: Analyzing trace with hash 895706696, now seen corresponding path program 1 times
[2025-05-07 17:23:54,526 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:54,526 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [354622283]
[2025-05-07 17:23:54,526 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:54,526 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:54,564 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 79 statements into 1 equivalence classes.
[2025-05-07 17:23:54,570 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 79 of 79 statements.
[2025-05-07 17:23:54,570 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:54,570 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:54,688 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-05-07 17:23:54,688 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:54,688 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [354622283]
[2025-05-07 17:23:54,689 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [354622283] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:54,689 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:54,689 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [] total 4
[2025-05-07 17:23:54,689 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1175608415]
[2025-05-07 17:23:54,689 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:54,690 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-05-07 17:23:54,690 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:54,691 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-05-07 17:23:54,691 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:23:54,691 INFO  L87              Difference]: Start difference. First operand 125 states and 155 transitions. Second operand  has 4 states, 3 states have (on average 11.666666666666666) internal successors, (35), 4 states have internal predecessors, (35), 4 states have call successors, (21), 1 states have call predecessors, (21), 3 states have return successors, (21), 3 states have call predecessors, (21), 4 states have call successors, (21)
[2025-05-07 17:23:54,708 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:54,708 INFO  L93              Difference]: Finished difference Result 129 states and 160 transitions.
[2025-05-07 17:23:54,709 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-05-07 17:23:54,709 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 11.666666666666666) internal successors, (35), 4 states have internal predecessors, (35), 4 states have call successors, (21), 1 states have call predecessors, (21), 3 states have return successors, (21), 3 states have call predecessors, (21), 4 states have call successors, (21) Word has length 79
[2025-05-07 17:23:54,709 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:54,711 INFO  L225             Difference]: With dead ends: 129
[2025-05-07 17:23:54,711 INFO  L226             Difference]: Without dead ends: 125
[2025-05-07 17:23:54,711 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:23:54,712 INFO  L437           NwaCegarLoop]: 147 mSDtfsCounter, 1 mSDsluCounter, 287 mSDsCounter, 0 mSdLazyCounter, 2 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 434 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:23:54,712 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 434 Invalid, 2 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 2 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:23:54,713 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 125 states.
[2025-05-07 17:23:54,723 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 125 to 123.
[2025-05-07 17:23:54,723 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 123 states, 50 states have (on average 1.12) internal successors, (56), 56 states have internal predecessors, (56), 43 states have call successors, (44), 28 states have call predecessors, (44), 30 states have return successors, (50), 38 states have call predecessors, (50), 43 states have call successors, (50)
[2025-05-07 17:23:54,725 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 123 states to 123 states and 150 transitions.
[2025-05-07 17:23:54,725 INFO  L79                 Accepts]: Start accepts. Automaton has 123 states and 150 transitions. Word has length 79
[2025-05-07 17:23:54,725 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:54,725 INFO  L485      AbstractCegarLoop]: Abstraction has 123 states and 150 transitions.
[2025-05-07 17:23:54,726 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 11.666666666666666) internal successors, (35), 4 states have internal predecessors, (35), 4 states have call successors, (21), 1 states have call predecessors, (21), 3 states have return successors, (21), 3 states have call predecessors, (21), 4 states have call successors, (21)
[2025-05-07 17:23:54,726 INFO  L278                IsEmpty]: Start isEmpty. Operand 123 states and 150 transitions.
[2025-05-07 17:23:54,728 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 80
[2025-05-07 17:23:54,728 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:54,729 INFO  L218           NwaCegarLoop]: trace histogram [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, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:23:54,729 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable2
[2025-05-07 17:23:54,729 INFO  L403      AbstractCegarLoop]: === Iteration 3 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:54,729 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:54,729 INFO  L85        PathProgramCache]: Analyzing trace with hash 1959820112, now seen corresponding path program 1 times
[2025-05-07 17:23:54,729 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:54,729 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [2106242560]
[2025-05-07 17:23:54,730 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:54,730 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:54,756 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 79 statements into 1 equivalence classes.
[2025-05-07 17:23:54,775 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 79 of 79 statements.
[2025-05-07 17:23:54,775 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:54,776 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:54,870 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 2 proven. 0 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-05-07 17:23:54,870 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:54,871 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [2106242560]
[2025-05-07 17:23:54,871 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [2106242560] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:54,871 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:54,871 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [5] imperfect sequences [] total 5
[2025-05-07 17:23:54,871 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [652799531]
[2025-05-07 17:23:54,871 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:54,871 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 5 states
[2025-05-07 17:23:54,871 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:54,872 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 5 interpolants.
[2025-05-07 17:23:54,872 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=7, Invalid=13, Unknown=0, NotChecked=0, Total=20
[2025-05-07 17:23:54,872 INFO  L87              Difference]: Start difference. First operand 123 states and 150 transitions. Second operand  has 5 states, 4 states have (on average 9.25) internal successors, (37), 5 states have internal predecessors, (37), 3 states have call successors, (21), 1 states have call predecessors, (21), 4 states have return successors, (21), 4 states have call predecessors, (21), 3 states have call successors, (21)
[2025-05-07 17:23:54,929 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:54,929 INFO  L93              Difference]: Finished difference Result 127 states and 154 transitions.
[2025-05-07 17:23:54,930 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 5 states. 
[2025-05-07 17:23:54,930 INFO  L79                 Accepts]: Start accepts. Automaton has  has 5 states, 4 states have (on average 9.25) internal successors, (37), 5 states have internal predecessors, (37), 3 states have call successors, (21), 1 states have call predecessors, (21), 4 states have return successors, (21), 4 states have call predecessors, (21), 3 states have call successors, (21) Word has length 79
[2025-05-07 17:23:54,930 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:54,932 INFO  L225             Difference]: With dead ends: 127
[2025-05-07 17:23:54,932 INFO  L226             Difference]: Without dead ends: 127
[2025-05-07 17:23:54,932 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 5 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 3 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=7, Invalid=13, Unknown=0, NotChecked=0, Total=20
[2025-05-07 17:23:54,933 INFO  L437           NwaCegarLoop]: 138 mSDtfsCounter, 1 mSDsluCounter, 399 mSDsCounter, 0 mSdLazyCounter, 30 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 4 SdHoareTripleChecker+Valid, 537 SdHoareTripleChecker+Invalid, 31 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 30 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:54,933 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [4 Valid, 537 Invalid, 31 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 30 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:23:54,934 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 127 states.
[2025-05-07 17:23:54,943 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 127 to 125.
[2025-05-07 17:23:54,943 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 125 states, 51 states have (on average 1.1176470588235294) internal successors, (57), 57 states have internal predecessors, (57), 43 states have call successors, (44), 28 states have call predecessors, (44), 31 states have return successors, (51), 39 states have call predecessors, (51), 43 states have call successors, (51)
[2025-05-07 17:23:54,945 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 125 states to 125 states and 152 transitions.
[2025-05-07 17:23:54,945 INFO  L79                 Accepts]: Start accepts. Automaton has 125 states and 152 transitions. Word has length 79
[2025-05-07 17:23:54,945 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:54,945 INFO  L485      AbstractCegarLoop]: Abstraction has 125 states and 152 transitions.
[2025-05-07 17:23:54,946 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 5 states, 4 states have (on average 9.25) internal successors, (37), 5 states have internal predecessors, (37), 3 states have call successors, (21), 1 states have call predecessors, (21), 4 states have return successors, (21), 4 states have call predecessors, (21), 3 states have call successors, (21)
[2025-05-07 17:23:54,946 INFO  L278                IsEmpty]: Start isEmpty. Operand 125 states and 152 transitions.
[2025-05-07 17:23:54,947 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 83
[2025-05-07 17:23:54,948 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:54,948 INFO  L218           NwaCegarLoop]: trace histogram [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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:23:54,948 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable3
[2025-05-07 17:23:54,948 INFO  L403      AbstractCegarLoop]: === Iteration 4 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:54,948 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:54,949 INFO  L85        PathProgramCache]: Analyzing trace with hash 1365979025, now seen corresponding path program 1 times
[2025-05-07 17:23:54,949 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:54,949 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1815574993]
[2025-05-07 17:23:54,949 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:54,949 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:54,976 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 82 statements into 1 equivalence classes.
[2025-05-07 17:23:55,004 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 82 of 82 statements.
[2025-05-07 17:23:55,004 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:55,004 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:55,160 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 3 trivial. 0 not checked.
[2025-05-07 17:23:55,160 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:55,160 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1815574993]
[2025-05-07 17:23:55,160 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1815574993] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:55,160 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:55,161 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [] total 6
[2025-05-07 17:23:55,161 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [193659092]
[2025-05-07 17:23:55,161 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:55,161 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-05-07 17:23:55,161 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:55,162 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-05-07 17:23:55,162 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=9, Invalid=21, Unknown=0, NotChecked=0, Total=30
[2025-05-07 17:23:55,162 INFO  L87              Difference]: Start difference. First operand 125 states and 152 transitions. Second operand  has 6 states, 5 states have (on average 7.2) internal successors, (36), 6 states have internal predecessors, (36), 4 states have call successors, (22), 1 states have call predecessors, (22), 5 states have return successors, (22), 6 states have call predecessors, (22), 4 states have call successors, (22)
[2025-05-07 17:23:55,216 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:55,216 INFO  L93              Difference]: Finished difference Result 130 states and 159 transitions.
[2025-05-07 17:23:55,216 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-05-07 17:23:55,216 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 5 states have (on average 7.2) internal successors, (36), 6 states have internal predecessors, (36), 4 states have call successors, (22), 1 states have call predecessors, (22), 5 states have return successors, (22), 6 states have call predecessors, (22), 4 states have call successors, (22) Word has length 82
[2025-05-07 17:23:55,217 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:55,217 INFO  L225             Difference]: With dead ends: 130
[2025-05-07 17:23:55,218 INFO  L226             Difference]: Without dead ends: 130
[2025-05-07 17:23:55,218 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:23:55,218 INFO  L437           NwaCegarLoop]: 138 mSDtfsCounter, 1 mSDsluCounter, 537 mSDsCounter, 0 mSdLazyCounter, 25 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 675 SdHoareTripleChecker+Invalid, 25 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 25 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:55,218 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 675 Invalid, 25 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 25 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:23:55,219 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 130 states.
[2025-05-07 17:23:55,224 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 130 to 130.
[2025-05-07 17:23:55,225 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 130 states, 53 states have (on average 1.1132075471698113) internal successors, (59), 59 states have internal predecessors, (59), 44 states have call successors, (45), 28 states have call predecessors, (45), 33 states have return successors, (55), 42 states have call predecessors, (55), 44 states have call successors, (55)
[2025-05-07 17:23:55,226 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 130 states to 130 states and 159 transitions.
[2025-05-07 17:23:55,226 INFO  L79                 Accepts]: Start accepts. Automaton has 130 states and 159 transitions. Word has length 82
[2025-05-07 17:23:55,226 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:55,226 INFO  L485      AbstractCegarLoop]: Abstraction has 130 states and 159 transitions.
[2025-05-07 17:23:55,227 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 5 states have (on average 7.2) internal successors, (36), 6 states have internal predecessors, (36), 4 states have call successors, (22), 1 states have call predecessors, (22), 5 states have return successors, (22), 6 states have call predecessors, (22), 4 states have call successors, (22)
[2025-05-07 17:23:55,227 INFO  L278                IsEmpty]: Start isEmpty. Operand 130 states and 159 transitions.
[2025-05-07 17:23:55,228 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 105
[2025-05-07 17:23:55,228 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:55,228 INFO  L218           NwaCegarLoop]: trace histogram [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, 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:23:55,228 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable4
[2025-05-07 17:23:55,228 INFO  L403      AbstractCegarLoop]: === Iteration 5 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:55,229 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:55,229 INFO  L85        PathProgramCache]: Analyzing trace with hash 1814162195, now seen corresponding path program 1 times
[2025-05-07 17:23:55,229 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:55,229 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1169988783]
[2025-05-07 17:23:55,229 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:55,229 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:55,271 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 104 statements into 1 equivalence classes.
[2025-05-07 17:23:55,295 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 104 of 104 statements.
[2025-05-07 17:23:55,295 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:55,295 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:55,499 INFO  L134       CoverageAnalysis]: Checked inductivity of 9 backedges. 4 proven. 0 refuted. 0 times theorem prover too weak. 5 trivial. 0 not checked.
[2025-05-07 17:23:55,499 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:55,499 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1169988783]
[2025-05-07 17:23:55,499 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1169988783] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:55,499 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:55,499 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [10] imperfect sequences [] total 10
[2025-05-07 17:23:55,499 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1968465774]
[2025-05-07 17:23:55,499 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:55,500 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-05-07 17:23:55,500 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:55,501 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-05-07 17:23:55,501 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=17, Invalid=73, Unknown=0, NotChecked=0, Total=90
[2025-05-07 17:23:55,501 INFO  L87              Difference]: Start difference. First operand 130 states and 159 transitions. Second operand  has 10 states, 9 states have (on average 5.111111111111111) internal successors, (46), 10 states have internal predecessors, (46), 6 states have call successors, (28), 1 states have call predecessors, (28), 9 states have return successors, (28), 10 states have call predecessors, (28), 6 states have call successors, (28)
[2025-05-07 17:23:55,670 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:55,670 INFO  L93              Difference]: Finished difference Result 146 states and 189 transitions.
[2025-05-07 17:23:55,671 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 10 states. 
[2025-05-07 17:23:55,671 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 9 states have (on average 5.111111111111111) internal successors, (46), 10 states have internal predecessors, (46), 6 states have call successors, (28), 1 states have call predecessors, (28), 9 states have return successors, (28), 10 states have call predecessors, (28), 6 states have call successors, (28) Word has length 104
[2025-05-07 17:23:55,671 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:55,673 INFO  L225             Difference]: With dead ends: 146
[2025-05-07 17:23:55,673 INFO  L226             Difference]: Without dead ends: 146
[2025-05-07 17:23:55,673 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 10 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 8 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=17, Invalid=73, Unknown=0, NotChecked=0, Total=90
[2025-05-07 17:23:55,674 INFO  L437           NwaCegarLoop]: 155 mSDtfsCounter, 1 mSDsluCounter, 1190 mSDsCounter, 0 mSdLazyCounter, 159 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 1345 SdHoareTripleChecker+Invalid, 160 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 159 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:55,674 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 1345 Invalid, 160 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 159 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:23:55,675 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 146 states.
[2025-05-07 17:23:55,685 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 146 to 146.
[2025-05-07 17:23:55,686 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 146 states, 59 states have (on average 1.1016949152542372) internal successors, (65), 65 states have internal predecessors, (65), 48 states have call successors, (49), 28 states have call predecessors, (49), 39 states have return successors, (75), 52 states have call predecessors, (75), 48 states have call successors, (75)
[2025-05-07 17:23:55,687 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 146 states to 146 states and 189 transitions.
[2025-05-07 17:23:55,687 INFO  L79                 Accepts]: Start accepts. Automaton has 146 states and 189 transitions. Word has length 104
[2025-05-07 17:23:55,688 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:55,688 INFO  L485      AbstractCegarLoop]: Abstraction has 146 states and 189 transitions.
[2025-05-07 17:23:55,688 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 9 states have (on average 5.111111111111111) internal successors, (46), 10 states have internal predecessors, (46), 6 states have call successors, (28), 1 states have call predecessors, (28), 9 states have return successors, (28), 10 states have call predecessors, (28), 6 states have call successors, (28)
[2025-05-07 17:23:55,688 INFO  L278                IsEmpty]: Start isEmpty. Operand 146 states and 189 transitions.
[2025-05-07 17:23:55,690 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 105
[2025-05-07 17:23:55,690 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:55,690 INFO  L218           NwaCegarLoop]: trace histogram [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, 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:23:55,690 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable5
[2025-05-07 17:23:55,691 INFO  L403      AbstractCegarLoop]: === Iteration 6 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:55,691 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:55,691 INFO  L85        PathProgramCache]: Analyzing trace with hash -1326292945, now seen corresponding path program 1 times
[2025-05-07 17:23:55,691 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:55,691 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [102466248]
[2025-05-07 17:23:55,692 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:55,692 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:55,736 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 104 statements into 1 equivalence classes.
[2025-05-07 17:23:55,742 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 104 of 104 statements.
[2025-05-07 17:23:55,742 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:55,742 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:55,804 INFO  L134       CoverageAnalysis]: Checked inductivity of 9 backedges. 0 proven. 0 refuted. 0 times theorem prover too weak. 9 trivial. 0 not checked.
[2025-05-07 17:23:55,804 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:55,805 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [102466248]
[2025-05-07 17:23:55,805 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [102466248] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:55,805 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:55,805 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [4] imperfect sequences [] total 4
[2025-05-07 17:23:55,805 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1252128088]
[2025-05-07 17:23:55,805 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:55,805 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 4 states
[2025-05-07 17:23:55,805 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:55,806 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 4 interpolants.
[2025-05-07 17:23:55,806 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=5, Invalid=7, Unknown=0, NotChecked=0, Total=12
[2025-05-07 17:23:55,806 INFO  L87              Difference]: Start difference. First operand 146 states and 189 transitions. Second operand  has 4 states, 3 states have (on average 15.0) internal successors, (45), 4 states have internal predecessors, (45), 4 states have call successors, (28), 1 states have call predecessors, (28), 3 states have return successors, (28), 4 states have call predecessors, (28), 4 states have call successors, (28)
[2025-05-07 17:23:55,819 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:55,819 INFO  L93              Difference]: Finished difference Result 148 states and 190 transitions.
[2025-05-07 17:23:55,820 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 4 states. 
[2025-05-07 17:23:55,820 INFO  L79                 Accepts]: Start accepts. Automaton has  has 4 states, 3 states have (on average 15.0) internal successors, (45), 4 states have internal predecessors, (45), 4 states have call successors, (28), 1 states have call predecessors, (28), 3 states have return successors, (28), 4 states have call predecessors, (28), 4 states have call successors, (28) Word has length 104
[2025-05-07 17:23:55,820 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:55,821 INFO  L225             Difference]: With dead ends: 148
[2025-05-07 17:23:55,821 INFO  L226             Difference]: Without dead ends: 144
[2025-05-07 17:23:55,821 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:23:55,821 INFO  L437           NwaCegarLoop]: 141 mSDtfsCounter, 1 mSDsluCounter, 272 mSDsCounter, 0 mSdLazyCounter, 6 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 2 SdHoareTripleChecker+Valid, 413 SdHoareTripleChecker+Invalid, 6 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 6 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:55,822 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [2 Valid, 413 Invalid, 6 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 6 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:23:55,822 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 144 states.
[2025-05-07 17:23:55,827 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 144 to 144.
[2025-05-07 17:23:55,827 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 144 states, 59 states have (on average 1.0847457627118644) internal successors, (64), 64 states have internal predecessors, (64), 46 states have call successors, (47), 28 states have call predecessors, (47), 39 states have return successors, (73), 51 states have call predecessors, (73), 46 states have call successors, (73)
[2025-05-07 17:23:55,828 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 144 states to 144 states and 184 transitions.
[2025-05-07 17:23:55,828 INFO  L79                 Accepts]: Start accepts. Automaton has 144 states and 184 transitions. Word has length 104
[2025-05-07 17:23:55,828 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:55,828 INFO  L485      AbstractCegarLoop]: Abstraction has 144 states and 184 transitions.
[2025-05-07 17:23:55,828 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 4 states, 3 states have (on average 15.0) internal successors, (45), 4 states have internal predecessors, (45), 4 states have call successors, (28), 1 states have call predecessors, (28), 3 states have return successors, (28), 4 states have call predecessors, (28), 4 states have call successors, (28)
[2025-05-07 17:23:55,828 INFO  L278                IsEmpty]: Start isEmpty. Operand 144 states and 184 transitions.
[2025-05-07 17:23:55,829 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 105
[2025-05-07 17:23:55,829 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:55,829 INFO  L218           NwaCegarLoop]: trace histogram [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, 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:23:55,830 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable6
[2025-05-07 17:23:55,830 INFO  L403      AbstractCegarLoop]: === Iteration 7 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:55,830 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:55,830 INFO  L85        PathProgramCache]: Analyzing trace with hash 256901931, now seen corresponding path program 1 times
[2025-05-07 17:23:55,830 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:55,830 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [628296819]
[2025-05-07 17:23:55,830 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:55,830 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:55,871 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 104 statements into 1 equivalence classes.
[2025-05-07 17:23:55,894 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 104 of 104 statements.
[2025-05-07 17:23:55,894 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:55,894 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:56,059 INFO  L134       CoverageAnalysis]: Checked inductivity of 9 backedges. 4 proven. 0 refuted. 0 times theorem prover too weak. 5 trivial. 0 not checked.
[2025-05-07 17:23:56,059 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:56,059 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [628296819]
[2025-05-07 17:23:56,059 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [628296819] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:56,059 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:56,059 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [10] imperfect sequences [] total 10
[2025-05-07 17:23:56,059 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1875762174]
[2025-05-07 17:23:56,059 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:56,059 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-05-07 17:23:56,060 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:56,060 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-05-07 17:23:56,060 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=17, Invalid=73, Unknown=0, NotChecked=0, Total=90
[2025-05-07 17:23:56,060 INFO  L87              Difference]: Start difference. First operand 144 states and 184 transitions. Second operand  has 10 states, 8 states have (on average 5.75) internal successors, (46), 10 states have internal predecessors, (46), 7 states have call successors, (28), 1 states have call predecessors, (28), 8 states have return successors, (28), 9 states have call predecessors, (28), 7 states have call successors, (28)
[2025-05-07 17:23:56,205 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:56,205 INFO  L93              Difference]: Finished difference Result 148 states and 193 transitions.
[2025-05-07 17:23:56,205 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 10 states. 
[2025-05-07 17:23:56,205 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 8 states have (on average 5.75) internal successors, (46), 10 states have internal predecessors, (46), 7 states have call successors, (28), 1 states have call predecessors, (28), 8 states have return successors, (28), 9 states have call predecessors, (28), 7 states have call successors, (28) Word has length 104
[2025-05-07 17:23:56,206 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:56,206 INFO  L225             Difference]: With dead ends: 148
[2025-05-07 17:23:56,206 INFO  L226             Difference]: Without dead ends: 148
[2025-05-07 17:23:56,207 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 11 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 9 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.1s TimeCoverageRelationStatistics Valid=21, Invalid=89, Unknown=0, NotChecked=0, Total=110
[2025-05-07 17:23:56,207 INFO  L437           NwaCegarLoop]: 135 mSDtfsCounter, 2 mSDsluCounter, 1040 mSDsCounter, 0 mSdLazyCounter, 125 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 6 SdHoareTripleChecker+Valid, 1175 SdHoareTripleChecker+Invalid, 127 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 125 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:56,207 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [6 Valid, 1175 Invalid, 127 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 125 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:23:56,208 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 148 states.
[2025-05-07 17:23:56,212 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 148 to 146.
[2025-05-07 17:23:56,212 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 146 states, 60 states have (on average 1.0833333333333333) internal successors, (65), 65 states have internal predecessors, (65), 46 states have call successors, (47), 28 states have call predecessors, (47), 40 states have return successors, (79), 52 states have call predecessors, (79), 46 states have call successors, (79)
[2025-05-07 17:23:56,213 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 146 states to 146 states and 191 transitions.
[2025-05-07 17:23:56,213 INFO  L79                 Accepts]: Start accepts. Automaton has 146 states and 191 transitions. Word has length 104
[2025-05-07 17:23:56,213 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:56,214 INFO  L485      AbstractCegarLoop]: Abstraction has 146 states and 191 transitions.
[2025-05-07 17:23:56,214 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 8 states have (on average 5.75) internal successors, (46), 10 states have internal predecessors, (46), 7 states have call successors, (28), 1 states have call predecessors, (28), 8 states have return successors, (28), 9 states have call predecessors, (28), 7 states have call successors, (28)
[2025-05-07 17:23:56,214 INFO  L278                IsEmpty]: Start isEmpty. Operand 146 states and 191 transitions.
[2025-05-07 17:23:56,215 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 97
[2025-05-07 17:23:56,215 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:56,215 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:23:56,215 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable7
[2025-05-07 17:23:56,215 INFO  L403      AbstractCegarLoop]: === Iteration 8 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:56,215 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:56,215 INFO  L85        PathProgramCache]: Analyzing trace with hash 400526686, now seen corresponding path program 1 times
[2025-05-07 17:23:56,216 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:56,216 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1298094786]
[2025-05-07 17:23:56,216 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:56,216 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:56,250 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 96 statements into 1 equivalence classes.
[2025-05-07 17:23:56,260 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 96 of 96 statements.
[2025-05-07 17:23:56,260 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:56,260 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:57,234 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 2 proven. 0 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-05-07 17:23:57,234 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:57,234 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1298094786]
[2025-05-07 17:23:57,234 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1298094786] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:57,234 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:23:57,234 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [25] imperfect sequences [] total 25
[2025-05-07 17:23:57,234 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [800838467]
[2025-05-07 17:23:57,234 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:57,235 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 25 states
[2025-05-07 17:23:57,235 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:57,235 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 25 interpolants.
[2025-05-07 17:23:57,235 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=47, Invalid=553, Unknown=0, NotChecked=0, Total=600
[2025-05-07 17:23:57,236 INFO  L87              Difference]: Start difference. First operand 146 states and 191 transitions. Second operand  has 25 states, 19 states have (on average 2.3157894736842106) internal successors, (44), 21 states have internal predecessors, (44), 13 states have call successors, (26), 1 states have call predecessors, (26), 19 states have return successors, (26), 21 states have call predecessors, (26), 13 states have call successors, (26)
[2025-05-07 17:23:57,952 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:57,953 INFO  L93              Difference]: Finished difference Result 161 states and 220 transitions.
[2025-05-07 17:23:57,953 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 25 states. 
[2025-05-07 17:23:57,953 INFO  L79                 Accepts]: Start accepts. Automaton has  has 25 states, 19 states have (on average 2.3157894736842106) internal successors, (44), 21 states have internal predecessors, (44), 13 states have call successors, (26), 1 states have call predecessors, (26), 19 states have return successors, (26), 21 states have call predecessors, (26), 13 states have call successors, (26) Word has length 96
[2025-05-07 17:23:57,953 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:57,954 INFO  L225             Difference]: With dead ends: 161
[2025-05-07 17:23:57,954 INFO  L226             Difference]: Without dead ends: 161
[2025-05-07 17:23:57,955 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 30 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 28 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 10 ImplicationChecksByTransitivity, 0.3s TimeCoverageRelationStatistics Valid=67, Invalid=803, Unknown=0, NotChecked=0, Total=870
[2025-05-07 17:23:57,955 INFO  L437           NwaCegarLoop]: 128 mSDtfsCounter, 6 mSDsluCounter, 2837 mSDsCounter, 0 mSdLazyCounter, 865 mSolverCounterSat, 0 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.5s Time, 0 mProtectedPredicate, 0 mProtectedAction, 13 SdHoareTripleChecker+Valid, 2965 SdHoareTripleChecker+Invalid, 865 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Valid, 865 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.6s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:57,955 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [13 Valid, 2965 Invalid, 865 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [0 Valid, 865 Invalid, 0 Unknown, 0 Unchecked, 0.6s Time]
[2025-05-07 17:23:57,956 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 161 states.
[2025-05-07 17:23:57,967 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 161 to 159.
[2025-05-07 17:23:57,967 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 159 states, 65 states have (on average 1.0769230769230769) internal successors, (70), 70 states have internal predecessors, (70), 49 states have call successors, (50), 28 states have call predecessors, (50), 45 states have return successors, (98), 60 states have call predecessors, (98), 49 states have call successors, (98)
[2025-05-07 17:23:57,968 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 159 states to 159 states and 218 transitions.
[2025-05-07 17:23:57,968 INFO  L79                 Accepts]: Start accepts. Automaton has 159 states and 218 transitions. Word has length 96
[2025-05-07 17:23:57,968 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:57,968 INFO  L485      AbstractCegarLoop]: Abstraction has 159 states and 218 transitions.
[2025-05-07 17:23:57,968 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 25 states, 19 states have (on average 2.3157894736842106) internal successors, (44), 21 states have internal predecessors, (44), 13 states have call successors, (26), 1 states have call predecessors, (26), 19 states have return successors, (26), 21 states have call predecessors, (26), 13 states have call successors, (26)
[2025-05-07 17:23:57,968 INFO  L278                IsEmpty]: Start isEmpty. Operand 159 states and 218 transitions.
[2025-05-07 17:23:57,969 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 122
[2025-05-07 17:23:57,970 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:57,970 INFO  L218           NwaCegarLoop]: trace histogram [2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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:23:57,970 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable8
[2025-05-07 17:23:57,970 INFO  L403      AbstractCegarLoop]: === Iteration 9 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:57,970 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:57,970 INFO  L85        PathProgramCache]: Analyzing trace with hash 1304999883, now seen corresponding path program 1 times
[2025-05-07 17:23:57,970 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:57,971 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [302939209]
[2025-05-07 17:23:57,971 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:57,971 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:58,004 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 121 statements into 1 equivalence classes.
[2025-05-07 17:23:58,013 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 121 of 121 statements.
[2025-05-07 17:23:58,014 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:58,014 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:58,734 INFO  L134       CoverageAnalysis]: Checked inductivity of 26 backedges. 2 proven. 12 refuted. 0 times theorem prover too weak. 12 trivial. 0 not checked.
[2025-05-07 17:23:58,735 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:23:58,735 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [302939209]
[2025-05-07 17:23:58,735 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [302939209] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:23:58,735 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [1547234902]
[2025-05-07 17:23:58,735 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:58,735 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:23:58,738 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:23:58,740 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:23:58,741 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Waiting until timeout for monitored process
[2025-05-07 17:23:59,059 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 121 statements into 1 equivalence classes.
[2025-05-07 17:23:59,257 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 121 of 121 statements.
[2025-05-07 17:23:59,257 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:59,258 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:23:59,265 INFO  L256         TraceCheckSpWp]: Trace formula consists of 2039 conjuncts, 5 conjuncts are in the unsatisfiable core
[2025-05-07 17:23:59,276 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:23:59,384 INFO  L134       CoverageAnalysis]: Checked inductivity of 26 backedges. 22 proven. 0 refuted. 0 times theorem prover too weak. 4 trivial. 0 not checked.
[2025-05-07 17:23:59,384 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-05-07 17:23:59,384 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [1547234902] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:23:59,384 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-05-07 17:23:59,384 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [6] imperfect sequences [20] total 24
[2025-05-07 17:23:59,384 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [496651379]
[2025-05-07 17:23:59,384 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:23:59,384 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 6 states
[2025-05-07 17:23:59,384 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:23:59,385 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 6 interpolants.
[2025-05-07 17:23:59,385 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=45, Invalid=507, Unknown=0, NotChecked=0, Total=552
[2025-05-07 17:23:59,385 INFO  L87              Difference]: Start difference. First operand 159 states and 218 transitions. Second operand  has 6 states, 5 states have (on average 10.8) internal successors, (54), 6 states have internal predecessors, (54), 5 states have call successors, (33), 2 states have call predecessors, (33), 5 states have return successors, (33), 6 states have call predecessors, (33), 5 states have call successors, (33)
[2025-05-07 17:23:59,415 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:23:59,416 INFO  L93              Difference]: Finished difference Result 159 states and 217 transitions.
[2025-05-07 17:23:59,416 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 6 states. 
[2025-05-07 17:23:59,416 INFO  L79                 Accepts]: Start accepts. Automaton has  has 6 states, 5 states have (on average 10.8) internal successors, (54), 6 states have internal predecessors, (54), 5 states have call successors, (33), 2 states have call predecessors, (33), 5 states have return successors, (33), 6 states have call predecessors, (33), 5 states have call successors, (33) Word has length 121
[2025-05-07 17:23:59,416 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:23:59,417 INFO  L225             Difference]: With dead ends: 159
[2025-05-07 17:23:59,417 INFO  L226             Difference]: Without dead ends: 159
[2025-05-07 17:23:59,417 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 140 GetRequests, 118 SyntacticMatches, 0 SemanticMatches, 22 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.2s TimeCoverageRelationStatistics Valid=45, Invalid=507, Unknown=0, NotChecked=0, Total=552
[2025-05-07 17:23:59,417 INFO  L437           NwaCegarLoop]: 141 mSDtfsCounter, 1 mSDsluCounter, 546 mSDsCounter, 0 mSdLazyCounter, 18 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.0s Time, 0 mProtectedPredicate, 0 mProtectedAction, 4 SdHoareTripleChecker+Valid, 687 SdHoareTripleChecker+Invalid, 19 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 18 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.0s IncrementalHoareTripleChecker+Time
[2025-05-07 17:23:59,418 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [4 Valid, 687 Invalid, 19 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 18 Invalid, 0 Unknown, 0 Unchecked, 0.0s Time]
[2025-05-07 17:23:59,418 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 159 states.
[2025-05-07 17:23:59,424 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 159 to 159.
[2025-05-07 17:23:59,425 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 159 states, 65 states have (on average 1.0769230769230769) internal successors, (70), 70 states have internal predecessors, (70), 49 states have call successors, (50), 28 states have call predecessors, (50), 45 states have return successors, (97), 60 states have call predecessors, (97), 49 states have call successors, (97)
[2025-05-07 17:23:59,425 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 159 states to 159 states and 217 transitions.
[2025-05-07 17:23:59,426 INFO  L79                 Accepts]: Start accepts. Automaton has 159 states and 217 transitions. Word has length 121
[2025-05-07 17:23:59,426 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:23:59,426 INFO  L485      AbstractCegarLoop]: Abstraction has 159 states and 217 transitions.
[2025-05-07 17:23:59,426 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 6 states, 5 states have (on average 10.8) internal successors, (54), 6 states have internal predecessors, (54), 5 states have call successors, (33), 2 states have call predecessors, (33), 5 states have return successors, (33), 6 states have call predecessors, (33), 5 states have call successors, (33)
[2025-05-07 17:23:59,426 INFO  L278                IsEmpty]: Start isEmpty. Operand 159 states and 217 transitions.
[2025-05-07 17:23:59,427 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 122
[2025-05-07 17:23:59,427 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:23:59,427 INFO  L218           NwaCegarLoop]: trace histogram [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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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:23:59,433 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (2)] Ended with exit code 0
[2025-05-07 17:23:59,628 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: 2 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true,SelfDestructingSolverStorable9
[2025-05-07 17:23:59,628 INFO  L403      AbstractCegarLoop]: === Iteration 10 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:23:59,629 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:23:59,630 INFO  L85        PathProgramCache]: Analyzing trace with hash 230424035, now seen corresponding path program 1 times
[2025-05-07 17:23:59,630 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:23:59,630 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [885687583]
[2025-05-07 17:23:59,630 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:23:59,630 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:23:59,778 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 121 statements into 1 equivalence classes.
[2025-05-07 17:23:59,804 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 121 of 121 statements.
[2025-05-07 17:23:59,805 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:23:59,805 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:00,916 INFO  L134       CoverageAnalysis]: Checked inductivity of 22 backedges. 2 proven. 9 refuted. 0 times theorem prover too weak. 11 trivial. 0 not checked.
[2025-05-07 17:24:00,916 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:24:00,916 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [885687583]
[2025-05-07 17:24:00,917 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [885687583] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:24:00,917 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [2087392774]
[2025-05-07 17:24:00,917 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:24:00,917 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:24:00,918 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:24:00,920 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:24:00,921 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Waiting until timeout for monitored process
[2025-05-07 17:24:01,279 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 121 statements into 1 equivalence classes.
[2025-05-07 17:24:01,475 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 121 of 121 statements.
[2025-05-07 17:24:01,476 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:24:01,476 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:01,481 INFO  L256         TraceCheckSpWp]: Trace formula consists of 2038 conjuncts, 9 conjuncts are in the unsatisfiable core
[2025-05-07 17:24:01,484 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:24:01,672 INFO  L134       CoverageAnalysis]: Checked inductivity of 22 backedges. 7 proven. 0 refuted. 0 times theorem prover too weak. 15 trivial. 0 not checked.
[2025-05-07 17:24:01,672 INFO  L308         TraceCheckSpWp]: Omiting computation of backward sequence because forward sequence was already perfect
[2025-05-07 17:24:01,673 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [2087392774] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:24:01,673 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 1 imperfect interpolant sequences.
[2025-05-07 17:24:01,673 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [10] imperfect sequences [31] total 39
[2025-05-07 17:24:01,673 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [836772486]
[2025-05-07 17:24:01,673 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:24:01,673 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-05-07 17:24:01,673 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:24:01,674 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-05-07 17:24:01,675 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=75, Invalid=1407, Unknown=0, NotChecked=0, Total=1482
[2025-05-07 17:24:01,675 INFO  L87              Difference]: Start difference. First operand 159 states and 217 transitions. Second operand  has 10 states, 9 states have (on average 5.444444444444445) internal successors, (49), 10 states have internal predecessors, (49), 7 states have call successors, (31), 1 states have call predecessors, (31), 9 states have return successors, (32), 10 states have call predecessors, (32), 7 states have call successors, (32)
[2025-05-07 17:24:01,807 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:24:01,807 INFO  L93              Difference]: Finished difference Result 170 states and 243 transitions.
[2025-05-07 17:24:01,807 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 10 states. 
[2025-05-07 17:24:01,807 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 9 states have (on average 5.444444444444445) internal successors, (49), 10 states have internal predecessors, (49), 7 states have call successors, (31), 1 states have call predecessors, (31), 9 states have return successors, (32), 10 states have call predecessors, (32), 7 states have call successors, (32) Word has length 121
[2025-05-07 17:24:01,808 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:24:01,808 INFO  L225             Difference]: With dead ends: 170
[2025-05-07 17:24:01,808 INFO  L226             Difference]: Without dead ends: 170
[2025-05-07 17:24:01,809 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 152 GetRequests, 115 SyntacticMatches, 0 SemanticMatches, 37 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.5s TimeCoverageRelationStatistics Valid=75, Invalid=1407, Unknown=0, NotChecked=0, Total=1482
[2025-05-07 17:24:01,809 INFO  L437           NwaCegarLoop]: 148 mSDtfsCounter, 1 mSDsluCounter, 1134 mSDsCounter, 0 mSdLazyCounter, 160 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 3 SdHoareTripleChecker+Valid, 1282 SdHoareTripleChecker+Invalid, 161 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 160 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:24:01,809 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [3 Valid, 1282 Invalid, 161 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 160 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:24:01,810 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 170 states.
[2025-05-07 17:24:01,814 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 170 to 159.
[2025-05-07 17:24:01,814 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 159 states, 65 states have (on average 1.0769230769230769) internal successors, (70), 70 states have internal predecessors, (70), 49 states have call successors, (50), 28 states have call predecessors, (50), 45 states have return successors, (104), 60 states have call predecessors, (104), 49 states have call successors, (104)
[2025-05-07 17:24:01,815 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 159 states to 159 states and 224 transitions.
[2025-05-07 17:24:01,815 INFO  L79                 Accepts]: Start accepts. Automaton has 159 states and 224 transitions. Word has length 121
[2025-05-07 17:24:01,815 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:24:01,816 INFO  L485      AbstractCegarLoop]: Abstraction has 159 states and 224 transitions.
[2025-05-07 17:24:01,816 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 9 states have (on average 5.444444444444445) internal successors, (49), 10 states have internal predecessors, (49), 7 states have call successors, (31), 1 states have call predecessors, (31), 9 states have return successors, (32), 10 states have call predecessors, (32), 7 states have call successors, (32)
[2025-05-07 17:24:01,816 INFO  L278                IsEmpty]: Start isEmpty. Operand 159 states and 224 transitions.
[2025-05-07 17:24:01,817 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 97
[2025-05-07 17:24:01,817 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:24:01,817 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:24:01,822 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (3)] Ended with exit code 0
[2025-05-07 17:24:02,017 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable10,3 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:24:02,018 INFO  L403      AbstractCegarLoop]: === Iteration 11 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:24:02,019 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:24:02,019 INFO  L85        PathProgramCache]: Analyzing trace with hash -29185466, now seen corresponding path program 1 times
[2025-05-07 17:24:02,019 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:24:02,020 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [25526820]
[2025-05-07 17:24:02,020 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:24:02,020 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:24:02,116 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 96 statements into 1 equivalence classes.
[2025-05-07 17:24:02,133 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 96 of 96 statements.
[2025-05-07 17:24:02,134 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:24:02,134 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:02,236 INFO  L134       CoverageAnalysis]: Checked inductivity of 3 backedges. 2 proven. 0 refuted. 0 times theorem prover too weak. 1 trivial. 0 not checked.
[2025-05-07 17:24:02,236 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:24:02,236 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [25526820]
[2025-05-07 17:24:02,236 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [25526820] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:24:02,237 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:24:02,237 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [10] imperfect sequences [] total 10
[2025-05-07 17:24:02,237 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1271650092]
[2025-05-07 17:24:02,237 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:24:02,237 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 10 states
[2025-05-07 17:24:02,237 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:24:02,238 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 10 interpolants.
[2025-05-07 17:24:02,238 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=17, Invalid=73, Unknown=0, NotChecked=0, Total=90
[2025-05-07 17:24:02,238 INFO  L87              Difference]: Start difference. First operand 159 states and 224 transitions. Second operand  has 10 states, 8 states have (on average 5.5) internal successors, (44), 10 states have internal predecessors, (44), 7 states have call successors, (26), 1 states have call predecessors, (26), 8 states have return successors, (26), 8 states have call predecessors, (26), 7 states have call successors, (26)
[2025-05-07 17:24:02,356 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:24:02,356 INFO  L93              Difference]: Finished difference Result 161 states and 227 transitions.
[2025-05-07 17:24:02,356 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 10 states. 
[2025-05-07 17:24:02,357 INFO  L79                 Accepts]: Start accepts. Automaton has  has 10 states, 8 states have (on average 5.5) internal successors, (44), 10 states have internal predecessors, (44), 7 states have call successors, (26), 1 states have call predecessors, (26), 8 states have return successors, (26), 8 states have call predecessors, (26), 7 states have call successors, (26) Word has length 96
[2025-05-07 17:24:02,357 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:24:02,358 INFO  L225             Difference]: With dead ends: 161
[2025-05-07 17:24:02,358 INFO  L226             Difference]: Without dead ends: 161
[2025-05-07 17:24:02,358 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 11 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 9 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=21, Invalid=89, Unknown=0, NotChecked=0, Total=110
[2025-05-07 17:24:02,358 INFO  L437           NwaCegarLoop]: 126 mSDtfsCounter, 2 mSDsluCounter, 974 mSDsCounter, 0 mSdLazyCounter, 133 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 9 SdHoareTripleChecker+Valid, 1100 SdHoareTripleChecker+Invalid, 135 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 133 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:24:02,358 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [9 Valid, 1100 Invalid, 135 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 133 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:24:02,359 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 161 states.
[2025-05-07 17:24:02,363 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 161 to 157.
[2025-05-07 17:24:02,363 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 157 states, 64 states have (on average 1.078125) internal successors, (69), 69 states have internal predecessors, (69), 49 states have call successors, (50), 28 states have call predecessors, (50), 44 states have return successors, (97), 60 states have call predecessors, (97), 49 states have call successors, (97)
[2025-05-07 17:24:02,364 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 157 states to 157 states and 216 transitions.
[2025-05-07 17:24:02,364 INFO  L79                 Accepts]: Start accepts. Automaton has 157 states and 216 transitions. Word has length 96
[2025-05-07 17:24:02,364 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:24:02,364 INFO  L485      AbstractCegarLoop]: Abstraction has 157 states and 216 transitions.
[2025-05-07 17:24:02,364 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 10 states, 8 states have (on average 5.5) internal successors, (44), 10 states have internal predecessors, (44), 7 states have call successors, (26), 1 states have call predecessors, (26), 8 states have return successors, (26), 8 states have call predecessors, (26), 7 states have call successors, (26)
[2025-05-07 17:24:02,364 INFO  L278                IsEmpty]: Start isEmpty. Operand 157 states and 216 transitions.
[2025-05-07 17:24:02,365 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 121
[2025-05-07 17:24:02,365 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:24:02,365 INFO  L218           NwaCegarLoop]: trace histogram [5, 4, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 2, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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:24:02,365 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable11
[2025-05-07 17:24:02,365 INFO  L403      AbstractCegarLoop]: === Iteration 12 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:24:02,365 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:24:02,366 INFO  L85        PathProgramCache]: Analyzing trace with hash -1786734098, now seen corresponding path program 1 times
[2025-05-07 17:24:02,366 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:24:02,366 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1882925125]
[2025-05-07 17:24:02,366 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:24:02,366 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:24:02,391 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 120 statements into 1 equivalence classes.
[2025-05-07 17:24:02,402 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 120 of 120 statements.
[2025-05-07 17:24:02,402 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:24:02,402 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:02,503 INFO  L134       CoverageAnalysis]: Checked inductivity of 54 backedges. 15 proven. 0 refuted. 0 times theorem prover too weak. 39 trivial. 0 not checked.
[2025-05-07 17:24:02,503 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:24:02,503 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1882925125]
[2025-05-07 17:24:02,503 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1882925125] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:24:02,503 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:24:02,503 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [8] imperfect sequences [] total 8
[2025-05-07 17:24:02,503 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1225472631]
[2025-05-07 17:24:02,503 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:24:02,503 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 8 states
[2025-05-07 17:24:02,503 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:24:02,503 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 8 interpolants.
[2025-05-07 17:24:02,504 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:24:02,504 INFO  L87              Difference]: Start difference. First operand 157 states and 216 transitions. Second operand  has 8 states, 7 states have (on average 6.0) internal successors, (42), 8 states have internal predecessors, (42), 6 states have call successors, (28), 1 states have call predecessors, (28), 7 states have return successors, (30), 8 states have call predecessors, (30), 6 states have call successors, (30)
[2025-05-07 17:24:02,579 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:24:02,579 INFO  L93              Difference]: Finished difference Result 166 states and 244 transitions.
[2025-05-07 17:24:02,580 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-05-07 17:24:02,580 INFO  L79                 Accepts]: Start accepts. Automaton has  has 8 states, 7 states have (on average 6.0) internal successors, (42), 8 states have internal predecessors, (42), 6 states have call successors, (28), 1 states have call predecessors, (28), 7 states have return successors, (30), 8 states have call predecessors, (30), 6 states have call successors, (30) Word has length 120
[2025-05-07 17:24:02,580 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:24:02,581 INFO  L225             Difference]: With dead ends: 166
[2025-05-07 17:24:02,581 INFO  L226             Difference]: Without dead ends: 166
[2025-05-07 17:24:02,581 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 8 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 6 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:24:02,582 INFO  L437           NwaCegarLoop]: 129 mSDtfsCounter, 1 mSDsluCounter, 738 mSDsCounter, 0 mSdLazyCounter, 89 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 4 SdHoareTripleChecker+Valid, 867 SdHoareTripleChecker+Invalid, 91 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 89 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:24:02,582 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [4 Valid, 867 Invalid, 91 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 89 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:24:02,582 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 166 states.
[2025-05-07 17:24:02,586 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 166 to 160.
[2025-05-07 17:24:02,587 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 160 states, 65 states have (on average 1.0769230769230769) internal successors, (70), 70 states have internal predecessors, (70), 50 states have call successors, (51), 28 states have call predecessors, (51), 45 states have return successors, (110), 62 states have call predecessors, (110), 50 states have call successors, (110)
[2025-05-07 17:24:02,587 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 160 states to 160 states and 231 transitions.
[2025-05-07 17:24:02,588 INFO  L79                 Accepts]: Start accepts. Automaton has 160 states and 231 transitions. Word has length 120
[2025-05-07 17:24:02,588 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:24:02,588 INFO  L485      AbstractCegarLoop]: Abstraction has 160 states and 231 transitions.
[2025-05-07 17:24:02,588 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 8 states, 7 states have (on average 6.0) internal successors, (42), 8 states have internal predecessors, (42), 6 states have call successors, (28), 1 states have call predecessors, (28), 7 states have return successors, (30), 8 states have call predecessors, (30), 6 states have call successors, (30)
[2025-05-07 17:24:02,588 INFO  L278                IsEmpty]: Start isEmpty. Operand 160 states and 231 transitions.
[2025-05-07 17:24:02,589 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 113
[2025-05-07 17:24:02,589 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:24:02,589 INFO  L218           NwaCegarLoop]: trace histogram [4, 3, 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:24:02,589 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable12
[2025-05-07 17:24:02,589 INFO  L403      AbstractCegarLoop]: === Iteration 13 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:24:02,589 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:24:02,589 INFO  L85        PathProgramCache]: Analyzing trace with hash 70148643, now seen corresponding path program 1 times
[2025-05-07 17:24:02,590 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:24:02,590 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [611123943]
[2025-05-07 17:24:02,590 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:24:02,590 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:24:02,615 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 112 statements into 1 equivalence classes.
[2025-05-07 17:24:02,626 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 112 of 112 statements.
[2025-05-07 17:24:02,626 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:24:02,626 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:02,758 INFO  L134       CoverageAnalysis]: Checked inductivity of 38 backedges. 13 proven. 0 refuted. 0 times theorem prover too weak. 25 trivial. 0 not checked.
[2025-05-07 17:24:02,758 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:24:02,758 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [611123943]
[2025-05-07 17:24:02,758 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [611123943] provided 1 perfect and 0 imperfect interpolant sequences
[2025-05-07 17:24:02,758 INFO  L185   FreeRefinementEngine]: Found 1 perfect and 0 imperfect interpolant sequences.
[2025-05-07 17:24:02,759 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [8] imperfect sequences [] total 8
[2025-05-07 17:24:02,759 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1939837450]
[2025-05-07 17:24:02,759 INFO  L85    oduleStraightlineAll]: Using 1 perfect interpolants to construct interpolant automaton
[2025-05-07 17:24:02,759 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 8 states
[2025-05-07 17:24:02,759 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:24:02,760 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 8 interpolants.
[2025-05-07 17:24:02,760 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:24:02,760 INFO  L87              Difference]: Start difference. First operand 160 states and 231 transitions. Second operand  has 8 states, 7 states have (on average 6.0) internal successors, (42), 8 states have internal predecessors, (42), 6 states have call successors, (27), 1 states have call predecessors, (27), 7 states have return successors, (29), 7 states have call predecessors, (29), 6 states have call successors, (29)
[2025-05-07 17:24:02,872 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:24:02,872 INFO  L93              Difference]: Finished difference Result 166 states and 246 transitions.
[2025-05-07 17:24:02,872 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 8 states. 
[2025-05-07 17:24:02,872 INFO  L79                 Accepts]: Start accepts. Automaton has  has 8 states, 7 states have (on average 6.0) internal successors, (42), 8 states have internal predecessors, (42), 6 states have call successors, (27), 1 states have call predecessors, (27), 7 states have return successors, (29), 7 states have call predecessors, (29), 6 states have call successors, (29) Word has length 112
[2025-05-07 17:24:02,873 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:24:02,873 INFO  L225             Difference]: With dead ends: 166
[2025-05-07 17:24:02,873 INFO  L226             Difference]: Without dead ends: 166
[2025-05-07 17:24:02,874 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 8 GetRequests, 2 SyntacticMatches, 0 SemanticMatches, 6 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 0 ImplicationChecksByTransitivity, 0.0s TimeCoverageRelationStatistics Valid=13, Invalid=43, Unknown=0, NotChecked=0, Total=56
[2025-05-07 17:24:02,874 INFO  L437           NwaCegarLoop]: 129 mSDtfsCounter, 1 mSDsluCounter, 738 mSDsCounter, 0 mSdLazyCounter, 95 mSolverCounterSat, 2 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.1s Time, 0 mProtectedPredicate, 0 mProtectedAction, 7 SdHoareTripleChecker+Valid, 867 SdHoareTripleChecker+Invalid, 97 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 2 IncrementalHoareTripleChecker+Valid, 95 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.1s IncrementalHoareTripleChecker+Time
[2025-05-07 17:24:02,874 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [7 Valid, 867 Invalid, 97 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [2 Valid, 95 Invalid, 0 Unknown, 0 Unchecked, 0.1s Time]
[2025-05-07 17:24:02,874 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 166 states.
[2025-05-07 17:24:02,878 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 166 to 158.
[2025-05-07 17:24:02,879 INFO  L82        GeneralOperation]: Start removeUnreachable. Operand  has 158 states, 64 states have (on average 1.078125) internal successors, (69), 69 states have internal predecessors, (69), 50 states have call successors, (51), 28 states have call predecessors, (51), 44 states have return successors, (102), 61 states have call predecessors, (102), 50 states have call successors, (102)
[2025-05-07 17:24:02,879 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 158 states to 158 states and 222 transitions.
[2025-05-07 17:24:02,879 INFO  L79                 Accepts]: Start accepts. Automaton has 158 states and 222 transitions. Word has length 112
[2025-05-07 17:24:02,880 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:24:02,880 INFO  L485      AbstractCegarLoop]: Abstraction has 158 states and 222 transitions.
[2025-05-07 17:24:02,880 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 8 states, 7 states have (on average 6.0) internal successors, (42), 8 states have internal predecessors, (42), 6 states have call successors, (27), 1 states have call predecessors, (27), 7 states have return successors, (29), 7 states have call predecessors, (29), 6 states have call successors, (29)
[2025-05-07 17:24:02,880 INFO  L278                IsEmpty]: Start isEmpty. Operand 158 states and 222 transitions.
[2025-05-07 17:24:02,881 INFO  L284                IsEmpty]: Finished isEmpty. Found accepting run of length 135
[2025-05-07 17:24:02,881 INFO  L210           NwaCegarLoop]: Found error trace
[2025-05-07 17:24:02,881 INFO  L218           NwaCegarLoop]: trace histogram [5, 3, 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, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 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:24:02,881 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable13
[2025-05-07 17:24:02,881 INFO  L403      AbstractCegarLoop]: === Iteration 14 === Targeting Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY === [Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY] ===
[2025-05-07 17:24:02,881 INFO  L155       PredicateUnifier]: Initialized classic predicate unifier
[2025-05-07 17:24:02,881 INFO  L85        PathProgramCache]: Analyzing trace with hash -239949211, now seen corresponding path program 1 times
[2025-05-07 17:24:02,881 INFO  L118   FreeRefinementEngine]: Executing refinement strategy CAMEL
[2025-05-07 17:24:02,881 INFO  L324   FreeRefinementEngine]: Using trace check IpTcStrategyModuleSmtInterpolCraig [1730599829]
[2025-05-07 17:24:02,881 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:24:02,882 INFO  L127          SolverBuilder]: Constructing new instance of SMTInterpol with explicit timeout -1 ms and remaining time -1 ms
[2025-05-07 17:24:02,927 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 134 statements into 1 equivalence classes.
[2025-05-07 17:24:02,945 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 134 of 134 statements.
[2025-05-07 17:24:02,945 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:24:02,945 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:04,009 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 15 proven. 9 refuted. 0 times theorem prover too weak. 26 trivial. 0 not checked.
[2025-05-07 17:24:04,009 INFO  L136   FreeRefinementEngine]: Strategy CAMEL found an infeasible trace
[2025-05-07 17:24:04,009 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleSmtInterpolCraig [1730599829]
[2025-05-07 17:24:04,009 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleSmtInterpolCraig [1730599829] provided 0 perfect and 1 imperfect interpolant sequences
[2025-05-07 17:24:04,009 INFO  L324   FreeRefinementEngine]: Using interpolant generator IpTcStrategyModuleZ3 [2002669787]
[2025-05-07 17:24:04,010 INFO  L97    rtionOrderModulation]: Keeping assertion order NOT_INCREMENTALLY
[2025-05-07 17:24:04,010 INFO  L173          SolverBuilder]: Constructing external solver with command: z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:24:04,012 INFO  L189       MonitoredProcess]: No working directory specified, using /usr/bin/z3
[2025-05-07 17:24:04,013 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:24:04,014 INFO  L327       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Waiting until timeout for monitored process
[2025-05-07 17:24:04,337 INFO  L108    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY partitioned 134 statements into 1 equivalence classes.
[2025-05-07 17:24:04,508 INFO  L111    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s) and asserted 134 of 134 statements.
[2025-05-07 17:24:04,508 INFO  L114    AnnotateAndAsserter]: Assert order NOT_INCREMENTALLY issued 1 check-sat command(s)
[2025-05-07 17:24:04,508 INFO  L115    AnnotateAndAsserter]: Conjunction of SSA is unsat
[2025-05-07 17:24:04,514 INFO  L256         TraceCheckSpWp]: Trace formula consists of 2245 conjuncts, 13 conjuncts are in the unsatisfiable core
[2025-05-07 17:24:04,517 INFO  L279         TraceCheckSpWp]: Computing forward predicates...
[2025-05-07 17:24:04,712 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 12 proven. 2 refuted. 0 times theorem prover too weak. 36 trivial. 0 not checked.
[2025-05-07 17:24:04,713 INFO  L312         TraceCheckSpWp]: Computing backward predicates...
[2025-05-07 17:24:08,383 INFO  L134       CoverageAnalysis]: Checked inductivity of 50 backedges. 12 proven. 2 refuted. 0 times theorem prover too weak. 36 trivial. 0 not checked.
[2025-05-07 17:24:08,383 INFO  L158   FreeRefinementEngine]: IpTcStrategyModuleZ3 [2002669787] provided 0 perfect and 2 imperfect interpolant sequences
[2025-05-07 17:24:08,383 INFO  L185   FreeRefinementEngine]: Found 0 perfect and 3 imperfect interpolant sequences.
[2025-05-07 17:24:08,384 INFO  L198   FreeRefinementEngine]: Number of different interpolants: perfect sequences [] imperfect sequences [28, 11, 11] total 38
[2025-05-07 17:24:08,384 INFO  L121   tionRefinementEngine]: Using interpolant automaton builder IpAbStrategyModuleStraightlineAll [1758479883]
[2025-05-07 17:24:08,384 INFO  L85    oduleStraightlineAll]: Using 3 imperfect interpolants to construct interpolant automaton
[2025-05-07 17:24:08,384 INFO  L562      AbstractCegarLoop]: INTERPOLANT automaton has 38 states
[2025-05-07 17:24:08,384 INFO  L100   FreeRefinementEngine]: Using predicate unifier PredicateUnifier provided by strategy CAMEL
[2025-05-07 17:24:08,385 INFO  L144   InterpolantAutomaton]: Constructing interpolant automaton starting with 38 interpolants.
[2025-05-07 17:24:08,385 INFO  L146   InterpolantAutomaton]: CoverageRelationStatistics Valid=74, Invalid=1332, Unknown=0, NotChecked=0, Total=1406
[2025-05-07 17:24:08,386 INFO  L87              Difference]: Start difference. First operand 158 states and 222 transitions. Second operand  has 38 states, 30 states have (on average 2.6333333333333333) internal successors, (79), 35 states have internal predecessors, (79), 22 states have call successors, (50), 1 states have call predecessors, (50), 30 states have return successors, (64), 33 states have call predecessors, (64), 22 states have call successors, (64)
[2025-05-07 17:24:09,370 INFO  L144             Difference]: Subtrahend was deterministic. Have not used determinization.
[2025-05-07 17:24:09,370 INFO  L93              Difference]: Finished difference Result 160 states and 228 transitions.
[2025-05-07 17:24:09,370 INFO  L140   InterpolantAutomaton]: Switched to read-only mode: deterministic interpolant automaton has 29 states. 
[2025-05-07 17:24:09,371 INFO  L79                 Accepts]: Start accepts. Automaton has  has 38 states, 30 states have (on average 2.6333333333333333) internal successors, (79), 35 states have internal predecessors, (79), 22 states have call successors, (50), 1 states have call predecessors, (50), 30 states have return successors, (64), 33 states have call predecessors, (64), 22 states have call successors, (64) Word has length 134
[2025-05-07 17:24:09,371 INFO  L85                 Accepts]: Finished accepts. some prefix is accepted.
[2025-05-07 17:24:09,371 INFO  L225             Difference]: With dead ends: 160
[2025-05-07 17:24:09,371 INFO  L226             Difference]: Without dead ends: 0
[2025-05-07 17:24:09,371 INFO  L436           NwaCegarLoop]: 0 DeclaredPredicates, 311 GetRequests, 251 SyntacticMatches, 11 SemanticMatches, 49 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 88 ImplicationChecksByTransitivity, 1.0s TimeCoverageRelationStatistics Valid=135, Invalid=2415, Unknown=0, NotChecked=0, Total=2550
[2025-05-07 17:24:09,372 INFO  L437           NwaCegarLoop]: 118 mSDtfsCounter, 5 mSDsluCounter, 4047 mSDsCounter, 0 mSdLazyCounter, 1436 mSolverCounterSat, 1 mSolverCounterUnsat, 0 mSolverCounterUnknown, 0 mSolverCounterNotChecked, 0.6s Time, 0 mProtectedPredicate, 0 mProtectedAction, 11 SdHoareTripleChecker+Valid, 4165 SdHoareTripleChecker+Invalid, 1437 SdHoareTripleChecker+Unknown, 0 SdHoareTripleChecker+Unchecked, 0.0s SdHoareTripleChecker+Time, 1 IncrementalHoareTripleChecker+Valid, 1436 IncrementalHoareTripleChecker+Invalid, 0 IncrementalHoareTripleChecker+Unknown, 0 IncrementalHoareTripleChecker+Unchecked, 0.7s IncrementalHoareTripleChecker+Time
[2025-05-07 17:24:09,372 INFO  L438           NwaCegarLoop]: SdHoareTripleChecker [11 Valid, 4165 Invalid, 1437 Unknown, 0 Unchecked, 0.0s Time], IncrementalHoareTripleChecker [1 Valid, 1436 Invalid, 0 Unknown, 0 Unchecked, 0.7s Time]
[2025-05-07 17:24:09,372 INFO  L82        GeneralOperation]: Start minimizeSevpa. Operand 0 states.
[2025-05-07 17:24:09,372 INFO  L88        GeneralOperation]: Finished minimizeSevpa. Reduced states from 0 to 0.
[2025-05-07 17:24:09,372 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:24:09,372 INFO  L88        GeneralOperation]: Finished removeUnreachable. Reduced from 0 states to 0 states and 0 transitions.
[2025-05-07 17:24:09,373 INFO  L79                 Accepts]: Start accepts. Automaton has 0 states and 0 transitions. Word has length 134
[2025-05-07 17:24:09,373 INFO  L85                 Accepts]: Finished accepts. word is rejected.
[2025-05-07 17:24:09,373 INFO  L485      AbstractCegarLoop]: Abstraction has 0 states and 0 transitions.
[2025-05-07 17:24:09,373 INFO  L486      AbstractCegarLoop]: INTERPOLANT automaton has  has 38 states, 30 states have (on average 2.6333333333333333) internal successors, (79), 35 states have internal predecessors, (79), 22 states have call successors, (50), 1 states have call predecessors, (50), 30 states have return successors, (64), 33 states have call predecessors, (64), 22 states have call successors, (64)
[2025-05-07 17:24:09,373 INFO  L278                IsEmpty]: Start isEmpty. Operand 0 states and 0 transitions.
[2025-05-07 17:24:09,373 INFO  L284                IsEmpty]: Finished isEmpty. No accepting run.
[2025-05-07 17:24:09,375 INFO  L790   garLoopResultBuilder]: Registering result SAFE for location Ultimate.STARTErr0ASSERT_VIOLATIONCHC_SATISFIABILITY (0 of 1 remaining)
[2025-05-07 17:24:09,381 INFO  L552       MonitoredProcess]: [MP /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true (4)] Ended with exit code 0
[2025-05-07 17:24:09,576 WARN  L466      AbstractCegarLoop]: Destroyed unattended storables created during the last iteration: SelfDestructingSolverStorable14,4 /usr/bin/z3 -smt2 -in SMTLIB2_COMPLIANT=true
[2025-05-07 17:24:09,584 INFO  L422         BasicCegarLoop]: Path program histogram: [1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1]
[2025-05-07 17:24:09,586 INFO  L171   ceAbstractionStarter]: Computing trace abstraction results
[2025-05-07 17:24:09,589 INFO  L201        PluginConnector]: Adding new model de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction CFG 07.05 05:24:09 BoogieIcfgContainer
[2025-05-07 17:24:09,589 INFO  L131        PluginConnector]: ------------------------ END TraceAbstraction----------------------------
[2025-05-07 17:24:09,589 INFO  L158              Benchmark]: Toolchain (without parser) took 16263.54ms. Allocated memory was 234.9MB in the beginning and 536.9MB in the end (delta: 302.0MB). Free memory was 139.9MB in the beginning and 336.4MB in the end (delta: -196.5MB). Peak memory consumption was 128.3MB. Max. memory is 33.6GB.
[2025-05-07 17:24:09,589 INFO  L158              Benchmark]: SmtParser took 0.19ms. Allocated memory is still 234.9MB. Free memory is still 174.1MB. There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:24:09,590 INFO  L158              Benchmark]: ChcToBoogie took 36.40ms. Allocated memory is still 234.9MB. Free memory was 139.9MB in the beginning and 136.2MB in the end (delta: 3.7MB). Peak memory consumption was 16.8MB. Max. memory is 33.6GB.
[2025-05-07 17:24:09,590 INFO  L158              Benchmark]: Boogie Preprocessor took 55.52ms. Allocated memory is still 234.9MB. Free memory was 136.2MB in the beginning and 132.4MB in the end (delta: 3.8MB). There was no memory consumed. Max. memory is 33.6GB.
[2025-05-07 17:24:09,590 INFO  L158              Benchmark]: RCFGBuilder took 468.43ms. Allocated memory is still 234.9MB. Free memory was 132.4MB in the beginning and 150.5MB in the end (delta: -18.1MB). Peak memory consumption was 27.1MB. Max. memory is 33.6GB.
[2025-05-07 17:24:09,590 INFO  L158              Benchmark]: TraceAbstraction took 15699.97ms. Allocated memory was 234.9MB in the beginning and 536.9MB in the end (delta: 302.0MB). Free memory was 149.9MB in the beginning and 336.4MB in the end (delta: -186.4MB). Peak memory consumption was 118.0MB. Max. memory is 33.6GB.
[2025-05-07 17:24:09,591 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.19ms. Allocated memory is still 234.9MB. Free memory is still 174.1MB. There was no memory consumed. Max. memory is 33.6GB.
 * ChcToBoogie took 36.40ms. Allocated memory is still 234.9MB. Free memory was 139.9MB in the beginning and 136.2MB in the end (delta: 3.7MB). Peak memory consumption was 16.8MB. Max. memory is 33.6GB.
 * Boogie Preprocessor took 55.52ms. Allocated memory is still 234.9MB. Free memory was 136.2MB in the beginning and 132.4MB in the end (delta: 3.8MB). There was no memory consumed. Max. memory is 33.6GB.
 * RCFGBuilder took 468.43ms. Allocated memory is still 234.9MB. Free memory was 132.4MB in the beginning and 150.5MB in the end (delta: -18.1MB). Peak memory consumption was 27.1MB. Max. memory is 33.6GB.
 * TraceAbstraction took 15699.97ms. Allocated memory was 234.9MB in the beginning and 536.9MB in the end (delta: 302.0MB). Free memory was 149.9MB in the beginning and 336.4MB in the end (delta: -186.4MB). Peak memory consumption was 118.0MB. Max. memory is 33.6GB.
 * Results from de.uni_freiburg.informatik.ultimate.plugins.generator.traceabstraction:
  - StatisticsResult: ErrorAutomatonStatistics
    NumberErrorTraces: 0, NumberStatementsAllTraces: 0, NumberRelevantStatements: 0, 0.0s ErrorAutomatonConstructionTimeTotal, 0.0s FaulLocalizationTime, NumberStatementsFirstTrace: -1, TraceLengthAvg: 0, 0.0s ErrorAutomatonConstructionTimeAvg, 0.0s ErrorAutomatonDifferenceTimeAvg, 0.0s ErrorAutomatonDifferenceTimeTotal, NumberOfNoEnhancement: 0, NumberOfFiniteEnhancement: 0, NumberOfInfiniteEnhancement: 0
  - PositiveResult [Unknown line] : the set of constraint Horn clauses is satisfiable
    For all program executions holds that the set of constraint Horn clauses is satisfiable at this location
  - StatisticsResult: Ultimate Automizer benchmark data
    CFG has 30 procedures, 129 locations, 209 edges, 1 error locations. Started 1 CEGAR loops. OverallTime: 15.7s, OverallIterations: 14, TraceHistogramMax: 5, PathProgramHistogramMax: 1, EmptinessCheckTime: 0.0s, AutomataDifference: 2.8s, DeadEndRemovalTime: 0.0s, HoareAnnotationTime: 0.0s, InitialAbstractionConstructionTime: 0.0s, HoareTripleCheckerStatistics: 0 mSolverCounterUnknown, 77 SdHoareTripleChecker+Valid, 2.2s IncrementalHoareTripleChecker+Time, 0 mSdLazyCounter, 25 mSDsluCounter, 17073 SdHoareTripleChecker+Invalid, 1.9s Time, 0 mProtectedAction, 0 SdHoareTripleChecker+Unchecked, 0 IncrementalHoareTripleChecker+Unchecked, 15156 mSDsCounter, 14 IncrementalHoareTripleChecker+Valid, 0 mProtectedPredicate, 3177 IncrementalHoareTripleChecker+Invalid, 3191 SdHoareTripleChecker+Unknown, 0 mSolverCounterNotChecked, 14 mSolverCounterUnsat, 1917 mSDtfsCounter, 3177 mSolverCounterSat, 0.1s SdHoareTripleChecker+Time, 0 IncrementalHoareTripleChecker+Unknown, PredicateUnifierStatistics: 0 DeclaredPredicates, 705 GetRequests, 506 SyntacticMatches, 11 SemanticMatches, 188 ConstructedPredicates, 0 IntricatePredicates, 0 DeprecatedPredicates, 98 ImplicationChecksByTransitivity, 2.2s Time, 0.0s BasicInterpolantAutomatonTime, BiggestAbstraction: size=160occurred in iteration=12, InterpolantAutomatonStates: 140, 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, 14 MinimizatonAttempts, 39 StatesRemovedByMinimization, 9 NontrivialMinimizations, HoareAnnotationStatistics: No data available, RefinementEngineStatistics: TRACE_CHECK: 0.5s SsaConstructionTime, 0.9s SatisfiabilityAnalysisTime, 9.4s InterpolantComputationTime, 1799 NumberOfCodeBlocks, 1799 NumberOfCodeBlocksAsserted, 17 NumberOfCheckSat, 1915 ConstructedInterpolants, 0 QuantifiedInterpolants, 3168 SizeOfPredicates, 0 NumberOfNonLiveVariables, 6322 ConjunctsInSsa, 27 ConjunctsInUnsatCore, 18 InterpolantComputations, 13 PerfectInterpolantSequences, 346/380 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:24:09,602 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
