Warning: Permanently added '10.128.1.146' (ED25519) to the list of known hosts. 2024/02/06 16:26:30 ignoring optional flag "sandboxArg"="0" 2024/02/06 16:26:30 parsed 1 programs 2024/02/06 16:26:30 executed programs: 0 [ 107.349622][ T4465] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 107.357607][ T4465] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 107.365813][ T4465] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 107.374796][ T4465] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 107.383479][ T4465] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 107.391289][ T4465] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 107.570616][ T5436] chnl_net:caif_netlink_parms(): no params data found [ 107.653283][ T5436] bridge0: port 1(bridge_slave_0) entered blocking state [ 107.660459][ T5436] bridge0: port 1(bridge_slave_0) entered disabled state [ 107.668511][ T5436] bridge_slave_0: entered allmulticast mode [ 107.676214][ T5436] bridge_slave_0: entered promiscuous mode [ 107.685299][ T5436] bridge0: port 2(bridge_slave_1) entered blocking state [ 107.692821][ T5436] bridge0: port 2(bridge_slave_1) entered disabled state [ 107.700016][ T5436] bridge_slave_1: entered allmulticast mode [ 107.707402][ T5436] bridge_slave_1: entered promiscuous mode [ 107.744248][ T5436] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 107.757150][ T5436] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 107.799675][ T5436] team0: Port device team_slave_0 added [ 107.809013][ T5436] team0: Port device team_slave_1 added [ 107.841707][ T5436] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 107.848831][ T5436] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 107.874795][ T5436] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 107.888686][ T5436] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 107.895763][ T5436] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 107.921755][ T5436] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 107.976316][ T5436] hsr_slave_0: entered promiscuous mode [ 107.983540][ T5436] hsr_slave_1: entered promiscuous mode [ 108.884028][ T5436] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 108.898078][ T5436] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 108.911023][ T5436] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 108.925053][ T5436] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 109.063655][ T5436] 8021q: adding VLAN 0 to HW filter on device bond0 [ 109.094431][ T5436] 8021q: adding VLAN 0 to HW filter on device team0 [ 109.109949][ T5087] bridge0: port 1(bridge_slave_0) entered blocking state [ 109.117170][ T5087] bridge0: port 1(bridge_slave_0) entered forwarding state [ 109.141630][ T5087] bridge0: port 2(bridge_slave_1) entered blocking state [ 109.148848][ T5087] bridge0: port 2(bridge_slave_1) entered forwarding state [ 109.426932][ T5436] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 109.444794][ T4465] Bluetooth: hci0: command 0x0409 tx timeout [ 109.508849][ T5436] veth0_vlan: entered promiscuous mode [ 109.529370][ T5436] veth1_vlan: entered promiscuous mode [ 109.578817][ T5436] veth0_macvtap: entered promiscuous mode [ 109.590722][ T5436] veth1_macvtap: entered promiscuous mode [ 109.628716][ T5436] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 109.651877][ T5436] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 109.673156][ T5436] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 109.681917][ T5436] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 109.701451][ T5436] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 109.717860][ T5436] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 109.840363][ T2848] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 109.866656][ T2848] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 109.920229][ T2848] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 109.933275][ T2848] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 111.523231][ T4465] Bluetooth: hci0: command 0x041b tx timeout 2024/02/06 16:26:35 executed programs: 26 [ 113.246661][ C0] [ 113.249039][ C0] ====================================================== [ 113.256055][ C0] WARNING: possible circular locking dependency detected [ 113.263069][ C0] 6.8.0-rc3-syzkaller-g99bd3cb0d12e #0 Not tainted [ 113.269561][ C0] ------------------------------------------------------ [ 113.276576][ C0] kworker/u4:1/12 is trying to acquire lock: [ 113.282552][ C0] ffff88801e510620 (&rs->rs_recv_lock){...-}-{2:2}, at: rds_wake_sk_sleep+0x2e/0xd0 [ 113.291975][ C0] [ 113.291975][ C0] but task is already holding lock: [ 113.299337][ C0] ffff88801eaaf100 (&rm->m_rs_lock){..-.}-{2:2}, at: rds_send_remove_from_sock+0x129/0x800 [ 113.309392][ C0] [ 113.309392][ C0] which lock already depends on the new lock. [ 113.309392][ C0] [ 113.319817][ C0] [ 113.319817][ C0] the existing dependency chain (in reverse order) is: [ 113.328837][ C0] [ 113.328837][ C0] -> #1 (&rm->m_rs_lock){..-.}-{2:2}: [ 113.336419][ C0] lock_acquire+0x1e3/0x530 [ 113.341466][ C0] _raw_spin_lock_irqsave+0xd5/0x120 [ 113.347349][ C0] rds_message_put+0x14a/0xab0 [ 113.352907][ C0] rds_clear_recv_queue+0x2e8/0x3c0 [ 113.358646][ C0] rds_release+0xc5/0x2e0 [ 113.363503][ C0] sock_close+0xbe/0x240 [ 113.368275][ C0] __fput+0x42b/0x8a0 [ 113.372785][ C0] __x64_sys_close+0x7e/0x110 [ 113.377994][ C0] do_syscall_64+0xfb/0x240 [ 113.383040][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 113.389908][ C0] [ 113.389908][ C0] -> #0 (&rs->rs_recv_lock){...-}-{2:2}: [ 113.398104][ C0] validate_chain+0x18ca/0x58e0 [ 113.404117][ C0] __lock_acquire+0x1345/0x1fd0 [ 113.409508][ C0] lock_acquire+0x1e3/0x530 [ 113.414549][ C0] _raw_read_lock_irqsave+0xdd/0x130 [ 113.420370][ C0] rds_wake_sk_sleep+0x2e/0xd0 [ 113.425657][ C0] rds_send_remove_from_sock+0x1c9/0x800 [ 113.431823][ C0] rds_send_path_drop_acked+0x36b/0x3b0 [ 113.437906][ C0] rds_tcp_write_space+0x196/0x5f0 [ 113.443554][ C0] tcp_check_space+0x660/0xb00 [ 113.448846][ C0] tcp_rcv_established+0x101c/0x2030 [ 113.454655][ C0] tcp_v4_do_rcv+0x8dd/0xb90 [ 113.459771][ C0] tcp_v4_rcv+0x2cba/0x35c0 [ 113.464792][ C0] ip_protocol_deliver_rcu+0x225/0x430 [ 113.470770][ C0] ip_local_deliver_finish+0x2b6/0x500 [ 113.476750][ C0] NF_HOOK+0x3a6/0x450 [ 113.481338][ C0] NF_HOOK+0x3a6/0x450 [ 113.485933][ C0] __netif_receive_skb+0x2bf/0x6a0 [ 113.491565][ C0] process_backlog+0x385/0x760 [ 113.496847][ C0] __napi_poll+0xcd/0x490 [ 113.501700][ C0] net_rx_action+0x78b/0x1010 [ 113.506902][ C0] __do_softirq+0x2bd/0x942 [ 113.511928][ C0] do_softirq+0x11b/0x1e0 [ 113.516792][ C0] __local_bh_enable_ip+0x1bb/0x200 [ 113.522515][ C0] rds_tcp_tune+0x46b/0x630 [ 113.527543][ C0] rds_tcp_accept_one+0x32f/0xbb0 [ 113.533080][ C0] rds_tcp_accept_worker+0x3f/0xa0 [ 113.538704][ C0] process_scheduled_works+0x915/0x1420 [ 113.544775][ C0] worker_thread+0xa5f/0x1000 [ 113.550057][ C0] kthread+0x2f1/0x390 [ 113.554638][ C0] ret_from_fork+0x4d/0x80 [ 113.559573][ C0] ret_from_fork_asm+0x1b/0x30 [ 113.564859][ C0] [ 113.564859][ C0] other info that might help us debug this: [ 113.564859][ C0] [ 113.575073][ C0] Possible unsafe locking scenario: [ 113.575073][ C0] [ 113.582515][ C0] CPU0 CPU1 [ 113.587869][ C0] ---- ---- [ 113.593221][ C0] lock(&rm->m_rs_lock); [ 113.597547][ C0] lock(&rs->rs_recv_lock); [ 113.604648][ C0] lock(&rm->m_rs_lock); [ 113.611488][ C0] rlock(&rs->rs_recv_lock); [ 113.616157][ C0] [ 113.616157][ C0] *** DEADLOCK *** [ 113.616157][ C0] [ 113.624285][ C0] 7 locks held by kworker/u4:1/12: [ 113.629379][ C0] #0: ffff88802ae91d38 ((wq_completion)krdsd){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1420 [ 113.640271][ C0] #1: ffffc90000117d20 ((work_completion)(&rtn->rds_tcp_accept_w)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1420 [ 113.652985][ C0] #2: ffffffff8e130ae0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x2cd/0x760 [ 113.662487][ C0] #3: ffffffff8e130ae0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1bc/0x500 [ 113.672692][ C0] #4: ffff88801e3b5670 (k-slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2c69/0x35c0 [ 113.682293][ C0] #5: ffff88801e3b5978 (k-clock-AF_INET){++.-}-{2:2}, at: rds_tcp_write_space+0x33/0x5f0 [ 113.692237][ C0] #6: ffff88801eaaf100 (&rm->m_rs_lock){..-.}-{2:2}, at: rds_send_remove_from_sock+0x129/0x800 [ 113.702722][ C0] [ 113.702722][ C0] stack backtrace: [ 113.708594][ C0] CPU: 0 PID: 12 Comm: kworker/u4:1 Not tainted 6.8.0-rc3-syzkaller-g99bd3cb0d12e #0 [ 113.718131][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/25/2024 [ 113.728182][ C0] Workqueue: krdsd rds_tcp_accept_worker [ 113.733822][ C0] Call Trace: [ 113.737091][ C0] [ 113.739926][ C0] dump_stack_lvl+0x1e7/0x2e0 [ 113.744609][ C0] ? __pfx_dump_stack_lvl+0x10/0x10 [ 113.749811][ C0] ? srso_return_thunk+0x5/0x5f [ 113.754665][ C0] ? print_circular_bug+0x12f/0x1a0 [ 113.759887][ C0] check_noncircular+0x36a/0x4a0 [ 113.764845][ C0] ? __pfx_check_noncircular+0x10/0x10 [ 113.770311][ C0] ? srso_return_thunk+0x5/0x5f [ 113.775173][ C0] ? lockdep_lock+0x123/0x2b0 [ 113.779860][ C0] ? __pfx_validate_chain+0x10/0x10 [ 113.785051][ C0] ? validate_chain+0x11b/0x58e0 [ 113.789982][ C0] ? srso_return_thunk+0x5/0x5f [ 113.794840][ C0] ? _find_first_zero_bit+0xd4/0x100 [ 113.800120][ C0] validate_chain+0x18ca/0x58e0 [ 113.804965][ C0] ? srso_return_thunk+0x5/0x5f [ 113.809816][ C0] ? __read_once_word_nocheck+0x9/0x20 [ 113.815289][ C0] ? __pfx_validate_chain+0x10/0x10 [ 113.820479][ C0] ? ret_from_fork_asm+0x1a/0x30 [ 113.825420][ C0] ? __pfx_validate_chain+0x10/0x10 [ 113.830621][ C0] ? ret_from_fork_asm+0x1b/0x30 [ 113.835561][ C0] ? ret_from_fork_asm+0x1b/0x30 [ 113.840588][ C0] ? __kernel_text_address+0xd/0x40 [ 113.845780][ C0] ? ret_from_fork_asm+0x1b/0x30 [ 113.850714][ C0] ? __pfx_stack_trace_consume_entry+0x10/0x10 [ 113.856863][ C0] ? srso_return_thunk+0x5/0x5f [ 113.861711][ C0] ? arch_stack_walk+0x17a/0x1b0 [ 113.866641][ C0] ? srso_return_thunk+0x5/0x5f [ 113.871491][ C0] ? look_up_lock_class+0x77/0x160 [ 113.876601][ C0] ? srso_return_thunk+0x5/0x5f [ 113.881452][ C0] ? register_lock_class+0x102/0x980 [ 113.886735][ C0] ? srso_return_thunk+0x5/0x5f [ 113.891584][ C0] ? look_up_lock_class+0x77/0x160 [ 113.896692][ C0] ? srso_return_thunk+0x5/0x5f [ 113.901542][ C0] ? register_lock_class+0x102/0x980 [ 113.906827][ C0] ? __pfx_register_lock_class+0x10/0x10 [ 113.912481][ C0] ? __pfx_stack_trace_save+0x10/0x10 [ 113.917853][ C0] ? srso_return_thunk+0x5/0x5f [ 113.922704][ C0] ? mark_lock+0x9a/0x350 [ 113.927028][ C0] __lock_acquire+0x1345/0x1fd0 [ 113.931889][ C0] lock_acquire+0x1e3/0x530 [ 113.936397][ C0] ? rds_wake_sk_sleep+0x2e/0xd0 [ 113.941329][ C0] ? srso_return_thunk+0x5/0x5f [ 113.946193][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 113.951310][ C0] ? srso_return_thunk+0x5/0x5f [ 113.956208][ C0] ? do_raw_spin_lock+0x14e/0x370 [ 113.961245][ C0] ? __pfx_do_raw_spin_lock+0x10/0x10 [ 113.966628][ C0] _raw_read_lock_irqsave+0xdd/0x130 [ 113.971919][ C0] ? rds_wake_sk_sleep+0x2e/0xd0 [ 113.976870][ C0] ? __pfx__raw_read_lock_irqsave+0x10/0x10 [ 113.982769][ C0] ? srso_return_thunk+0x5/0x5f [ 113.987625][ C0] ? _raw_spin_lock_irqsave+0xe1/0x120 [ 113.993096][ C0] ? __pfx__raw_spin_lock_irqsave+0x10/0x10 [ 113.998999][ C0] ? __kasan_slab_free+0x46/0x70 [ 114.003946][ C0] rds_wake_sk_sleep+0x2e/0xd0 [ 114.008821][ C0] rds_send_remove_from_sock+0x1c9/0x800 [ 114.014484][ C0] ? __pfx_rds_tcp_is_acked+0x10/0x10 [ 114.019911][ C0] rds_send_path_drop_acked+0x36b/0x3b0 [ 114.025480][ C0] ? __pfx_rds_tcp_is_acked+0x10/0x10 [ 114.030853][ C0] ? __pfx_rds_send_path_drop_acked+0x10/0x10 [ 114.036926][ C0] rds_tcp_write_space+0x196/0x5f0 [ 114.042037][ C0] ? __pfx_sk_stream_write_space+0x10/0x10 [ 114.047844][ C0] ? __pfx_rds_tcp_write_space+0x10/0x10 [ 114.053478][ C0] tcp_check_space+0x660/0xb00 [ 114.058324][ C0] tcp_rcv_established+0x101c/0x2030 [ 114.063608][ C0] ? __pfx_tcp_rcv_established+0x10/0x10 [ 114.069232][ C0] ? do_raw_spin_lock+0x14e/0x370 [ 114.074253][ C0] ? srso_return_thunk+0x5/0x5f [ 114.079107][ C0] tcp_v4_do_rcv+0x8dd/0xb90 [ 114.083698][ C0] tcp_v4_rcv+0x2cba/0x35c0 [ 114.088210][ C0] ? srso_return_thunk+0x5/0x5f [ 114.093057][ C0] ? raw_local_deliver+0xd56/0xe60 [ 114.098174][ C0] ? __pfx_tcp_v4_rcv+0x10/0x10 [ 114.103027][ C0] ? __pfx_tcp_v4_rcv+0x10/0x10 [ 114.107874][ C0] ip_protocol_deliver_rcu+0x225/0x430 [ 114.113333][ C0] ? ip_local_deliver_finish+0x1bc/0x500 [ 114.118963][ C0] ip_local_deliver_finish+0x2b6/0x500 [ 114.124424][ C0] ? __pfx_ip_local_deliver_finish+0x10/0x10 [ 114.130423][ C0] NF_HOOK+0x3a6/0x450 [ 114.134491][ C0] ? srso_return_thunk+0x5/0x5f [ 114.139341][ C0] ? NF_HOOK+0x9a/0x450 [ 114.143491][ C0] ? __pfx_NF_HOOK+0x10/0x10 [ 114.148077][ C0] ? __pfx_ip_local_deliver_finish+0x10/0x10 [ 114.154059][ C0] ? srso_return_thunk+0x5/0x5f [ 114.158908][ C0] ? ip_rcv_finish+0x406/0x560 [ 114.163670][ C0] ? __pfx_ip_rcv_finish+0x10/0x10 [ 114.168779][ C0] NF_HOOK+0x3a6/0x450 [ 114.172847][ C0] ? NF_HOOK+0x9a/0x450 [ 114.176999][ C0] ? __pfx_NF_HOOK+0x10/0x10 [ 114.181582][ C0] ? ip_rcv_core+0x7ff/0xd10 [ 114.186173][ C0] ? __pfx_ip_rcv_finish+0x10/0x10 [ 114.191287][ C0] ? __pfx_ip_rcv+0x10/0x10 [ 114.195789][ C0] __netif_receive_skb+0x2bf/0x6a0 [ 114.200899][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 114.206014][ C0] ? __pfx___netif_receive_skb+0x10/0x10 [ 114.211641][ C0] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 114.217623][ C0] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 114.223948][ C0] ? _raw_spin_lock_irq+0xdf/0x120 [ 114.229056][ C0] ? process_backlog+0x2cd/0x760 [ 114.233989][ C0] process_backlog+0x385/0x760 [ 114.238762][ C0] ? __pfx_process_backlog+0x10/0x10 [ 114.244050][ C0] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 114.250031][ C0] ? srso_return_thunk+0x5/0x5f [ 114.254883][ C0] ? __pfx_lockdep_hardirqs_on_prepare+0x10/0x10 [ 114.261210][ C0] __napi_poll+0xcd/0x490 [ 114.265536][ C0] net_rx_action+0x78b/0x1010 [ 114.270218][ C0] ? __pfx_net_rx_action+0x10/0x10 [ 114.275327][ C0] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 114.281312][ C0] __do_softirq+0x2bd/0x942 [ 114.285813][ C0] ? do_softirq+0x11b/0x1e0 [ 114.290319][ C0] ? __pfx___do_softirq+0x10/0x10 [ 114.295347][ C0] ? srso_return_thunk+0x5/0x5f [ 114.300199][ C0] do_softirq+0x11b/0x1e0 [ 114.304533][ C0] [ 114.307452][ C0] [ 114.310374][ C0] ? __pfx_do_softirq+0x10/0x10 [ 114.315244][ C0] ? __pfx_lockdep_softirqs_on+0x10/0x10 [ 114.320875][ C0] ? rds_tcp_tune+0x46b/0x630 [ 114.325542][ C0] ? srso_return_thunk+0x5/0x5f [ 114.330389][ C0] ? rcu_is_watching+0x15/0xb0 [ 114.335166][ C0] __local_bh_enable_ip+0x1bb/0x200 [ 114.340366][ C0] ? srso_return_thunk+0x5/0x5f [ 114.345243][ C0] ? rds_tcp_tune+0x46b/0x630 [ 114.349929][ C0] ? __pfx___local_bh_enable_ip+0x10/0x10 [ 114.355657][ C0] ? srso_return_thunk+0x5/0x5f [ 114.360517][ C0] rds_tcp_tune+0x46b/0x630 [ 114.365021][ C0] ? __pfx_rds_tcp_tune+0x10/0x10 [ 114.370042][ C0] ? srso_return_thunk+0x5/0x5f [ 114.374911][ C0] ? tcp_sock_set_keepidle+0x1f9/0x2c0 [ 114.380385][ C0] rds_tcp_accept_one+0x32f/0xbb0 [ 114.385419][ C0] ? __pfx_lock_acquire+0x10/0x10 [ 114.390455][ C0] ? lockdep_hardirqs_on_prepare+0x43c/0x780 [ 114.396447][ C0] ? __pfx_rds_tcp_accept_one+0x10/0x10 [ 114.402009][ C0] ? process_scheduled_works+0x825/0x1420 [ 114.407740][ C0] rds_tcp_accept_worker+0x3f/0xa0 [ 114.412857][ C0] ? process_scheduled_works+0x825/0x1420 [ 114.418586][ C0] process_scheduled_works+0x915/0x1420 [ 114.424154][ C0] ? __pfx_process_scheduled_works+0x10/0x10 [ 114.430162][ C0] ? srso_return_thunk+0x5/0x5f [ 114.435018][ C0] ? assign_work+0x364/0x3d0 [ 114.439701][ C0] worker_thread+0xa5f/0x1000 [ 114.444396][ C0] ? __pfx_worker_thread+0x10/0x10 [ 114.449509][ C0] kthread+0x2f1/0x390 [ 114.453574][ C0] ? __pfx_worker_thread+0x10/0x10 [ 114.458691][ C0] ? __pfx_kthread+0x10/0x10 [ 114.463274][ C0] ret_from_fork+0x4d/0x80 [ 114.467694][ C0] ? __pfx_kthread+0x10/0x10 [ 114.472282][ C0] ret_from_fork_asm+0x1b/0x30 [ 114.477059][ C0] [ 114.517268][ T4465] Bluetooth: hci0: command 0x040f tx timeout [ 116.562647][ T4465] Bluetooth: hci0: command 0x0419 tx timeout 2024/02/06 16:26:40 executed programs: 75 2024/02/06 16:26:45 executed programs: 154