[37.700401] Initializing watchdogs [37.700440] /dev/watchdog0 [37.707453] [001/133] (960s left) i915_query (query-topology-garbage-items) [37.779284] Starting subtest: query-topology-garbage-items [37.781900] Subtest query-topology-garbage-items: SUCCESS (0.000s) [37.842108] [002/133] (960s left) kms_plane_scaling (planes-upscale-20x20) [37.952693] Starting subtest: planes-upscale-20x20 [37.955462] Starting dynamic subtest: pipe-A-eDP-1 [38.035324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.081s) [38.047209] Starting dynamic subtest: pipe-B-eDP-1 [39.279173] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s) [39.292797] Starting dynamic subtest: pipe-C-eDP-1 [40.482923] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s) [40.491228] Starting dynamic subtest: pipe-D-eDP-1 [41.698254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s) [41.701271] Subtest planes-upscale-20x20: SUCCESS (3.746s) [42.918417] [003/133] (955s left) syncobj_timeline (etime-multi-wait-all-submitted) [42.993704] Starting subtest: etime-multi-wait-all-submitted [43.093490] Subtest etime-multi-wait-all-submitted: SUCCESS (0.101s) [43.154211] [004/133] (955s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [43.560702] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [44.423755] [005/133] (953s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [44.486673] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [44.590402] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s) [44.652777] [006/133] (953s left) drm_fdinfo (memory-info-resident) [44.728095] Starting subtest: memory-info-resident [44.730664] Starting dynamic subtest: smem0 [47.399624] Dynamic subtest smem0: SUCCESS (2.671s) [47.402274] Subtest memory-info-resident: SUCCESS (2.671s) [47.458369] [007/133] (950s left) gem_exec_nop (basic-parallel) [47.552570] Starting subtest: basic-parallel [63.410809] Subtest basic-parallel: SUCCESS (15.868s) [63.615488] [008/133] (934s left) perf_pmu (semaphore-busy) [63.674491] Starting subtest: semaphore-busy [63.677179] Starting dynamic subtest: rcs0 [65.321815] Dynamic subtest rcs0: SUCCESS (1.645s) [65.334872] Starting dynamic subtest: bcs0 [66.956757] Dynamic subtest bcs0: SUCCESS (1.635s) [66.969933] Starting dynamic subtest: vcs0 [70.959794] Dynamic subtest vcs0: SUCCESS (4.003s) [70.972525] Starting dynamic subtest: vcs1 [76.974232] Dynamic subtest vcs1: SUCCESS (6.014s) [76.986618] Starting dynamic subtest: vecs0 [82.990645] Dynamic subtest vecs0: SUCCESS (6.016s) [83.003831] Starting dynamic subtest: ccs0 [86.067520] Dynamic subtest ccs0: SUCCESS (3.076s) [86.070670] Subtest semaphore-busy: SUCCESS (22.391s) [86.167461] [009/133] (912s left) gem_exec_reloc (basic-cpu-read-noreloc) [86.245945] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [86.305222] [010/133] (912s left) kms_cursor_crc (cursor-random-512x170) [86.565648] Starting subtest: cursor-random-512x170 [86.570450] Subtest cursor-random-512x170: SKIP (0.001s) [86.680789] [011/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [86.806770] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [91.923630] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.121s) [92.023218] [012/133] (906s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [92.166650] Starting subtest: psr-indfb-scaledprimary [95.943130] Subtest psr-indfb-scaledprimary: SUCCESS (3.781s) [96.063543] [013/133] (902s left) gem_softpin (evict-snoop) [96.129701] Starting subtest: evict-snoop [96.134838] Subtest evict-snoop: SKIP (0.000s) [96.247551] [014/133] (902s left) perf_pmu (gt-awake) [96.303744] Starting subtest: gt-awake [105.460378] Subtest gt-awake: SUCCESS (9.156s) [105.546188] [015/133] (892s left) kms_chamelium_color (ctm-green-to-red) [105.666406] Subtest ctm-green-to-red: SKIP (0.000s) [105.686237] [016/133] (892s left) kms_big_fb (y-tiled-8bpp-rotate-180) [105.791371] Starting subtest: y-tiled-8bpp-rotate-180 [105.796045] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [105.869889] [017/133] (892s left) gem_exec_schedule (smoketest) [106.078776] Starting subtest: smoketest [106.081778] Starting dynamic subtest: rcs0 [111.638745] Dynamic subtest rcs0: SUCCESS (5.506s) [111.649305] Starting dynamic subtest: bcs0 [117.119692] Dynamic subtest bcs0: SUCCESS (5.482s) [117.130063] Starting dynamic subtest: vcs0 [122.604514] Dynamic subtest vcs0: SUCCESS (5.485s) [122.613077] Starting dynamic subtest: vcs1 [128.086193] Dynamic subtest vcs1: SUCCESS (5.482s) [128.096040] Starting dynamic subtest: vecs0 [133.573242] Dynamic subtest vecs0: SUCCESS (5.486s) [133.582228] Starting dynamic subtest: ccs0 [139.059714] Dynamic subtest ccs0: SUCCESS (5.489s) [139.062106] Subtest smoketest: SUCCESS (32.932s) [139.244702] [018/133] (859s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [139.365500] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [139.368204] Starting dynamic subtest: pipe-A-eDP-1 [144.044180] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.678s) [144.057568] Starting dynamic subtest: pipe-B-eDP-1 [149.871864] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.827s) [149.883900] Starting dynamic subtest: pipe-C-eDP-1 [155.441930] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.569s) [155.447714] Starting dynamic subtest: pipe-D-eDP-1 [161.149536] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.708s) [161.151816] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (21.784s) [162.410485] [019/133] (836s left) gem_exec_reloc (basic-cpu-active) [162.486485] Subtest basic-cpu-active: SKIP (0.000s) [162.531842] [020/133] (836s left) kms_plane_alpha_blend (alpha-transparent-fb) [162.644281] Starting subtest: alpha-transparent-fb [162.908267] Starting dynamic subtest: pipe-A-eDP-1 [163.575870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s) [163.590744] Starting dynamic subtest: pipe-D-eDP-1 [165.006815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s) [165.010281] Subtest alpha-transparent-fb: SUCCESS (2.361s) [165.922783] [021/133] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [166.067056] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [170.893629] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.832s) [171.019345] [022/133] (827s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [171.142086] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [171.146309] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [171.223961] [023/133] (827s left) drm_fdinfo (all-busy-check-all) [171.270584] Starting subtest: all-busy-check-all [171.280799] Subtest all-busy-check-all: SKIP (0.009s) [171.343285] [024/133] (827s left) kms_psr2_sf (overlay-plane-move-continuous-sf) [176.594221] Starting subtest: overlay-plane-move-continuous-sf [176.597280] Starting dynamic subtest: psr2-pipe-A-eDP-1 [183.414355] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (6.818s) [183.426665] Starting dynamic subtest: psr2-pipe-B-eDP-1 [190.194771] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (6.779s) [190.197858] Subtest overlay-plane-move-continuous-sf: SUCCESS (13.603s) [191.081613] [025/133] (807s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [191.226278] Starting subtest: cursorB-vs-flipA-varying-size [191.232067] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [191.330441] [026/133] (807s left) gem_mmap_gtt (big-bo) [191.407562] Subtest big-bo: SKIP (0.000s) [191.444583] [027/133] (807s left) sw_sync (timeline_closed_signaled) [191.497342] Starting subtest: timeline_closed_signaled [191.499633] Subtest timeline_closed_signaled: SUCCESS (0.000s) [191.542659] [028/133] (807s left) syncobj_wait (wait-all-for-submit-complex) [191.625422] Starting subtest: wait-all-for-submit-complex [191.841428] Subtest wait-all-for-submit-complex: SUCCESS (0.215s) [191.911249] [029/133] (806s left) kms_frontbuffer_tracking (fbc-tiling-4) [192.033585] Starting subtest: fbc-tiling-4 [195.102058] Subtest fbc-tiling-4: SUCCESS (3.073s) [195.253250] [030/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [195.380640] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [195.384735] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [195.469596] [031/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [195.604968] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [195.608802] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [195.680646] [032/133] (803s left) sw_sync (sync_random_merge) [195.744861] Starting subtest: sync_random_merge [195.766801] Subtest sync_random_merge: SUCCESS (0.023s) [195.803991] [033/133] (803s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [195.915751] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [195.917857] Starting dynamic subtest: pipe-A-default-mode [196.210426] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [196.216062] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.289s) [197.096896] [034/133] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [197.212341] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [197.216687] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [197.293712] [035/133] (801s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [197.438642] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [205.309992] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (7.873s) [206.185718] [036/133] (792s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [206.317267] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [206.319893] Starting dynamic subtest: pipe-A-eDP-1 [206.324823] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [206.336818] Starting dynamic subtest: pipe-B-eDP-1 [206.341132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [206.347749] Starting dynamic subtest: pipe-C-eDP-1 [206.352336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [206.359085] Starting dynamic subtest: pipe-D-eDP-1 [206.363513] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [206.367972] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s) [206.385236] [037/133] (792s left) vc4/vc4_perfmon (get-values-invalid-pointer) [206.437577] Subtest get-values-invalid-pointer: SKIP (0.000s) [206.480437] [038/133] (792s left) perf_pmu (interrupts) [206.535712] Starting subtest: interrupts [207.685137] Subtest interrupts: SUCCESS (1.147s) [207.781445] [039/133] (791s left) sysfs_timeslice_duration (timeout) [207.850376] Starting subtest: timeout [207.852837] Starting dynamic subtest: vecs0 [217.467624] Dynamic subtest vecs0: SUCCESS (9.612s) [217.483318] Starting dynamic subtest: ccs0 [218.138317] Dynamic subtest ccs0: SUCCESS (0.672s) [218.151615] Starting dynamic subtest: vcs0 [227.452058] Dynamic subtest vcs0: SUCCESS (9.308s) [227.466836] Starting dynamic subtest: bcs0 [228.116979] Dynamic subtest bcs0: SUCCESS (0.665s) [228.130978] Starting dynamic subtest: rcs0 [228.861675] Dynamic subtest rcs0: SUCCESS (0.746s) [228.876163] Starting dynamic subtest: vcs1 [238.453703] Dynamic subtest vcs1: SUCCESS (9.586s) [238.456732] Subtest timeout: SUCCESS (30.600s) [238.521496] [040/133] (760s left) kms_psr (psr2-cursor-render) [238.627156] Starting subtest: psr2-cursor-render [238.629711] Starting dynamic subtest: eDP-1 [240.452214] Dynamic subtest eDP-1: SUCCESS (1.821s) [240.454716] Subtest psr2-cursor-render: SUCCESS (1.822s) [241.387362] [041/133] (757s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [241.514174] Starting subtest: basic-flip-before-cursor-atomic [242.443072] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s) [243.319351] [042/133] (755s left) kms_flip (plain-flip-ts-check-interruptible) [243.430689] Starting subtest: plain-flip-ts-check-interruptible [243.433842] Starting dynamic subtest: A-eDP1 [252.385779] Dynamic subtest A-eDP1: SUCCESS (8.955s) [252.396868] Starting dynamic subtest: B-eDP1 [261.342724] Dynamic subtest B-eDP1: SUCCESS (8.955s) [261.356662] Starting dynamic subtest: C-eDP1 [270.293136] Dynamic subtest C-eDP1: SUCCESS (8.948s) [270.307585] Starting dynamic subtest: D-eDP1 [279.191068] Dynamic subtest D-eDP1: SUCCESS (8.897s) [279.199294] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.771s) [280.496088] [043/133] (718s left) prime_self_import (basic-with_two_bos) [280.537183] Starting subtest: basic-with_two_bos [280.562557] Subtest basic-with_two_bos: SUCCESS (0.024s) [280.653603] [044/133] (718s left) core_auth (basic-auth) [280.724967] Starting subtest: basic-auth [280.727478] Subtest basic-auth: SUCCESS (0.002s) [280.806391] [045/133] (718s left) gen7_exec_parse (basic-allowed) [280.875621] Subtest basic-allowed: SKIP (0.000s) [280.914416] [046/133] (718s left) kms_atomic_transition (plane-all-transition-nonblocking) [281.035961] Starting subtest: plane-all-transition-nonblocking [281.038441] Starting dynamic subtest: pipe-A-eDP-1 [283.535132] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s) [283.847345] Starting dynamic subtest: pipe-B-eDP-1 [287.163386] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.329s) [287.475278] Subtest plane-all-transition-nonblocking: SUCCESS (6.437s) [288.366534] [047/133] (710s left) kms_big_fb (linear-8bpp-rotate-270) [288.495504] Starting subtest: linear-8bpp-rotate-270 [288.512846] Subtest linear-8bpp-rotate-270: SKIP (0.018s) [288.641758] [048/133] (710s left) gem_eio (in-flight-internal-10ms) [288.856990] Starting subtest: in-flight-internal-10ms [290.566432] Subtest in-flight-internal-10ms: SUCCESS (1.708s) [290.681446] [049/133] (708s left) gem_exec_schedule (u-semaphore-resolve) [290.759493] Starting subtest: u-semaphore-resolve [290.780658] Subtest u-semaphore-resolve: SUCCESS (0.031s) [291.133617] [050/133] (708s left) v3d/v3d_submit_cl (valid-submission) [291.217705] Subtest valid-submission: SKIP (0.000s) [291.269523] [051/133] (708s left) kms_psr (psr-sprite-render) [291.396523] Starting subtest: psr-sprite-render [291.399495] Starting dynamic subtest: eDP-1 [293.242454] Dynamic subtest eDP-1: SUCCESS (1.844s) [293.245085] Subtest psr-sprite-render: SUCCESS (1.845s) [294.122890] [052/133] (705s left) v3d/v3d_perfmon (get-values-valid-perfmon) [294.202045] Subtest get-values-valid-perfmon: SKIP (0.000s) [294.249218] [053/133] (705s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [294.387427] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [295.043073] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.658s) [295.206571] [054/133] (704s left) perf_pmu (all-busy-check-all) [295.257247] Starting subtest: all-busy-check-all [296.435302] Subtest all-busy-check-all: SUCCESS (1.176s) [296.531042] [055/133] (702s left) kms_big_fb (x-tiled-64bpp-rotate-90) [296.668589] Starting subtest: x-tiled-64bpp-rotate-90 [296.686215] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s) [296.803826] [056/133] (702s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [296.913116] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [296.915563] Starting dynamic subtest: pipe-A-default-mode [297.207500] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [297.212394] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.289s) [298.091268] [057/133] (701s left) gem_spin_batch (legacy) [298.172265] Starting subtest: legacy [298.175267] Starting dynamic subtest: default [301.413291] Dynamic subtest default: SUCCESS (3.236s) [301.429083] Starting dynamic subtest: render [304.643060] Dynamic subtest render: SUCCESS (3.229s) [304.657295] Starting dynamic subtest: bsd [307.878692] Dynamic subtest bsd: SUCCESS (3.233s) [307.894070] Starting dynamic subtest: bsd1 [311.111316] Dynamic subtest bsd1: SUCCESS (3.231s) [311.126350] Starting dynamic subtest: bsd2 [314.347853] Dynamic subtest bsd2: SUCCESS (3.233s) [314.363268] Starting dynamic subtest: blt [317.584734] Dynamic subtest blt: SUCCESS (3.236s) [317.598895] Starting dynamic subtest: vebox [320.820625] Dynamic subtest vebox: SUCCESS (3.234s) [320.823192] Subtest legacy: SUCCESS (22.645s) [321.537600] [058/133] (678s left) kms_cursor_legacy (torture-bo) [321.684718] Starting subtest: torture-bo [321.687336] Starting dynamic subtest: pipe-A [327.521655] Dynamic subtest pipe-A: SUCCESS (5.832s) [327.539294] Starting dynamic subtest: pipe-B [334.088502] Dynamic subtest pipe-B: SUCCESS (6.567s) [334.107842] Starting dynamic subtest: pipe-C [340.404704] Dynamic subtest pipe-C: SUCCESS (6.315s) [340.420598] Starting dynamic subtest: pipe-D [347.093077] Dynamic subtest pipe-D: SUCCESS (6.688s) [347.113384] Starting dynamic subtest: all-pipes [353.536248] Dynamic subtest all-pipes: SUCCESS (6.441s) [353.540484] Subtest torture-bo: SUCCESS (31.849s) [353.682976] [059/133] (645s left) gem_eio (reset-stress) [353.840528] Starting subtest: reset-stress [396.924983] Subtest reset-stress: SUCCESS (43.082s) [398.480129] [060/133] (601s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [398.588774] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [398.591269] Starting dynamic subtest: pipe-A-eDP-1 [398.595844] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [398.607236] Starting dynamic subtest: pipe-B-eDP-1 [398.611361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [398.617660] Starting dynamic subtest: pipe-C-eDP-1 [398.622117] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [398.629739] Starting dynamic subtest: pipe-D-eDP-1 [398.635283] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [398.639997] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s) [398.664369] [061/133] (600s left) kms_psr (fbc-psr2-primary-blt) [398.766681] Starting subtest: fbc-psr2-primary-blt [398.769394] Starting dynamic subtest: eDP-1 [398.774544] Dynamic subtest eDP-1: SKIP (0.000s) [398.779579] Subtest fbc-psr2-primary-blt: SKIP (0.001s) [398.826147] [062/133] (600s left) kms_big_fb (y-tiled-16bpp-rotate-0) [398.946490] Starting subtest: y-tiled-16bpp-rotate-0 [398.951090] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [399.031970] [063/133] (600s left) kms_psr2_sf (cursor-plane-move-continuous-sf) [404.244520] Starting subtest: cursor-plane-move-continuous-sf [404.247213] Starting dynamic subtest: psr2-pipe-A-eDP-1 [415.422182] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (11.174s) [415.435697] Starting dynamic subtest: psr2-pipe-B-eDP-1 [426.574074] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (11.147s) [426.577248] Subtest cursor-plane-move-continuous-sf: SUCCESS (22.327s) [427.503979] [064/133] (572s left) gem_mmap_wc (set-cache-level) [427.583656] Subtest set-cache-level: SKIP (0.000s) [427.630889] [065/133] (572s left) gem_exec_fair (basic-deadline) [427.734375] Subtest basic-deadline: SKIP (0.000s) [427.776794] [066/133] (571s left) kms_psr (fbc-psr-dpms) [427.867686] Starting subtest: fbc-psr-dpms [427.870429] Starting dynamic subtest: eDP-1 [427.875299] Dynamic subtest eDP-1: SKIP (0.000s) [427.880444] Subtest fbc-psr-dpms: SKIP (0.001s) [427.931297] [067/133] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [428.065675] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [428.070167] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [428.165394] [068/133] (571s left) kms_pm_rpm (legacy-planes) [429.722395] Starting subtest: legacy-planes [429.725924] Starting dynamic subtest: plane-40 [454.244947] Dynamic subtest plane-40: SUCCESS (24.523s) [454.256701] Starting dynamic subtest: plane-49 [478.967770] Dynamic subtest plane-49: SUCCESS (24.721s) [478.984809] Starting dynamic subtest: plane-58 [503.550106] Dynamic subtest plane-58: SUCCESS (24.579s) [503.566744] Starting dynamic subtest: plane-67 [528.311544] Dynamic subtest plane-67: SUCCESS (24.761s) [528.314684] Subtest legacy-planes: SUCCESS (98.590s) [529.092635] [069/133] (470s left) gem_ctx_isolation (clean) [529.146153] Starting subtest: clean [529.148786] Starting dynamic subtest: rcs0 [529.188281] Dynamic subtest rcs0: SUCCESS (0.042s) [529.203522] Starting dynamic subtest: bcs0 [529.257639] Dynamic subtest bcs0: SUCCESS (0.069s) [529.269876] Starting dynamic subtest: vcs0 [529.313058] Dynamic subtest vcs0: SUCCESS (0.054s) [529.328060] Starting dynamic subtest: vcs1 [530.474939] Dynamic subtest vcs1: SUCCESS (1.161s) [530.491027] Starting dynamic subtest: vecs0 [532.476205] Dynamic subtest vecs0: SUCCESS (2.001s) [532.492190] Starting dynamic subtest: ccs0 [534.462210] Dynamic subtest ccs0: SUCCESS (1.986s) [534.465280] Subtest clean: SUCCESS (5.317s) [534.682062] [070/133] (465s left) syncobj_timeline (wait-all-complex) [534.745739] Starting subtest: wait-all-complex [534.966437] Subtest wait-all-complex: SUCCESS (0.218s) [535.036508] [071/133] (464s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done) [535.108715] Subtest poll-write-waits-until-write-done: SKIP (0.000s) [535.156286] [072/133] (464s left) syncobj_wait (reset-unsignaled) [535.226289] Starting subtest: reset-unsignaled [535.229123] Subtest reset-unsignaled: SUCCESS (0.000s) [535.318101] [073/133] (464s left) gen9_exec_parse (secure-batches) [535.395475] Subtest secure-batches: SKIP (0.000s) [535.463850] [074/133] (464s left) kms_pm_backlight (fade-with-suspend) [535.580104] Starting subtest: fade-with-suspend [551.962110] Starting dynamic subtest: eDP-1 [554.635807] Dynamic subtest eDP-1: SUCCESS (2.674s) [554.638650] Subtest fade-with-suspend: SUCCESS (4.838s) [555.577241] [075/133] (458s left) kms_scaling_modes (scaling-mode-full-aspect) [555.705358] Starting subtest: scaling-mode-full-aspect [555.707849] Starting dynamic subtest: pipe-A-eDP-1 [555.794802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.088s) [555.809349] Starting dynamic subtest: pipe-B-eDP-1 [557.049184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s) [557.061682] Starting dynamic subtest: pipe-C-eDP-1 [558.301989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.254s) [558.311631] Starting dynamic subtest: pipe-D-eDP-1 [559.518514] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s) [559.521299] Subtest scaling-mode-full-aspect: SUCCESS (3.813s) [560.754897] [076/133] (453s left) perf (non-zero-reason) [560.883640] Starting subtest: non-zero-reason [560.886065] Starting dynamic subtest: 0-rcs0 [567.074526] Dynamic subtest 0-rcs0: SUCCESS (6.191s) [567.094307] Starting dynamic subtest: 1-vcs0 [571.405035] Dynamic subtest 1-vcs0: SUCCESS (4.330s) [571.408380] Subtest non-zero-reason: SUCCESS (10.523s) [571.446221] [077/133] (442s left) kms_rotation_crc (primary-rotation-90) [571.539623] Starting subtest: primary-rotation-90 [571.545204] Subtest primary-rotation-90: SKIP (0.001s) [571.607822] [078/133] (442s left) kms_cursor_crc (cursor-offscreen-128x42) [571.846148] Starting subtest: cursor-offscreen-128x42 [571.875274] Subtest cursor-offscreen-128x42: SKIP (0.025s) [572.061986] [079/133] (442s left) syncobj_timeline (invalid-transfer-bad-pad) [572.122751] Starting subtest: invalid-transfer-bad-pad [572.125246] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [572.216917] [080/133] (442s left) vgem_basic (bad-fence) [572.277822] Starting subtest: bad-fence [572.280549] Subtest bad-fence: SUCCESS (0.000s) [572.328003] [081/133] (442s left) kms_chamelium_edid (dp-edid-read) [572.727890] Subtest dp-edid-read: SKIP (0.000s) [573.589654] [082/133] (440s left) kms_content_protection (content-type-change) [573.740246] Starting subtest: content-type-change [577.355823] Subtest content-type-change: SKIP (3.613s) [578.608742] [083/133] (435s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [578.747452] Starting subtest: fbc-rgb101010-draw-render [582.375584] Subtest fbc-rgb101010-draw-render: SUCCESS (3.633s) [582.507438] [084/133] (431s left) gem_softpin (noreloc) [582.589343] Starting subtest: noreloc [587.981074] Subtest noreloc: SUCCESS (5.390s) [588.099836] [085/133] (426s left) gem_eio (in-flight-internal-1us) [588.340452] Starting subtest: in-flight-internal-1us [589.765082] Subtest in-flight-internal-1us: SUCCESS (1.427s) [589.886544] [086/133] (424s left) i915_module_load (reload-no-display) [589.925393] Starting subtest: reload-no-display [594.156721] Subtest reload-no-display: SUCCESS (4.232s) [594.181888] [087/133] (420s left) gem_workarounds (basic-read-fd) [595.432029] Starting subtest: basic-read-fd [595.457946] Subtest basic-read-fd: SUCCESS (0.026s) [595.534201] [088/133] (419s left) syncobj_timeline (multi-wait-all-available-signaled) [595.625737] Starting subtest: multi-wait-all-available-signaled [595.628675] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [595.715921] [089/133] (418s left) kms_plane (pixel-format-source-clamping) [595.846559] Starting subtest: pixel-format-source-clamping [595.851525] Starting dynamic subtest: pipe-A [605.647085] Dynamic subtest pipe-A: SUCCESS (9.796s) [605.663282] Starting dynamic subtest: pipe-B [616.242293] Dynamic subtest pipe-B: SUCCESS (10.592s) [616.244842] Subtest pixel-format-source-clamping: SUCCESS (20.394s) [617.115675] [090/133] (397s left) gem_lmem_swapping (heavy-verify-multi-ccs) [617.176994] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [617.200540] [091/133] (397s left) gem_ctx_persistence (hostile) [617.248538] Starting subtest: hostile [625.466391] Subtest hostile: SUCCESS (8.214s) [625.594108] [092/133] (389s left) gem_exec_fence (submit) [625.768284] Starting subtest: submit [625.774282] Subtest submit: SKIP (0.000s) [627.742970] [093/133] (386s left) gem_barrier_race (remote-request) [627.829029] Starting subtest: remote-request [627.832188] Starting dynamic subtest: rcs0 [632.927653] Dynamic subtest rcs0: SUCCESS (5.100s) [632.929546] Subtest remote-request: SUCCESS (5.100s) [633.042359] [094/133] (381s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [633.161835] Starting subtest: bad-aux-stride-y-tiled-ccs [633.163975] Starting dynamic subtest: pipe-A-eDP-1 [633.168029] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [633.183052] Starting dynamic subtest: pipe-B-eDP-1 [633.187138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [633.196898] Starting dynamic subtest: pipe-C-eDP-1 [633.200740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [633.207622] Starting dynamic subtest: pipe-D-eDP-1 [633.211574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [633.215529] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s) [633.235108] [095/133] (381s left) gem_fenced_exec_thrash (2-spare-fences) [633.312673] Subtest 2-spare-fences: SKIP (0.000s) [633.372508] [096/133] (381s left) gem_exec_schedule (manyslice) [633.472206] Starting subtest: manyslice [633.474156] Starting dynamic subtest: rcs0 [638.546607] Dynamic subtest rcs0: SUCCESS (5.087s) [638.558540] Starting dynamic subtest: bcs0 [645.184987] Dynamic subtest bcs0: SUCCESS (6.636s) [645.201334] Starting dynamic subtest: vcs0 [650.750522] Dynamic subtest vcs0: SUCCESS (5.564s) [650.768303] Starting dynamic subtest: vcs1 [656.784455] Dynamic subtest vcs1: SUCCESS (6.034s) [656.800991] Starting dynamic subtest: vecs0 [662.307300] Dynamic subtest vecs0: SUCCESS (5.521s) [662.324950] Starting dynamic subtest: ccs0 [667.925185] Dynamic subtest ccs0: SUCCESS (5.617s) [667.927859] Subtest manyslice: SUCCESS (34.466s) [668.222787] [097/133] (346s left) gem_mmap_wc (bad-object) [668.288264] Subtest bad-object: SKIP (0.000s) [668.342580] [098/133] (346s left) i915_pm_rpm (gem-idle) [669.916396] Starting subtest: gem-idle [678.816030] Subtest gem-idle: SUCCESS (8.901s) [679.349068] [099/133] (335s left) gem_ctx_shared (q-promotion) [680.683082] Starting subtest: Q-promotion [680.686239] Starting dynamic subtest: rcs0 [680.776298] Dynamic subtest rcs0: SUCCESS (0.093s) [680.799190] Starting dynamic subtest: vcs0 [680.854823] Dynamic subtest vcs0: SUCCESS (0.078s) [680.875455] Starting dynamic subtest: vcs1 [680.938073] Dynamic subtest vcs1: SUCCESS (0.082s) [680.959409] Starting dynamic subtest: vecs0 [681.020995] Dynamic subtest vecs0: SUCCESS (0.081s) [681.043770] Starting dynamic subtest: ccs0 [681.096022] Dynamic subtest ccs0: SUCCESS (0.074s) [681.099040] Subtest Q-promotion: SUCCESS (0.414s) [682.800094] [100/133] (332s left) gem_exec_parallel (engines) [682.872717] Starting subtest: engines [682.875508] Starting dynamic subtest: basic [684.682950] Dynamic subtest basic: SUCCESS (1.809s) [684.698917] Starting dynamic subtest: contexts [689.116061] Dynamic subtest contexts: SUCCESS (4.431s) [689.123176] Starting dynamic subtest: fds [692.801369] Dynamic subtest fds: SUCCESS (3.683s) [692.810948] Starting dynamic subtest: userptr [694.649877] Dynamic subtest userptr: SUCCESS (1.848s) [694.652575] Subtest engines: SUCCESS (11.777s) [694.830356] [101/133] (320s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [694.944137] Starting subtest: fbcpsr-shrfb-scaledprimary [700.829390] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.889s) [700.963174] [102/133] (313s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [701.087759] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [706.028424] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.943s) [706.122150] [103/133] (308s left) gem_exec_suspend (basic-s4-devices) [706.206567] Starting subtest: basic-S4-devices [706.209911] Starting dynamic subtest: smem [719.675126] Dynamic subtest smem: SUCCESS (13.467s) [719.678553] Subtest basic-S4-devices: SUCCESS (13.468s) [722.863551] [104/133] (295s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [723.023867] Starting subtest: cursorB-vs-flipB-varying-size [723.028684] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [723.163076] [105/133] (294s left) kms_addfb_basic (small-bo) [723.278558] Starting subtest: small-bo [723.281126] Subtest small-bo: SUCCESS (0.000s) [723.378509] [106/133] (294s left) kms_big_fb (4-tiled-32bpp-rotate-0) [723.521080] Starting subtest: 4-tiled-32bpp-rotate-0 [724.841997] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.323s) [724.971840] [107/133] (293s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [725.077232] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [725.081378] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [725.163087] [108/133] (292s left) core_getversion (basic) [725.213075] Starting subtest: basic [725.217501] Subtest basic: SUCCESS (0.000s) [725.277772] [109/133] (292s left) kms_cursor_edge_walk (256x256-right-edge) [725.393134] Starting subtest: 256x256-right-edge [725.395499] Starting dynamic subtest: pipe-A-eDP-1 [728.942193] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.544s) [728.951531] Starting dynamic subtest: pipe-D-eDP-1 [732.183737] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.240s) [732.186451] Subtest 256x256-right-edge: SUCCESS (6.788s) [733.110086] [110/133] (285s left) i915_query (query-topology-kernel-writes) [733.178850] Starting subtest: query-topology-kernel-writes [733.181537] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [733.276101] [111/133] (284s left) kms_big_fb (yf-tiled-addfb) [733.409899] Starting subtest: yf-tiled-addfb [733.414577] Subtest yf-tiled-addfb: SKIP (0.000s) [733.504509] [112/133] (284s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [733.623517] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [733.628131] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [733.711980] [113/133] (284s left) kms_draw_crc (draw-method-render) [733.830348] Starting subtest: draw-method-render [733.833265] Starting dynamic subtest: xrgb8888-untiled [734.075602] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s) [734.085852] Starting dynamic subtest: rgb565-untiled [734.309700] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [734.324840] Starting dynamic subtest: xrgb2101010-untiled [734.517993] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [734.538226] Starting dynamic subtest: xrgb8888-xtiled [734.653733] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [734.671649] Starting dynamic subtest: rgb565-xtiled [734.776123] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [734.786328] Starting dynamic subtest: xrgb2101010-xtiled [734.885089] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [734.893857] Starting dynamic subtest: xrgb8888-4tiled [735.008166] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s) [735.023777] Starting dynamic subtest: rgb565-4tiled [735.119603] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s) [735.134669] Starting dynamic subtest: xrgb2101010-4tiled [735.229191] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s) [735.231367] Subtest draw-method-render: SUCCESS (1.402s) [735.328931] [114/133] (282s left) kms_panel_fitting (atomic-fastset) [735.457030] Starting subtest: atomic-fastset [735.459164] Starting dynamic subtest: pipe-A-eDP-1 [735.618998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.161s) [735.635587] Starting dynamic subtest: pipe-B-eDP-1 [736.921666] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.300s) [736.939977] Starting dynamic subtest: pipe-C-eDP-1 [738.148038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s) [738.156221] Starting dynamic subtest: pipe-D-eDP-1 [739.366560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [739.372540] Subtest atomic-fastset: SUCCESS (3.903s) [740.595817] [115/133] (277s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [740.685191] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [740.690394] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [740.862893] [116/133] (277s left) gem_lmem_swapping (parallel-random) [740.929943] Subtest parallel-random: SKIP (0.000s) [740.958681] [117/133] (277s left) kms_vblank (wait-busy) [741.089271] Starting subtest: wait-busy [741.092141] Starting dynamic subtest: pipe-A-eDP-1 [742.981333] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s) [742.996386] Starting dynamic subtest: pipe-D-eDP-1 [745.608566] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s) [745.611355] Subtest wait-busy: SUCCESS (4.518s) [746.484538] [118/133] (271s left) gem_exec_flush (basic-wb-ro-before-default) [746.565183] Starting subtest: basic-wb-ro-before-default [752.009727] Subtest basic-wb-ro-before-default: SUCCESS (5.444s) [752.194726] [119/133] (266s left) kms_mmap_write_crc (main) [752.331165] Starting subtest: main [752.333725] Starting dynamic subtest: pipe-A-eDP-1 [755.783945] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s) [755.787440] Subtest main: SUCCESS (3.451s) [756.671190] [120/133] (261s left) gem_pxp (protected-raw-src-copy-not-readible) [759.287921] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [759.351976] [121/133] (259s left) gem_ctx_persistence (heartbeat-close) [759.430028] Starting subtest: heartbeat-close [759.434948] Subtest heartbeat-close: SKIP (0.000s) [759.528948] [122/133] (258s left) kms_psr (pr-basic) [759.645246] Starting subtest: pr-basic [759.650498] Subtest pr-basic: SKIP (0.000s) [759.712568] [123/133] (258s left) perf (invalid-oa-metric-set-id) [759.813247] Starting subtest: invalid-oa-metric-set-id [759.824077] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s) [759.857774] [124/133] (258s left) kms_addfb_basic (addfb25-x-tiled-legacy) [759.920544] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [760.050715] [125/133] (258s left) gem_mmap_offset (clear) [760.122042] Starting subtest: clear [760.124789] Starting dynamic subtest: smem0 [785.476162] Dynamic subtest smem0: SUCCESS (25.351s) [785.478319] Subtest clear: SUCCESS (25.352s) [785.655024] [126/133] (232s left) api_intel_bb (crc32) [785.722782] Starting subtest: crc32 [785.725433] Starting dynamic subtest: rcs0-smem0 [786.044980] Dynamic subtest rcs0-smem0: SUCCESS (0.323s) [786.063724] Starting dynamic subtest: bcs0-smem0 [786.429862] Dynamic subtest bcs0-smem0: SUCCESS (0.383s) [786.447929] Starting dynamic subtest: vcs0-smem0 [786.792192] Dynamic subtest vcs0-smem0: SUCCESS (0.360s) [786.812115] Starting dynamic subtest: vcs1-smem0 [787.173629] Dynamic subtest vcs1-smem0: SUCCESS (0.380s) [787.193332] Starting dynamic subtest: vecs0-smem0 [787.562815] Dynamic subtest vecs0-smem0: SUCCESS (0.388s) [787.582432] Starting dynamic subtest: ccs0-smem0 [787.996056] Dynamic subtest ccs0-smem0: SUCCESS (0.432s) [787.999355] Subtest crc32: SUCCESS (2.275s) [788.137947] [127/133] (230s left) gem_wait (invalid-buf) [788.214662] Starting subtest: invalid-buf [788.217663] Subtest invalid-buf: SUCCESS (0.000s) [788.421721] [128/133] (230s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [788.556517] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [788.561045] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [788.648956] [129/133] (229s left) gem_shrink (reclaim) [788.720311] Starting subtest: reclaim [790.967959] Subtest reclaim: SUCCESS (2.247s) [791.040635] [130/133] (227s left) gem_exec_balancer (parallel-ordering) [791.275428] Starting subtest: parallel-ordering [791.897091] Subtest parallel-ordering: SUCCESS (0.621s) [792.034593] [131/133] (226s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [792.181269] Starting subtest: fbc-rgb565-draw-mmap-cpu [794.999096] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.820s) [795.102353] [132/133] (223s left) kms_hdr (static-swap) [795.215064] Starting subtest: static-swap [795.219496] Subtest static-swap: SKIP (0.000s) [795.282210] [133/133] (223s left) gem_exec_reloc (basic-write-gtt) [795.341065] Subtest basic-write-gtt: SKIP (0.000s) [795.391836] Closing watchdogs Done.