[51.979844] Initializing watchdogs [51.980425] /dev/watchdog0 [52.012668] [001/142] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [52.563877] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [66.042300] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (13.485s) [66.178323] [002/142] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [66.360777] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [66.365494] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [66.468583] [003/142] (946s left) i915_module_load (reload-no-display) [66.680667] Starting subtest: reload-no-display [74.485997] Subtest reload-no-display: SUCCESS (7.806s) [74.551268] [004/142] (938s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [81.049422] Starting subtest: primary-y-tiled-reflect-x-90 [81.055749] Subtest primary-y-tiled-reflect-x-90: SKIP (0.003s) [81.188549] [005/142] (931s left) gen9_exec_parse (batch-without-end) [81.610442] Subtest batch-without-end: SKIP (0.000s) [81.717179] [006/142] (931s left) kms_cursor_edge_walk (64x64-right-edge) [82.188640] Starting subtest: 64x64-right-edge [82.196928] Starting dynamic subtest: pipe-A-eDP-1 [86.351544] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.152s) [86.387185] Starting dynamic subtest: pipe-D-eDP-1 [89.799959] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.443s) [89.803539] Subtest 64x64-right-edge: SUCCESS (7.611s) [90.745070] [007/142] (922s left) gem_exec_balancer (parallel-contexts) [91.989600] Starting subtest: parallel-contexts [104.058816] Subtest parallel-contexts: SUCCESS (12.065s) [104.242903] [008/142] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [104.777349] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [104.783951] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [104.926711] [009/142] (908s left) gem_sync (basic-store-each) [105.357266] Starting subtest: basic-store-each [109.482809] Subtest basic-store-each: SUCCESS (4.124s) [109.773729] [010/142] (903s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_mc_ccs) [110.912330] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs [110.921492] Subtest pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s) [112.031746] [011/142] (901s left) gem_readwrite (beyond-eob) [112.406211] Subtest beyond-EOB: SKIP (0.000s) [112.527236] [012/142] (900s left) vgem_basic (bad-fence) [113.012221] Starting subtest: bad-fence [113.015291] Subtest bad-fence: SUCCESS (0.000s) [113.124356] [013/142] (900s left) kms_psr (psr2_sprite_blt) [113.615506] Starting subtest: psr2_sprite_blt [115.713495] Subtest psr2_sprite_blt: SUCCESS (2.096s) [116.646935] [014/142] (896s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [116.923821] Starting subtest: yf-tiled-64bpp-rotate-90 [116.931294] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [117.098766] [015/142] (896s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [120.030289] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s) [120.186914] [016/142] (893s left) gem_exec_store (dword) [120.609522] Starting subtest: dword [120.612526] Starting dynamic subtest: rcs0 [120.675116] Dynamic subtest rcs0: SUCCESS (0.065s) [120.708867] Starting dynamic subtest: bcs0 [120.729451] Dynamic subtest bcs0: SUCCESS (0.054s) [120.764781] Starting dynamic subtest: vcs0 [122.473907] Dynamic subtest vcs0: SUCCESS (1.742s) [122.509630] Starting dynamic subtest: vcs1 [124.521195] Dynamic subtest vcs1: SUCCESS (2.046s) [124.554778] Starting dynamic subtest: vecs0 [126.505162] Dynamic subtest vecs0: SUCCESS (1.983s) [126.538054] Starting dynamic subtest: ccs0 [126.555861] Dynamic subtest ccs0: SUCCESS (0.051s) [126.559301] Subtest dword: SUCCESS (5.947s) [126.842853] [017/142] (886s left) fbdev (unaligned-write) [127.228367] Starting subtest: unaligned-write [128.164648] Subtest unaligned-write: SUCCESS (0.937s) [128.333988] [018/142] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [128.864560] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [128.871142] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [129.026426] [019/142] (884s left) syncobj_timeline (etime-multi-wait-all-submitted) [129.397351] Starting subtest: etime-multi-wait-all-submitted [129.503813] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s) [129.639141] [020/142] (884s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [130.136567] Starting subtest: fbc-rgb565-draw-mmap-wc [142.620500] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (12.487s) [142.925318] [021/142] (870s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs) [144.045443] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs [144.048530] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s) [145.341265] [022/142] (868s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [145.812313] Starting subtest: plane-all-modeset-transition-internal-panels [145.818709] Starting dynamic subtest: pipe-A-eDP-1 [148.478843] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.661s) [148.923639] Starting dynamic subtest: pipe-B-eDP-1 [151.199319] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.308s) [151.587868] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (5.777s) [152.528982] [023/142] (861s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs) [154.736690] Starting subtest: pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs [154.742575] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s) [155.471694] [024/142] (858s left) gem_flink_basic (basic) [155.834487] Starting subtest: basic [155.838143] Subtest basic: SUCCESS (0.000s) [155.975614] [025/142] (858s left) i915_query (query-regions-garbage-items) [156.350825] Starting subtest: query-regions-garbage-items [156.354389] Subtest query-regions-garbage-items: SUCCESS (0.002s) [156.481535] [026/142] (857s left) gem_exec_balancer (hog) [156.905108] Starting subtest: hog [156.911293] Subtest hog: SKIP (0.000s) [157.891116] [027/142] (856s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [158.875430] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc [158.883802] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [160.266182] [028/142] (854s left) tools_test (sysfs_l3_parity) [160.638909] Starting subtest: sysfs_l3_parity [161.102266] Subtest sysfs_l3_parity: SKIP (0.478s) [161.226616] [029/142] (853s left) kms_big_fb (x-tiled-64bpp-rotate-180) [161.751184] Starting subtest: x-tiled-64bpp-rotate-180 [168.354389] Subtest x-tiled-64bpp-rotate-180: SUCCESS (6.602s) [169.744709] [030/142] (844s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs) [170.893524] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs [170.899812] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [172.131069] [031/142] (842s left) sysfs_defaults (readonly) [172.441745] Starting subtest: readonly [172.450261] Starting dynamic subtest: vecs0 [172.453696] Dynamic subtest vecs0: SUCCESS (0.002s) [172.489314] Starting dynamic subtest: ccs0 [172.493126] Dynamic subtest ccs0: SUCCESS (0.002s) [172.532460] Starting dynamic subtest: vcs0 [172.536189] Dynamic subtest vcs0: SUCCESS (0.002s) [172.571153] Starting dynamic subtest: bcs0 [172.574478] Dynamic subtest bcs0: SUCCESS (0.002s) [172.608694] Starting dynamic subtest: rcs0 [172.611994] Dynamic subtest rcs0: SUCCESS (0.002s) [172.645929] Starting dynamic subtest: vcs1 [172.649295] Dynamic subtest vcs1: SUCCESS (0.002s) [172.652334] Subtest readonly: SUCCESS (0.036s) [172.707248] [032/142] (841s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs) [174.109646] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs [174.116755] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.002s) [175.104990] [033/142] (839s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [175.614410] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [175.621354] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [175.761086] [034/142] (839s left) gem_eio (throttle) [177.888434] Starting subtest: throttle [181.319277] Subtest throttle: SUCCESS (3.434s) [182.642990] [035/142] (832s left) kms_invalid_mode (zero-vdisplay) [183.120893] Starting subtest: zero-vdisplay [183.124083] Starting dynamic subtest: eDP-1-pipe-A [183.540548] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.412s) [183.585632] Starting dynamic subtest: eDP-1-pipe-B [183.589299] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.039s) [183.628454] Starting dynamic subtest: eDP-1-pipe-C [183.632247] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.039s) [183.682832] Starting dynamic subtest: eDP-1-pipe-D [183.686653] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.039s) [183.689651] Subtest zero-vdisplay: SUCCESS (0.562s) [184.448105] [036/142] (830s left) gem_eio (in-flight-external) [186.524347] Starting subtest: in-flight-external [189.515610] Subtest in-flight-external: SUCCESS (2.995s) [191.662839] [037/142] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [192.179306] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [192.186423] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [192.331926] [038/142] (822s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs) [193.635248] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs [203.048229] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (9.412s) [204.332188] [039/142] (810s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [204.838894] Starting subtest: fbcpsr-rgb565-draw-pwrite [223.749235] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (18.911s) [223.977670] [040/142] (791s left) gem_pxp (create-regular-buffer) [226.881751] Subtest create-regular-buffer: SKIP (0.000s) [227.022178] [041/142] (788s left) gem_mmap_offset (ptrace) [227.403785] Starting subtest: ptrace [227.418335] Starting dynamic subtest: smem0-wb [227.564491] Dynamic subtest smem0-wb: SUCCESS (0.145s) [227.608641] Starting dynamic subtest: smem0-wc [227.725948] Dynamic subtest smem0-wc: SUCCESS (0.156s) [227.769148] Starting dynamic subtest: smem0-uc [227.894086] Dynamic subtest smem0-uc: SUCCESS (0.163s) [227.897769] Subtest ptrace: SUCCESS (0.493s) [228.083208] [042/142] (787s left) perf (gen12-unprivileged-single-ctx-counters) [229.054899] Starting subtest: gen12-unprivileged-single-ctx-counters [229.058531] Starting dynamic subtest: rcs0 [229.339199] Dynamic subtest rcs0: SUCCESS (0.281s) [229.342734] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.286s) [229.458052] [043/142] (786s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [229.976351] Starting subtest: psr-rgb101010-draw-mmap-wc [240.666897] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (10.689s) [240.918670] [044/142] (774s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [241.399975] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [241.409340] Starting dynamic subtest: pipe-A-eDP-1 [241.516065] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [241.564128] Starting dynamic subtest: pipe-B-eDP-1 [241.705310] Dynamic subtest pipe-B-eDP-1: SKIP (0.179s) [241.752257] Starting dynamic subtest: pipe-C-eDP-1 [241.902273] Dynamic subtest pipe-C-eDP-1: SKIP (0.189s) [241.949840] Starting dynamic subtest: pipe-D-eDP-1 [242.104620] Dynamic subtest pipe-D-eDP-1: SKIP (0.186s) [242.111443] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.698s) [242.264497] [045/142] (773s left) kms_rmfb (close-fd) [242.734386] Starting subtest: close-fd [242.742940] Starting dynamic subtest: pipe-A-eDP-1 [243.059752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.314s) [243.107593] Starting dynamic subtest: pipe-B-eDP-1 [244.755505] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.687s) [244.801506] Starting dynamic subtest: pipe-C-eDP-1 [246.416712] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.654s) [246.461229] Starting dynamic subtest: pipe-D-eDP-1 [248.114267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.689s) [248.117641] Subtest close-fd: SUCCESS (5.380s) [249.646954] [046/142] (766s left) kms_addfb_basic (too-high) [250.129344] Starting subtest: too-high [250.132950] Subtest too-high: SUCCESS (0.004s) [250.307863] [047/142] (765s left) kms_prop_blob (invalid-get-prop) [250.678384] Starting subtest: invalid-get-prop [250.681942] Subtest invalid-get-prop: SUCCESS (0.000s) [250.822590] [048/142] (765s left) gem_render_copy (y-tiled-to-vebox-linear) [251.239200] Starting subtest: y-tiled-to-vebox-linear [251.245706] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [251.508899] [049/142] (764s left) gem_exec_endless (dispatch) [251.977974] Starting subtest: dispatch [251.981964] Starting dynamic subtest: rcs0 [252.006874] Dynamic subtest rcs0: SUCCESS (0.025s) [252.049323] Starting dynamic subtest: bcs0 [252.055830] Dynamic subtest bcs0: SUCCESS (0.020s) [252.097695] Starting dynamic subtest: vcs0 [252.104220] Dynamic subtest vcs0: SUCCESS (0.019s) [252.151826] Starting dynamic subtest: vcs1 [252.158073] Dynamic subtest vcs1: SUCCESS (0.020s) [252.192771] Starting dynamic subtest: vecs0 [252.199247] Dynamic subtest vecs0: SUCCESS (0.019s) [252.236801] Starting dynamic subtest: ccs0 [252.243251] Dynamic subtest ccs0: SUCCESS (0.019s) [252.246646] Subtest dispatch: SUCCESS (0.149s) [253.652218] [050/142] (762s left) gem_exec_params (invalid-batch-start-offset) [254.055237] Starting subtest: invalid-batch-start-offset [254.075471] Subtest invalid-batch-start-offset: SUCCESS (0.017s) [254.267592] [051/142] (761s left) gem_ctx_exec (basic-nohangcheck) [254.642394] Starting subtest: basic-nohangcheck [257.731129] Subtest basic-nohangcheck: FAIL (2.982s) [257.833097] [052/142] (758s left) syncobj_timeline (reset-signaled) [258.209427] Starting subtest: reset-signaled [258.213098] Subtest reset-signaled: SUCCESS (0.002s) [258.373602] [053/142] (757s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [258.867329] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [258.878879] Starting dynamic subtest: pipe-A-default-mode [260.498522] Dynamic subtest pipe-A-default-mode: SKIP (1.614s) [260.505534] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.628s) [260.778612] [054/142] (755s left) sw_sync (sync_multi_consumer_producer) [261.152602] Starting subtest: sync_multi_consumer_producer [262.488506] Subtest sync_multi_consumer_producer: SUCCESS (1.342s) [262.617306] [055/142] (753s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [263.191817] Starting subtest: 2x-long-cursor-vs-flip-legacy [263.209849] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.016s) [263.538172] [056/142] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [264.048597] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [264.055409] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [264.207333] [057/142] (752s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [264.692449] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [264.699459] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [264.850837] [058/142] (751s left) kms_chamelium_hpd (dp-hpd-storm-disable) [265.753368] Subtest dp-hpd-storm-disable: SKIP (0.000s) [266.618116] [059/142] (750s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_mc_ccs) [268.286355] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs [268.295941] Subtest pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [268.970225] [060/142] (747s left) v3d/v3d_perfmon (create-single-perfmon) [269.454766] Subtest create-single-perfmon: SKIP (0.000s) [269.584974] [061/142] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [270.086447] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [280.640861] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (10.557s) [280.924038] [062/142] (736s left) kms_getfb (getfb2-handle-closed) [281.305769] Starting subtest: getfb2-handle-closed [281.309610] Subtest getfb2-handle-closed: SUCCESS (0.000s) [281.487279] [063/142] (735s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs) [283.018329] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs [283.034674] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.013s) [283.850395] [064/142] (733s left) gem_ctx_exec (basic) [284.230883] Starting subtest: basic [284.242401] Subtest basic: SUCCESS (0.016s) [284.406800] [065/142] (732s left) gen7_exec_parse (basic-rejected) [284.802980] Subtest basic-rejected: SKIP (0.000s) [284.916961] [066/142] (732s left) kms_plane_alpha_blend (coverage-7efc) [285.399354] Starting subtest: coverage-7efc [287.171886] Starting dynamic subtest: pipe-A-eDP-1 [288.285992] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.111s) [288.469837] Starting dynamic subtest: pipe-D-eDP-1 [290.637329] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.209s) [290.640788] Subtest coverage-7efc: SUCCESS (5.242s) [291.588363] [067/142] (725s left) gem_exec_params (rel-constants-invalid-rel-gen5) [291.990718] Starting subtest: rel-constants-invalid-rel-gen5 [291.994655] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s) [292.157637] [068/142] (725s left) kms_big_fb (4-tiled-addfb-size-overflow) [292.676259] Starting subtest: 4-tiled-addfb-size-overflow [292.679951] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.002s) [292.849711] [069/142] (724s left) gem_busy (extended) [293.442777] Starting subtest: extended [293.446615] Starting dynamic subtest: rcs0 [293.532348] Dynamic subtest rcs0: SUCCESS (0.088s) [293.580382] Starting dynamic subtest: bcs0 [293.590404] Dynamic subtest bcs0: SUCCESS (0.050s) [293.631315] Starting dynamic subtest: vcs0 [295.529174] Dynamic subtest vcs0: SUCCESS (1.935s) [295.570346] Starting dynamic subtest: vcs1 [297.513428] Dynamic subtest vcs1: SUCCESS (1.979s) [297.554344] Starting dynamic subtest: vecs0 [299.497253] Dynamic subtest vecs0: SUCCESS (1.979s) [299.538448] Starting dynamic subtest: ccs0 [299.552504] Dynamic subtest ccs0: SUCCESS (0.052s) [299.557538] Subtest extended: SUCCESS (6.112s) [299.913422] [070/142] (717s left) gem_exec_whisper (basic-queues-priority-all) [300.348347] Starting subtest: basic-queues-priority-all [341.057276] Subtest basic-queues-priority-all: FAIL (40.169s) [348.572950] [071/142] (669s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [349.131978] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [349.138836] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [349.312183] [072/142] (668s left) kms_big_fb (linear-8bpp-rotate-90) [349.864713] Starting subtest: linear-8bpp-rotate-90 [349.922268] Subtest linear-8bpp-rotate-90: SKIP (0.054s) [350.116210] [073/142] (667s left) kms_addfb_basic (unused-handle) [350.509144] Starting subtest: unused-handle [350.512613] Subtest unused-handle: SUCCESS (0.000s) [350.786720] [074/142] (667s left) kms_big_fb (y-tiled-8bpp-rotate-0) [351.329335] Starting subtest: y-tiled-8bpp-rotate-0 [351.335990] Subtest y-tiled-8bpp-rotate-0: SKIP (0.001s) [351.482283] [075/142] (666s left) kms_atomic_transition (modeset-transition) [351.981702] Starting subtest: modeset-transition [351.985121] Starting dynamic subtest: 1x-outputs [383.210294] Dynamic subtest 1x-outputs: SUCCESS (31.230s) [383.650500] Subtest modeset-transition: SUCCESS (31.671s) [384.581678] [076/142] (633s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [384.997116] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [385.135581] [077/142] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [385.654399] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [391.959903] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (6.306s) [392.261684] [078/142] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [392.768791] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [392.775279] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s) [392.935906] [079/142] (625s left) kms_lease (possible-crtcs-filtering) [393.443392] Starting subtest: possible-crtcs-filtering [393.471371] Subtest possible-crtcs-filtering: SUCCESS (0.035s) [393.649760] [080/142] (624s left) i915_pm_rpm (i2c) [399.754880] Starting subtest: i2c [409.540216] Subtest i2c: SUCCESS (9.790s) [409.763683] [081/142] (608s left) gem_partial_pwrite_pread (reads) [410.175230] Subtest reads: SKIP (0.000s) [410.310329] [082/142] (608s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [410.798881] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [410.805420] Starting dynamic subtest: pipe-A-default-mode [414.263653] Dynamic subtest pipe-A-default-mode: SUCCESS (3.452s) [414.267059] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (3.466s) [415.216130] [083/142] (603s left) gem_exec_params (invalid-fence-in) [415.616549] Starting subtest: invalid-fence-in [415.621062] Subtest invalid-fence-in: SUCCESS (0.003s) [415.800716] [084/142] (603s left) v3d/v3d_submit_csd (single-out-sync) [416.287140] Subtest single-out-sync: SKIP (0.000s) [416.412141] [085/142] (602s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [416.930417] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [416.937239] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [417.111534] [086/142] (601s left) gem_ctx_param (root-set) [417.494183] Starting subtest: root-set [417.498158] Subtest root-set: SUCCESS (0.001s) [417.649197] [087/142] (601s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs) [418.481215] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs [418.486901] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SKIP (0.002s) [419.880322] [088/142] (599s left) kms_ccs (pipe-d-crc-primary-basic-yf_tiled_ccs) [421.199510] Starting subtest: pipe-D-crc-primary-basic-yf_tiled_ccs [421.206895] Subtest pipe-D-crc-primary-basic-yf_tiled_ccs: SKIP (0.001s) [421.673866] [089/142] (597s left) kms_vblank (pipe-d-query-forked) [422.155251] Starting subtest: pipe-D-query-forked [425.966906] Subtest pipe-D-query-forked: SUCCESS (3.805s) [426.936166] [090/142] (592s left) kms_psr2_sf (overlay-plane-update-continuous-sf) [434.360766] Starting subtest: overlay-plane-update-continuous-sf [434.376087] Starting dynamic subtest: pipe-A-eDP-1 [436.627828] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.249s) [436.692619] Starting dynamic subtest: pipe-B-eDP-1 [438.933929] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.285s) [438.937181] Subtest overlay-plane-update-continuous-sf: SUCCESS (4.571s) [439.893846] [091/142] (579s left) gem_exec_schedule (pi-distinct-iova) [440.501178] Starting subtest: pi-distinct-iova [440.504643] Starting dynamic subtest: rcs0 [440.823322] Dynamic subtest rcs0: SUCCESS (0.321s) [440.872866] Starting dynamic subtest: bcs0 [441.037562] Dynamic subtest bcs0: SUCCESS (0.209s) [441.088413] Starting dynamic subtest: vcs0 [441.264720] Dynamic subtest vcs0: SUCCESS (0.223s) [441.312462] Starting dynamic subtest: vcs1 [441.483715] Dynamic subtest vcs1: SUCCESS (0.215s) [441.531782] Starting dynamic subtest: vecs0 [441.705351] Dynamic subtest vecs0: SUCCESS (0.217s) [441.751414] Starting dynamic subtest: ccs0 [441.953088] Dynamic subtest ccs0: SUCCESS (0.243s) [441.956196] Subtest pi-distinct-iova: SUCCESS (1.454s) [442.815988] [092/142] (576s left) gem_ctx_sseu (invalid-args) [443.221938] Subtest invalid-args: SKIP (0.000s) [443.359081] [093/142] (576s left) kms_chamelium_frames (dp-frame-dump) [444.249681] Subtest dp-frame-dump: SKIP (0.000s) [445.118891] [094/142] (574s left) kms_flip (nonexisting-fb-interruptible) [445.553863] Starting subtest: nonexisting-fb-interruptible [445.582139] Starting dynamic subtest: A-eDP1 [447.770134] Dynamic subtest A-eDP1: SUCCESS (2.188s) [447.817747] Starting dynamic subtest: B-eDP1 [449.358230] Dynamic subtest B-eDP1: SUCCESS (1.584s) [449.399924] Starting dynamic subtest: C-eDP1 [450.929437] Dynamic subtest C-eDP1: SUCCESS (1.566s) [450.984343] Starting dynamic subtest: D-eDP1 [452.504183] Dynamic subtest D-eDP1: SUCCESS (1.567s) [452.530135] Subtest nonexisting-fb-interruptible: SUCCESS (6.981s) [454.069377] [095/142] (565s left) gem_wait (invalid-flags) [454.467981] Starting subtest: invalid-flags [454.471431] Subtest invalid-flags: SUCCESS (0.000s) [454.889586] [096/142] (565s left) kms_cursor_crc (cursor-rapid-movement-256x85) [455.984368] Starting subtest: cursor-rapid-movement-256x85 [456.015371] Starting dynamic subtest: pipe-A-eDP-1 [457.301653] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.282s) [457.502719] Starting dynamic subtest: pipe-D-eDP-1 [459.856389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.397s) [459.859944] Subtest cursor-rapid-movement-256x85: SUCCESS (3.872s) [460.822752] [097/142] (559s left) kms_cursor_crc (cursor-onscreen-128x128) [461.684694] Starting subtest: cursor-onscreen-128x128 [461.714993] Starting dynamic subtest: pipe-A-eDP-1 [466.385779] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.674s) [466.564164] Starting dynamic subtest: pipe-D-eDP-1 [470.732736] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.190s) [470.736112] Subtest cursor-onscreen-128x128: SUCCESS (9.052s) [471.809913] [098/142] (548s left) dmabuf_sync_file (import-multiple-read-write) [472.205718] Starting subtest: import-multiple-read-write [472.228996] Subtest import-multiple-read-write: SUCCESS (0.024s) [472.376158] [099/142] (547s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [472.753274] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [472.863777] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.110s) [473.019409] [100/142] (547s left) kms_vblank (pipe-b-ts-continuation-idle-hang) [473.500518] Starting subtest: pipe-B-ts-continuation-idle-hang [488.653049] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (15.150s) [489.631512] [101/142] (530s left) perf_pmu (multi-client) [490.034399] Starting subtest: multi-client [490.037867] Starting dynamic subtest: rcs0 [491.114651] Dynamic subtest rcs0: SUCCESS (1.077s) [491.161491] Starting dynamic subtest: bcs0 [492.191833] Dynamic subtest bcs0: SUCCESS (1.073s) [492.245307] Starting dynamic subtest: vcs0 [493.269093] Dynamic subtest vcs0: SUCCESS (1.072s) [493.315679] Starting dynamic subtest: vcs1 [494.576953] Dynamic subtest vcs1: SUCCESS (1.304s) [494.623673] Starting dynamic subtest: vecs0 [496.559789] Dynamic subtest vecs0: SUCCESS (1.978s) [496.608136] Starting dynamic subtest: ccs0 [498.545103] Dynamic subtest ccs0: SUCCESS (1.981s) [498.548735] Subtest multi-client: SUCCESS (8.512s) [498.772610] [102/142] (521s left) gem_mmap_gtt (close-race) [499.162927] Subtest close-race: SKIP (0.000s) [499.298535] [103/142] (521s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [499.913274] Starting subtest: 2x-long-flip-vs-cursor-legacy [499.931804] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.016s) [500.288354] [104/142] (520s left) api_intel_bb (intel-bb-blit-y) [500.676421] Starting subtest: intel-bb-blit-y [512.300333] Subtest intel-bb-blit-y: SUCCESS (11.629s) [512.507541] [105/142] (508s left) kms_cursor_crc (cursor-alpha-transparent) [513.004174] Starting subtest: cursor-alpha-transparent [513.014682] Starting dynamic subtest: pipe-A-eDP-1 [514.352421] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.341s) [514.404381] Starting dynamic subtest: pipe-D-eDP-1 [517.026367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.664s) [517.029831] Subtest cursor-alpha-transparent: SUCCESS (4.025s) [518.585216] [106/142] (502s left) vc4/vc4_purgeable_bo (free-purged-bo) [519.069803] Subtest free-purged-bo: SKIP (0.000s) [519.200450] [107/142] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [519.709540] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [519.716503] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [519.869646] [108/142] (501s left) kms_cursor_legacy (flip-vs-cursor-atomic) [520.447444] Starting subtest: flip-vs-cursor-atomic [533.182954] Subtest flip-vs-cursor-atomic: SUCCESS (12.733s) [534.165991] [109/142] (486s left) gem_userptr_blits (process-exit-busy) [534.620815] Starting subtest: process-exit-busy [534.702452] Subtest process-exit-busy: SUCCESS (0.082s) [534.930511] [110/142] (486s left) i915_pm_rpm (debugfs-read) [540.997801] Starting subtest: debugfs-read [662.221623] Per-test timeout exceeded. Killing the current test with SIGQUIT. [664.041746] Closing watchdogs [664.045719] Initializing watchdogs [664.045891] /dev/watchdog0 [664.080132] [111/142] (357s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [664.616510] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [664.623199] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [664.795356] [112/142] (356s left) core_setmaster (master-drop-set-user) [665.275593] Starting subtest: master-drop-set-user [665.359471] Subtest master-drop-set-user: SUCCESS (0.085s) [665.453173] [113/142] (356s left) gem_eio (in-flight-contexts-1us) [666.928992] Starting subtest: in-flight-contexts-1us [696.531371] Subtest in-flight-contexts-1us: SUCCESS (29.604s) [698.635690] [114/142] (322s left) kms_vrr (flip-dpms) [699.125418] Starting subtest: flip-dpms [699.132163] Subtest flip-dpms: SKIP (0.000s) [699.269958] [115/142] (322s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs) [700.817979] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs [700.824835] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.002s) [701.568691] [116/142] (320s left) gem_userptr_blits (nohangcheck) [702.079390] Starting subtest: nohangcheck [704.455992] Subtest nohangcheck: FAIL (2.263s) [704.524356] [117/142] (317s left) gem_exec_fence (syncobj-export) [706.576604] Starting subtest: syncobj-export [706.596205] Subtest syncobj-export: SUCCESS (0.019s) [707.715624] [118/142] (314s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [708.234708] Starting subtest: fbcpsr-2p-rte [708.242492] Subtest fbcpsr-2p-rte: SKIP (0.000s) [708.403676] [119/142] (313s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [708.879374] Starting subtest: primary-x-tiled-reflect-x-0 [723.718550] Subtest primary-x-tiled-reflect-x-0: SUCCESS (14.840s) [725.356319] [120/142] (296s left) kms_addfb_basic (tile-pitch-mismatch) [725.746088] Starting subtest: tile-pitch-mismatch [725.753196] Subtest tile-pitch-mismatch: SKIP (0.000s) [726.038892] [121/142] (296s left) gem_exec_suspend (basic-s3) [726.464287] Starting subtest: basic-S3 [726.467341] Starting dynamic subtest: smem [754.538377] Dynamic subtest smem: SUCCESS (28.070s) [754.542787] Subtest basic-S3: SUCCESS (28.074s) [754.824828] [122/142] (267s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [755.214902] Starting subtest: multi-wait-for-submit-unsubmitted [755.319509] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s) [755.503357] [123/142] (266s left) kms_vblank (pipe-b-query-idle) [755.995687] Starting subtest: pipe-B-query-idle [759.090872] Subtest pipe-B-query-idle: SUCCESS (3.096s) [760.053890] [124/142] (262s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_ccs) [761.602144] Starting subtest: pipe-C-bad-aux-stride-y_tiled_ccs [761.608787] Subtest pipe-C-bad-aux-stride-y_tiled_ccs: SKIP (0.000s) [762.478811] [125/142] (260s left) gem_exec_schedule (u-semaphore-noskip) [762.935603] Starting subtest: u-semaphore-noskip [763.775114] Subtest u-semaphore-noskip: SUCCESS (0.844s) [765.655429] [126/142] (257s left) kms_draw_crc (draw-method-mmap-wc) [766.160623] Starting subtest: draw-method-mmap-wc [766.164495] Starting dynamic subtest: xrgb8888-untiled [766.836252] Dynamic subtest xrgb8888-untiled: SUCCESS (0.673s) [766.896761] Starting dynamic subtest: rgb565-untiled [767.428348] Dynamic subtest rgb565-untiled: SUCCESS (0.585s) [767.487179] Starting dynamic subtest: xrgb2101010-untiled [768.071080] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.641s) [768.146380] Starting dynamic subtest: xrgb8888-xtiled [768.570049] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.496s) [768.632062] Starting dynamic subtest: rgb565-xtiled [769.025198] Dynamic subtest rgb565-xtiled: SUCCESS (0.452s) [769.082373] Starting dynamic subtest: xrgb2101010-xtiled [769.470764] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.441s) [769.530293] Starting dynamic subtest: xrgb8888-4tiled [769.991978] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.518s) [770.056612] Starting dynamic subtest: rgb565-4tiled [770.504607] Dynamic subtest rgb565-4tiled: SUCCESS (0.507s) [770.562652] Starting dynamic subtest: xrgb2101010-4tiled [771.027940] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.520s) [771.031742] Subtest draw-method-mmap-wc: SUCCESS (4.866s) [771.225412] [127/142] (251s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-5) [771.702274] Starting subtest: plane-downscale-with-modifiers-factor-0-5 [771.711266] Starting dynamic subtest: pipe-A-eDP-1 [771.848793] Dynamic subtest pipe-A-eDP-1: SKIP (0.132s) [771.912981] Starting dynamic subtest: pipe-B-eDP-1 [772.092595] Dynamic subtest pipe-B-eDP-1: SKIP (0.232s) [772.154154] Starting dynamic subtest: pipe-C-eDP-1 [772.344524] Dynamic subtest pipe-C-eDP-1: SKIP (0.242s) [772.432805] Starting dynamic subtest: pipe-D-eDP-1 [772.615321] Dynamic subtest pipe-D-eDP-1: SKIP (0.252s) [772.622073] Subtest plane-downscale-with-modifiers-factor-0-5: SKIP (0.907s) [772.812216] [128/142] (250s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [773.313963] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [773.320821] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s) [773.499473] [129/142] (249s left) kms_vblank (pipe-b-query-forked-busy-hang) [773.979200] Starting subtest: pipe-B-query-forked-busy-hang [789.857402] Subtest pipe-B-query-forked-busy-hang: SUCCESS (15.875s) [790.817242] [130/142] (232s left) syncobj_timeline (multi-wait-all-available-signaled) [791.206085] Starting subtest: multi-wait-all-available-signaled [791.210062] Subtest multi-wait-all-available-signaled: SUCCESS (0.003s) [791.370486] [131/142] (231s left) syncobj_timeline (invalid-transfer-illegal-handle) [791.749847] Starting subtest: invalid-transfer-illegal-handle [791.753691] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [791.907345] [132/142] (231s left) kms_flip (flip-vs-expired-vblank-interruptible) [792.333478] Starting subtest: flip-vs-expired-vblank-interruptible [792.360770] Starting dynamic subtest: A-eDP1 [801.623780] Dynamic subtest A-eDP1: SUCCESS (9.263s) [801.682236] Starting dynamic subtest: B-eDP1 [810.714714] Dynamic subtest B-eDP1: SUCCESS (9.084s) [810.771214] Starting dynamic subtest: C-eDP1 [819.649126] Dynamic subtest C-eDP1: SUCCESS (8.928s) [819.696953] Starting dynamic subtest: D-eDP1 [828.686349] Dynamic subtest D-eDP1: SUCCESS (9.034s) [828.714726] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (36.386s) [830.273451] [133/142] (193s left) kms_chamelium_color (ctm-limited-range) [830.752742] Subtest ctm-limited-range: SKIP (0.000s) [830.892229] [134/142] (192s left) kms_flip (plain-flip-ts-check) [831.294778] Starting subtest: plain-flip-ts-check [831.326305] Starting dynamic subtest: A-eDP1 [840.778220] Dynamic subtest A-eDP1: SUCCESS (9.457s) [840.841155] Starting dynamic subtest: B-eDP1 [850.076251] Dynamic subtest B-eDP1: SUCCESS (9.294s) [850.136407] Starting dynamic subtest: C-eDP1 [859.345484] Dynamic subtest C-eDP1: SUCCESS (9.262s) [859.400925] Starting dynamic subtest: D-eDP1 [868.601869] Dynamic subtest D-eDP1: SUCCESS (9.254s) [868.627608] Subtest plain-flip-ts-check: SUCCESS (37.340s) [870.205326] [135/142] (153s left) v3d/v3d_submit_cl (bad-pad) [870.680376] Subtest bad-pad: SKIP (0.000s) [870.826736] [136/142] (152s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [871.325706] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [871.332131] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [871.510381] [137/142] (152s left) kms_addfb_basic (master-rmfb) [871.889776] Starting subtest: master-rmfb [871.893397] Subtest master-rmfb: SUCCESS (0.004s) [872.187162] [138/142] (151s left) gem_ppgtt (flink-and-close-vma-leak) [872.583379] Starting subtest: flink-and-close-vma-leak [872.637910] Subtest flink-and-close-vma-leak: SUCCESS (0.054s) [872.829542] [139/142] (151s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs) [873.710547] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs [874.512416] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SUCCESS (0.807s) [876.377297] [140/142] (147s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [876.873237] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [876.878738] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [877.051784] [141/142] (147s left) kms_setmode (clone-exclusive-crtc) [877.429741] Starting subtest: clone-exclusive-crtc [877.440762] Subtest clone-exclusive-crtc: SKIP (0.003s) [877.598966] [142/142] (146s left) gem_ctx_param (vm) [877.970808] Starting subtest: vm [878.112417] Subtest vm: SUCCESS (0.145s) [878.327278] Closing watchdogs Done.