[57.070953] Initializing watchdogs [57.070998] /dev/watchdog0 [57.084995] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.089671] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.091960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.096139] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [57.221782] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [57.226312] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [57.328187] [002/132] (960s left) kms_psr (psr2-cursor-blt) [57.428993] Starting subtest: psr2-cursor-blt [57.431368] Starting dynamic subtest: eDP-1 [59.129016] Dynamic subtest eDP-1: SUCCESS (1.685s) [59.131483] Subtest psr2-cursor-blt: SUCCESS (1.686s) [59.924073] [003/132] (957s left) gem_eio (wait-wedge-immediate) [60.080243] Starting subtest: wait-wedge-immediate [61.351307] Subtest wait-wedge-immediate: SUCCESS (1.261s) [61.470041] [004/132] (956s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [61.568162] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [61.570609] Starting dynamic subtest: pipe-A-eDP-1 [61.594877] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [61.603711] Starting dynamic subtest: pipe-B-eDP-1 [61.624663] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [61.631977] Starting dynamic subtest: pipe-C-eDP-1 [61.652724] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [61.660099] Starting dynamic subtest: pipe-D-eDP-1 [61.681903] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [61.686230] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [63.817106] [005/132] (953s left) gem_exec_balancer (sequential) [63.871067] Starting subtest: sequential [66.953298] Subtest sequential: SUCCESS (3.071s) [67.266814] [006/132] (950s left) gem_partial_pwrite_pread (reads-display) [67.333496] Subtest reads-display: SKIP (0.000s) [67.399049] [007/132] (950s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [67.510475] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [67.514472] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [67.606893] [008/132] (950s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [67.703338] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [67.705274] Starting dynamic subtest: pipe-A-eDP-1 [67.726199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [67.735887] Starting dynamic subtest: pipe-B-eDP-1 [67.755576] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [67.763191] Starting dynamic subtest: pipe-C-eDP-1 [67.783573] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [67.791963] Starting dynamic subtest: pipe-D-eDP-1 [67.813423] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [67.815749] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.089s) [70.081261] [009/132] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [70.176949] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [77.777044] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.595s) [77.900090] [010/132] (940s left) kms_big_fb (linear-64bpp-rotate-180) [78.012962] Starting subtest: linear-64bpp-rotate-180 [79.647320] Subtest linear-64bpp-rotate-180: SUCCESS (1.633s) [79.799025] [011/132] (938s left) kms_flip (2x-wf_vblank-ts-check) [79.890494] Starting subtest: 2x-wf_vblank-ts-check [79.900792] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s) [79.976669] [012/132] (938s left) kms_color_pipeline (plane-ctm3x4) [80.086100] Starting subtest: plane-ctm3x4 [80.210110] Starting dynamic subtest: pipe-A-plane-0 [80.332321] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s) [80.340557] Starting dynamic subtest: pipe-A-plane-1 [80.443890] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s) [80.451540] Starting dynamic subtest: pipe-A-plane-2 [80.599493] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [81.796094] Starting dynamic subtest: pipe-B-plane-0 [81.967087] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [81.975057] Starting dynamic subtest: pipe-B-plane-1 [82.077958] Dynamic subtest pipe-B-plane-1: SUCCESS (0.111s) [82.085970] Starting dynamic subtest: pipe-B-plane-2 [82.189465] Dynamic subtest pipe-B-plane-2: SUCCESS (0.111s) [83.328350] Starting dynamic subtest: pipe-C-plane-0 [83.432437] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [83.440942] Starting dynamic subtest: pipe-C-plane-1 [83.543506] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s) [83.551781] Starting dynamic subtest: pipe-C-plane-2 [83.654591] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s) [84.860498] Starting dynamic subtest: pipe-D-plane-0 [84.964611] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s) [84.974063] Starting dynamic subtest: pipe-D-plane-1 [85.075653] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s) [85.085081] Starting dynamic subtest: pipe-D-plane-2 [85.188252] Dynamic subtest pipe-D-plane-2: SUCCESS (0.111s) [85.472529] Subtest plane-ctm3x4: SUCCESS (5.385s) [86.331248] [013/132] (931s left) kms_properties (invalid-properties-legacy) [86.440635] Starting subtest: invalid-properties-legacy [86.538835] Subtest invalid-properties-legacy: SUCCESS (0.100s) [86.608864] [014/132] (931s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [86.705358] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [86.709756] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [86.797232] [015/132] (931s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [86.849982] Subtest writes-after-reads: SKIP (0.000s) [86.909859] [016/132] (931s left) kms_hdr (brightness-with-hdr) [86.998040] Starting subtest: brightness-with-hdr [87.004432] Subtest brightness-with-hdr: SKIP (0.000s) [87.068841] [017/132] (931s left) i915_suspend (debugfs-reader) [87.116848] Starting subtest: debugfs-reader [105.178909] Subtest debugfs-reader: SUCCESS (3.210s) [105.343900] [018/132] (913s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [105.462051] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [105.466446] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [105.563229] [019/132] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [105.674682] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [109.349641] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.625s) [110.555564] [020/132] (907s left) gem_softpin (evict-active-interruptible) [110.619364] Starting subtest: evict-active-interruptible [110.626070] Subtest evict-active-interruptible: SUCCESS (0.007s) [110.742522] [021/132] (907s left) kms_cursor_crc (cursor-sliding-512x512) [111.018188] Starting subtest: cursor-sliding-512x512 [111.022410] Subtest cursor-sliding-512x512: SKIP (0.001s) [111.186332] [022/132] (907s left) gem_exec_whisper (basic-contexts) [111.240463] Starting subtest: basic-contexts [117.157500] Subtest basic-contexts: SUCCESS (5.873s) [117.337674] [023/132] (901s left) gem_userptr_blits (input-checking) [117.399761] Starting subtest: input-checking [117.402028] Subtest input-checking: SUCCESS (0.000s) [117.530754] [024/132] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [117.641883] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [117.645914] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [117.736704] [025/132] (900s left) gem_exec_reloc (basic-write-wc-active) [117.794555] Subtest basic-write-wc-active: SKIP (0.000s) [117.858346] [026/132] (900s left) gem_exec_nop (basic-sequential) [117.923931] Starting subtest: basic-sequential [134.265410] Subtest basic-sequential: SUCCESS (16.317s) [134.490682] [027/132] (884s left) gem_barrier_race (remote-request) [134.558974] Starting subtest: remote-request [134.561513] Starting dynamic subtest: rcs0 [139.720779] Dynamic subtest rcs0: SUCCESS (5.167s) [139.722590] Subtest remote-request: SUCCESS (5.167s) [139.852879] [028/132] (878s left) gem_mmap_gtt (coherency) [139.915365] Subtest coherency: SKIP (0.000s) [139.982179] [029/132] (878s left) kms_lease (multimaster-lease) [140.073506] Starting subtest: multimaster-lease [140.075581] Subtest multimaster-lease: SUCCESS (0.003s) [140.189375] [030/132] (878s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [140.293096] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [140.296907] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [140.394581] [031/132] (878s left) kms_async_flips (async-flip-dpms) [140.499861] Starting subtest: async-flip-dpms [140.880533] Starting dynamic subtest: pipe-A-eDP-1 [144.730023] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.851s) [145.107395] Starting dynamic subtest: pipe-B-eDP-1 [147.888208] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.792s) [148.279312] Starting dynamic subtest: pipe-C-eDP-1 [151.048528] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s) [151.430969] Starting dynamic subtest: pipe-D-eDP-1 [154.206114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.783s) [154.208619] Subtest async-flip-dpms: SUCCESS (13.709s) [155.390521] [032/132] (863s left) i915_drm_fdinfo (memory-info-idle) [155.437620] Starting subtest: memory-info-idle [155.439921] Starting dynamic subtest: smem0 [155.478188] Dynamic subtest smem0: SUCCESS (0.039s) [155.480787] Subtest memory-info-idle: SUCCESS (0.040s) [155.550217] [033/132] (863s left) kms_flip (plain-flip-fb-recreate) [155.635809] Starting subtest: plain-flip-fb-recreate [155.637655] Starting dynamic subtest: A-eDP1 [164.473863] Dynamic subtest A-eDP1: SUCCESS (8.839s) [164.485343] Starting dynamic subtest: B-eDP1 [173.309671] Dynamic subtest B-eDP1: SUCCESS (8.832s) [173.323536] Starting dynamic subtest: C-eDP1 [182.375828] Dynamic subtest C-eDP1: SUCCESS (9.062s) [182.385484] Starting dynamic subtest: D-eDP1 [191.203367] Dynamic subtest D-eDP1: SUCCESS (8.824s) [191.207614] Subtest plain-flip-fb-recreate: SUCCESS (35.567s) [192.385775] [034/132] (826s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [192.446462] Starting subtest: invalid-single-wait-all-unsubmitted [192.448905] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [192.553108] [035/132] (826s left) kms_chamelium_color (ctm-limited-range) [192.651718] Subtest ctm-limited-range: SKIP (0.000s) [192.693275] [036/132] (826s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [192.780801] Starting subtest: flip-vs-dpms-on-nop-interruptible [192.783091] Starting dynamic subtest: A-eDP1 [194.586967] Dynamic subtest A-eDP1: SUCCESS (1.805s) [194.597493] Starting dynamic subtest: B-eDP1 [196.418191] Dynamic subtest B-eDP1: SUCCESS (1.829s) [196.430674] Starting dynamic subtest: C-eDP1 [198.248030] Dynamic subtest C-eDP1: SUCCESS (1.826s) [198.259852] Starting dynamic subtest: D-eDP1 [200.094665] Dynamic subtest D-eDP1: SUCCESS (1.844s) [200.097163] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.315s) [201.261982] [037/132] (817s left) syncobj_timeline (wait-all-interrupted) [201.330669] Starting subtest: wait-all-interrupted [201.438171] Subtest wait-all-interrupted: SUCCESS (0.108s) [201.516061] [038/132] (817s left) kms_chamelium_hpd (vga-hpd) [201.919420] Subtest vga-hpd: SKIP (0.000s) [202.695081] [039/132] (816s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [202.760368] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [202.815433] [040/132] (816s left) kms_flip (dpms-vs-vblank-race) [202.912024] Starting subtest: dpms-vs-vblank-race [202.914380] Starting dynamic subtest: A-eDP1 [207.909283] Dynamic subtest A-eDP1: SUCCESS (4.999s) [207.922151] Starting dynamic subtest: B-eDP1 [212.535131] Dynamic subtest B-eDP1: SUCCESS (4.622s) [212.546512] Starting dynamic subtest: C-eDP1 [216.040269] Dynamic subtest C-eDP1: SUCCESS (3.503s) [216.050548] Starting dynamic subtest: D-eDP1 [220.660622] Dynamic subtest D-eDP1: SUCCESS (4.619s) [220.662754] Subtest dpms-vs-vblank-race: SUCCESS (17.757s) [221.538027] [041/132] (797s left) kms_content_protection (dp-mst-type-1-suspend-resume) [221.687290] Starting subtest: dp-mst-type-1-suspend-resume [221.691756] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [221.793457] [042/132] (797s left) gem_mmap_wc (write) [221.845123] Subtest write: SKIP (0.000s) [221.900267] [043/132] (797s left) gem_ctx_engines (execute-oneforall) [221.960141] Starting subtest: execute-oneforall [222.489309] Subtest execute-oneforall: SUCCESS (0.529s) [224.247213] [044/132] (795s left) kms_properties (connector-properties-legacy) [224.347187] Starting subtest: connector-properties-legacy [224.349569] Starting dynamic subtest: pipe-A-eDP-1 [232.238785] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.889s) [232.248403] Starting dynamic subtest: pipe-None-DP-1 [232.252664] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [232.261233] Starting dynamic subtest: pipe-None-HDMI-A-1 [232.265109] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [232.274160] Starting dynamic subtest: pipe-None-DP-2 [232.278310] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [232.287266] Starting dynamic subtest: pipe-None-HDMI-A-2 [232.291355] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [232.300270] Starting dynamic subtest: pipe-None-DP-3 [232.304615] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [232.313618] Starting dynamic subtest: pipe-None-DP-4 [232.317898] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [232.320038] Subtest connector-properties-legacy: SUCCESS (7.902s) [233.105739] [045/132] (786s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [233.214684] Starting subtest: crc-primary-suspend-y-tiled-ccs [233.216932] Starting dynamic subtest: pipe-A-eDP-1 [233.225980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [233.237366] Starting dynamic subtest: pipe-B-eDP-1 [233.246080] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [233.255552] Starting dynamic subtest: pipe-C-eDP-1 [233.264251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [233.273119] Starting dynamic subtest: pipe-D-eDP-1 [233.281548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [233.285639] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [235.377972] [046/132] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [235.462784] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [242.292791] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.833s) [242.431024] [047/132] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [242.525735] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [242.529657] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [242.607635] [048/132] (776s left) kms_flip (flip-vs-panning-vs-hang) [242.706840] Starting subtest: flip-vs-panning-vs-hang [242.709271] Starting dynamic subtest: A-eDP1 [293.678306] Dynamic subtest A-eDP1: SUCCESS (50.960s) [293.698207] Starting dynamic subtest: D-eDP1 [333.609212] Dynamic subtest D-eDP1: SUCCESS (39.920s) [333.614219] Subtest flip-vs-panning-vs-hang: SUCCESS (90.889s) [334.827225] [049/132] (684s left) gem_exec_schedule (preempt) [334.901501] Starting subtest: preempt [334.903369] Starting dynamic subtest: rcs0 [334.918417] Dynamic subtest rcs0: SUCCESS (0.022s) [334.931106] Starting dynamic subtest: bcs0 [334.936478] Dynamic subtest bcs0: SUCCESS (0.018s) [334.945814] Starting dynamic subtest: vcs0 [334.957012] Dynamic subtest vcs0: SUCCESS (0.020s) [334.966513] Starting dynamic subtest: vcs1 [334.978901] Dynamic subtest vcs1: SUCCESS (0.021s) [334.992400] Starting dynamic subtest: vecs0 [334.997890] Dynamic subtest vecs0: SUCCESS (0.018s) [335.007845] Starting dynamic subtest: ccs0 [335.016148] Dynamic subtest ccs0: SUCCESS (0.017s) [335.018410] Subtest preempt: SUCCESS (0.121s) [336.210443] [050/132] (683s left) gem_ctx_param (invalid-get-no-zeromap) [336.267827] Starting subtest: invalid-get-no-zeromap [336.270043] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [336.393951] [051/132] (683s left) kms_pipe_crc_basic (disable-crc-after-crtc) [336.488775] Starting subtest: disable-crc-after-crtc [336.491102] Starting dynamic subtest: pipe-A-eDP-1 [338.170630] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.682s) [338.181708] Starting dynamic subtest: pipe-B-eDP-1 [340.537260] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.366s) [340.548210] Starting dynamic subtest: pipe-C-eDP-1 [342.786786] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s) [342.797356] Starting dynamic subtest: pipe-D-eDP-1 [345.071868] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.284s) [345.074097] Subtest disable-crc-after-crtc: SUCCESS (8.587s) [345.887488] [052/132] (673s left) api_intel_bb (purge-bb) [345.947152] Starting subtest: purge-bb [345.949795] Subtest purge-bb: SUCCESS (0.004s) [346.076298] [053/132] (673s left) perf_pmu (interrupts) [346.123085] Starting subtest: interrupts [347.250131] Subtest interrupts: SUCCESS (1.124s) [347.364739] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true [347.369484] [054/132] (672s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [347.467457] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [347.469678] Starting dynamic subtest: pipe-A-default-mode [348.643292] Dynamic subtest pipe-A-default-mode: SKIP (1.172s) [348.647742] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.173s) [348.823398] [055/132] (671s left) gem_gpgpu_fill (offset-16x16) [348.892449] Starting subtest: offset-16x16 [348.900543] Subtest offset-16x16: SUCCESS (0.010s) [349.062884] [056/132] (670s left) prime_udl [349.155979] [057/132] (670s left) kms_async_flips (test-time-stamp) [349.255726] Starting subtest: test-time-stamp [349.646722] Starting dynamic subtest: pipe-A-eDP-1 [350.421886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s) [350.815259] Starting dynamic subtest: pipe-B-eDP-1 [351.561817] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s) [351.956630] Starting dynamic subtest: pipe-C-eDP-1 [352.712660] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s) [353.086638] Starting dynamic subtest: pipe-D-eDP-1 [353.848840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s) [353.851333] Subtest test-time-stamp: SUCCESS (4.593s) [355.013322] [058/132] (664s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [355.073027] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [355.077762] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [355.257136] [059/132] (664s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [355.346663] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [355.349591] Starting dynamic subtest: pipe-A [355.410099] Dynamic subtest pipe-A: SUCCESS (0.064s) [355.421018] Starting dynamic subtest: pipe-B [356.520657] Dynamic subtest pipe-B: SUCCESS (1.110s) [356.535786] Starting dynamic subtest: pipe-C [357.629453] Dynamic subtest pipe-C: SUCCESS (1.108s) [357.640527] Starting dynamic subtest: pipe-D [358.768782] Dynamic subtest pipe-D: SUCCESS (1.138s) [358.771240] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.424s) [359.929759] [060/132] (660s left) gem_exec_params (secure-non-master) [359.992160] Starting subtest: secure-non-master [359.996825] Subtest secure-non-master: SKIP (0.000s) [360.100536] [061/132] (660s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [360.166128] Starting subtest: multi-wait-all-for-submit-submitted-signaled [360.268691] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s) [360.346697] [062/132] (659s left) gem_ctx_persistence (legacy-engines-hang) [360.397395] Starting subtest: legacy-engines-hang [360.399716] Starting dynamic subtest: render [360.467775] Dynamic subtest render: SUCCESS (0.069s) [360.480804] Starting dynamic subtest: bsd1 [360.538273] Dynamic subtest bsd1: SUCCESS (0.069s) [360.552020] Starting dynamic subtest: bsd2 [360.649363] Dynamic subtest bsd2: SUCCESS (0.108s) [360.664332] Starting dynamic subtest: blt [360.747335] Dynamic subtest blt: SUCCESS (0.094s) [360.759968] Starting dynamic subtest: vebox [360.838743] Dynamic subtest vebox: SUCCESS (0.088s) [360.841513] Subtest legacy-engines-hang: SUCCESS (0.441s) [360.914551] [063/132] (659s left) gem_mmap_offset (partial-mmap) [360.968079] Starting subtest: partial-mmap [360.970228] Starting dynamic subtest: smem0 [360.972364] Dynamic subtest smem0: SUCCESS (0.004s) [360.974222] Subtest partial-mmap: SUCCESS (0.005s) [361.078028] [064/132] (659s left) kms_dsc (dsc-fractional-bpp) [361.167220] Starting subtest: dsc-fractional-bpp [361.177842] Subtest dsc-fractional-bpp: SKIP (0.000s) [361.238786] [065/132] (659s left) kms_joiner (basic-max-non-joiner) [361.338900] Starting subtest: basic-max-non-joiner [361.342130] Subtest basic-max-non-joiner: SKIP (0.000s) [361.404435] [066/132] (658s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [361.503655] Starting subtest: 4-tiled-addfb-size-offset-overflow [361.505629] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [361.598043] [067/132] (658s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [361.703509] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [361.705290] Starting dynamic subtest: pipe-A-eDP-1 [361.801281] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [361.813915] Starting dynamic subtest: pipe-B-eDP-1 [362.991015] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s) [362.996142] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.288s) [364.184931] [068/132] (656s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [364.280653] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [364.284572] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [364.348690] [069/132] (656s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [364.733206] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [365.502062] [070/132] (655s left) gem_eio (create) [365.734651] Starting subtest: create [366.047034] Subtest create: SUCCESS (0.310s) [366.166073] [071/132] (654s left) gem_exec_fence (syncobj-timeline-signal) [366.687937] Starting subtest: syncobj-timeline-signal [366.694568] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [368.185412] [072/132] (652s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [368.308204] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [369.143650] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s) [369.294089] [073/132] (651s left) kms_frontbuffer_tracking (pipe-fbc-rte) [369.394594] Starting subtest: pipe-fbc-rte [369.401224] Starting dynamic subtest: pipe-B-eDP-1 [374.883855] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.494s) [374.891108] Subtest pipe-fbc-rte: SUCCESS (5.497s) [377.156233] [074/132] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [377.268094] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [377.272572] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [377.371517] [075/132] (643s left) gem_render_copy_redux (normal) [377.424914] Starting subtest: normal [377.733575] Subtest normal: SUCCESS (0.309s) [377.829480] [076/132] (642s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [377.916711] Starting subtest: plane-scaler-unity-scaling-with-rotation [377.919046] Starting dynamic subtest: pipe-A [378.142674] Dynamic subtest pipe-A: SUCCESS (0.228s) [378.154433] Starting dynamic subtest: pipe-B [379.420491] Dynamic subtest pipe-B: SUCCESS (1.277s) [379.431811] Starting dynamic subtest: pipe-C [380.752025] Dynamic subtest pipe-C: SUCCESS (1.330s) [380.763030] Starting dynamic subtest: pipe-D [382.096712] Dynamic subtest pipe-D: SUCCESS (1.343s) [382.099002] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.183s) [383.268402] [077/132] (637s left) kms_psr (fbc-pr-suspend) [383.371698] Starting subtest: fbc-pr-suspend [383.376246] Subtest fbc-pr-suspend: SKIP (0.000s) [383.464301] [078/132] (637s left) gem_busy (close-race) [383.537769] Starting subtest: close-race [407.176941] Subtest close-race: SUCCESS (23.638s) [407.554390] [079/132] (613s left) gem_mmap (pf-nonblock) [407.655460] Subtest pf-nonblock: SKIP (0.000s) [407.719730] [080/132] (613s left) kms_sequence (queue-busy) [407.822542] Starting subtest: queue-busy [407.824957] Starting dynamic subtest: pipe-A-eDP-1 [409.768985] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s) [409.780701] Starting dynamic subtest: pipe-B-eDP-1 [412.356208] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.588s) [412.367160] Starting dynamic subtest: pipe-C-eDP-1 [414.967895] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s) [414.978551] Starting dynamic subtest: pipe-D-eDP-1 [417.511305] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s) [417.513697] Subtest queue-busy: SUCCESS (9.688s) [418.305945] [081/132] (602s left) api_intel_bb (crc32) [418.365508] Starting subtest: crc32 [418.367646] Starting dynamic subtest: rcs0-smem0 [418.672435] Dynamic subtest rcs0-smem0: SUCCESS (0.306s) [418.685362] Starting dynamic subtest: bcs0-smem0 [419.021641] Dynamic subtest bcs0-smem0: SUCCESS (0.346s) [419.034641] Starting dynamic subtest: vcs0-smem0 [419.431658] Dynamic subtest vcs0-smem0: SUCCESS (0.407s) [419.445592] Starting dynamic subtest: vcs1-smem0 [419.826277] Dynamic subtest vcs1-smem0: SUCCESS (0.392s) [419.840201] Starting dynamic subtest: vecs0-smem0 [420.161061] Dynamic subtest vecs0-smem0: SUCCESS (0.332s) [420.175272] Starting dynamic subtest: ccs0-smem0 [420.566431] Dynamic subtest ccs0-smem0: SUCCESS (0.403s) [420.569412] Subtest crc32: SUCCESS (2.203s) [420.687562] [082/132] (600s left) i915_pm_rpm (system-suspend-execbuf) [422.334519] Starting subtest: system-suspend-execbuf [485.083294] Subtest system-suspend-execbuf: SUCCESS (47.818s) [485.460499] [083/132] (535s left) kms_psr (fbc-psr-primary-mmap-gtt) [485.546098] Starting subtest: fbc-psr-primary-mmap-gtt [485.548468] Starting dynamic subtest: eDP-1 [485.553546] Dynamic subtest eDP-1: SKIP (0.000s) [485.558601] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [485.643302] [084/132] (535s left) syncobj_timeline (host-signal-points) [485.703977] Starting subtest: host-signal-points [485.706522] Subtest host-signal-points: SUCCESS (0.005s) [485.801758] [085/132] (535s left) kms_cursor_crc (cursor-random-64x64) [485.978359] Starting subtest: cursor-random-64x64 [485.984424] Starting dynamic subtest: pipe-A-eDP-1 [489.337613] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.354s) [489.368681] Starting dynamic subtest: pipe-D-eDP-1 [493.396735] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.033s) [493.399444] Subtest cursor-random-64x64: SUCCESS (7.415s) [494.215130] [086/132] (527s left) gem_exec_balancer (noheartbeat) [494.483418] Starting subtest: noheartbeat [494.488742] Subtest noheartbeat: SKIP (0.000s) [494.587754] [087/132] (526s left) gem_pxp (verify-pxp-stale-ctx-execution) [494.704016] Starting subtest: verify-pxp-stale-ctx-execution [495.770338] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.064s) [495.894613] [088/132] (525s left) kms_cursor_legacy (single-move) [496.025522] Starting subtest: single-move [496.028163] Starting dynamic subtest: pipe-A [501.409990] Dynamic subtest pipe-A: SUCCESS (5.380s) [501.423743] Starting dynamic subtest: pipe-B [506.794733] Dynamic subtest pipe-B: SUCCESS (5.380s) [506.808136] Starting dynamic subtest: pipe-C [512.177757] Dynamic subtest pipe-C: SUCCESS (5.379s) [512.191248] Starting dynamic subtest: pipe-D [517.560910] Dynamic subtest pipe-D: SUCCESS (5.379s) [517.574004] Starting dynamic subtest: all-pipes [522.951739] Dynamic subtest all-pipes: SUCCESS (5.386s) [522.954662] Subtest single-move: SUCCESS (26.916s) [523.102319] [089/132] (498s left) gen9_exec_parse (basic-rejected) [523.165664] Subtest basic-rejected: SKIP (0.000s) [523.229726] [090/132] (498s left) kms_psr (psr-no-drrs) [523.317385] Starting subtest: psr-no-drrs [523.319617] Starting dynamic subtest: eDP-1 [524.903658] Dynamic subtest eDP-1: SUCCESS (1.585s) [524.906164] Subtest psr-no-drrs: SUCCESS (1.586s) [525.778874] [091/132] (495s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [525.875243] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [525.880550] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [525.948018] [092/132] (495s left) gem_spin_batch (user-each) [526.015749] Starting subtest: user-each [529.291660] Subtest user-each: SUCCESS (3.267s) [530.977854] [093/132] (490s left) gem_lmem_swapping (parallel-random-verify) [531.024642] Subtest parallel-random-verify: SKIP (0.000s) [531.073433] [094/132] (490s left) gem_exec_params (invalid-ring) [531.141450] Starting subtest: invalid-ring [531.144279] Subtest invalid-ring: SUCCESS (0.000s) [531.242127] [095/132] (490s left) i915_drm_fdinfo (virtual-idle) [531.284152] Starting subtest: virtual-idle [534.323659] Subtest virtual-idle: SUCCESS (3.034s) [534.396294] [096/132] (487s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [534.496527] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [534.499473] Starting dynamic subtest: pipe-A-eDP-1 [534.924515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s) [534.935772] Starting dynamic subtest: pipe-B-eDP-1 [536.391511] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s) [536.403235] Starting dynamic subtest: pipe-C-eDP-1 [537.779508] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s) [537.790667] Starting dynamic subtest: pipe-D-eDP-1 [539.145460] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s) [539.148179] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.617s) [540.311424] [097/132] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [540.412187] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [547.205719] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.798s) [547.347226] [098/132] (474s left) gem_workarounds (reset-fd) [547.408211] Starting subtest: reset-fd [547.552544] Subtest reset-fd: SUCCESS (0.142s) [547.655039] [099/132] (474s left) gem_exec_fence (submit-chain) [547.835260] Starting subtest: submit-chain [547.863390] Subtest submit-chain: SUCCESS (0.028s) [550.010546] [100/132] (471s left) sw_sync (timeline_closed) [550.052126] Starting subtest: timeline_closed [550.054954] Subtest timeline_closed: SUCCESS (0.000s) [550.107342] [101/132] (471s left) kms_plane_multiple (2x-tiling-4) [550.196503] Starting subtest: 2x-tiling-4 [550.201511] Subtest 2x-tiling-4: SKIP (0.000s) [550.270029] [102/132] (471s left) gem_wait (await) [550.330270] Starting subtest: await [550.333266] Starting dynamic subtest: all-engines [551.405781] Dynamic subtest all-engines: SUCCESS (1.075s) [551.424238] Starting dynamic subtest: rcs0 [552.465213] Dynamic subtest rcs0: SUCCESS (1.057s) [552.483250] Starting dynamic subtest: bcs0 [553.525780] Dynamic subtest bcs0: SUCCESS (1.058s) [553.543769] Starting dynamic subtest: vcs0 [554.583763] Dynamic subtest vcs0: SUCCESS (1.056s) [554.601752] Starting dynamic subtest: vcs1 [555.641035] Dynamic subtest vcs1: SUCCESS (1.055s) [555.659225] Starting dynamic subtest: vecs0 [556.699150] Dynamic subtest vecs0: SUCCESS (1.056s) [556.717496] Starting dynamic subtest: ccs0 [557.760336] Dynamic subtest ccs0: SUCCESS (1.059s) [557.763528] Subtest await: SUCCESS (7.433s) [557.967090] [103/132] (463s left) perf_pmu (rc6) [558.016347] Starting subtest: rc6 [558.019072] Starting dynamic subtest: gt0 [564.384197] Dynamic subtest gt0: SUCCESS (6.367s) [564.399678] Starting dynamic subtest: runtime-pm-gt0 [572.108464] Dynamic subtest runtime-pm-gt0: SUCCESS (7.722s) [572.123756] Starting dynamic subtest: runtime-pm-long-gt0 [584.542904] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.431s) [584.559194] Starting dynamic subtest: other-idle-gt0 [590.886307] Dynamic subtest other-idle-gt0: SUCCESS (6.340s) [590.900890] Starting dynamic subtest: gt1 [597.229765] Dynamic subtest gt1: SUCCESS (6.339s) [597.242612] Starting dynamic subtest: runtime-pm-gt1 [604.677976] Dynamic subtest runtime-pm-gt1: SUCCESS (7.446s) [604.691867] Starting dynamic subtest: runtime-pm-long-gt1 [617.114437] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.431s) [617.128605] Starting dynamic subtest: other-idle-gt1 [623.457939] Dynamic subtest other-idle-gt1: SUCCESS (6.340s) [623.460718] Subtest rc6: SUCCESS (65.434s) [624.705212] [104/132] (397s left) syncobj_wait (invalid-reset-zero-handles) [624.765224] Starting subtest: invalid-reset-zero-handles [624.767625] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [624.837076] [105/132] (397s left) sysfs_timeslice_duration (invalid) [624.890516] Starting subtest: invalid [624.893013] Starting dynamic subtest: vecs0 [624.895282] Dynamic subtest vecs0: SUCCESS (0.000s) [624.906420] Starting dynamic subtest: ccs0 [624.908487] Dynamic subtest ccs0: SUCCESS (0.000s) [624.918192] Starting dynamic subtest: vcs0 [624.920241] Dynamic subtest vcs0: SUCCESS (0.000s) [624.929987] Starting dynamic subtest: bcs0 [624.932042] Dynamic subtest bcs0: SUCCESS (0.000s) [624.942250] Starting dynamic subtest: rcs0 [624.944522] Dynamic subtest rcs0: SUCCESS (0.000s) [624.954727] Starting dynamic subtest: vcs1 [624.957302] Dynamic subtest vcs1: SUCCESS (0.000s) [624.959430] Subtest invalid: SUCCESS (0.006s) [624.999001] [106/132] (397s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [625.063869] Starting subtest: etime-multi-wait-all-submitted-signaled [625.168207] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s) [625.226662] [107/132] (396s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [625.321637] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [625.327416] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [625.401655] [108/132] (396s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [625.503903] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [632.049630] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.547s) [632.145071] [109/132] (390s left) kms_big_fb (y-tiled-8bpp-rotate-270) [632.240229] Starting subtest: y-tiled-8bpp-rotate-270 [632.245640] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [632.312004] [110/132] (389s left) kms_pm_rpm (fences-dpms) [634.046298] Starting subtest: fences-dpms [634.051900] Subtest fences-dpms: SKIP (0.000s) [634.549446] [111/132] (387s left) kms_addfb_basic (bad-pitch-0) [634.604533] Starting subtest: bad-pitch-0 [634.607275] Subtest bad-pitch-0: SUCCESS (0.000s) [634.710092] [112/132] (387s left) perf_pmu (busy-idle) [634.750236] Starting subtest: busy-idle [634.752750] Starting dynamic subtest: rcs0 [635.436682] Dynamic subtest rcs0: SUCCESS (0.687s) [635.451442] Starting dynamic subtest: bcs0 [636.102735] Dynamic subtest bcs0: SUCCESS (0.664s) [636.117401] Starting dynamic subtest: vcs0 [637.924219] Dynamic subtest vcs0: SUCCESS (1.817s) [637.939138] Starting dynamic subtest: vcs1 [639.844130] Dynamic subtest vcs1: SUCCESS (1.916s) [639.858408] Starting dynamic subtest: vecs0 [641.892032] Dynamic subtest vecs0: SUCCESS (2.044s) [641.906059] Starting dynamic subtest: ccs0 [642.562394] Dynamic subtest ccs0: SUCCESS (0.668s) [642.565523] Subtest busy-idle: SUCCESS (7.814s) [642.642769] [113/132] (379s left) gem_partial_pwrite_pread (writes-after-reads-display) [642.703589] Subtest writes-after-reads-display: SKIP (0.000s) [642.785998] [114/132] (379s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [642.888734] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [642.893332] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [642.955577] [115/132] (379s left) perf_pmu (busy-check-all) [643.000517] Starting subtest: busy-check-all [643.003051] Starting dynamic subtest: rcs0 [643.552107] Dynamic subtest rcs0: SUCCESS (0.552s) [643.566411] Starting dynamic subtest: bcs0 [644.102771] Dynamic subtest bcs0: SUCCESS (0.548s) [644.117035] Starting dynamic subtest: vcs0 [645.924064] Dynamic subtest vcs0: SUCCESS (1.817s) [645.938389] Starting dynamic subtest: vcs1 [647.907905] Dynamic subtest vcs1: SUCCESS (1.980s) [647.921778] Starting dynamic subtest: vecs0 [649.892161] Dynamic subtest vecs0: SUCCESS (1.981s) [649.906592] Starting dynamic subtest: ccs0 [650.448726] Dynamic subtest ccs0: SUCCESS (0.555s) [650.451685] Subtest busy-check-all: SUCCESS (7.449s) [650.529636] [116/132] (371s left) kms_vblank (ts-continuation-modeset-hang) [650.621157] Starting subtest: ts-continuation-modeset-hang [650.623509] Starting dynamic subtest: pipe-A-eDP-1 [676.637232] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.015s) [676.652717] Starting dynamic subtest: pipe-D-eDP-1 [701.677470] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.042s) [701.680156] Subtest ts-continuation-modeset-hang: SUCCESS (51.061s) [702.480863] [117/132] (320s left) syncobj_timeline (reset-unsignaled) [702.540569] Starting subtest: reset-unsignaled [702.542511] Subtest reset-unsignaled: SUCCESS (0.000s) [702.615131] [118/132] (319s left) kms_psr (psr2-primary-render) [702.715146] Starting subtest: psr2-primary-render [702.717652] Starting dynamic subtest: eDP-1 [704.490745] Dynamic subtest eDP-1: SUCCESS (1.774s) [704.493296] Subtest psr2-primary-render: SUCCESS (1.775s) [705.350273] [119/132] (317s left) kms_addfb_basic (small-bo) [705.441140] Starting subtest: small-bo [705.443537] Subtest small-bo: SUCCESS (0.000s) [705.518385] [120/132] (317s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [705.612533] Starting subtest: fbc-rgb101010-draw-blt [710.155739] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.547s) [711.274114] [121/132] (311s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [711.366749] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [711.371684] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [711.442311] [122/132] (311s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [711.539307] Starting subtest: psr2-overlay-plane-update-continuous-sf [711.541562] Starting dynamic subtest: pipe-A-eDP-1 [712.654519] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.120s) [712.666762] Starting dynamic subtest: pipe-B-eDP-1 [714.419534] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.764s) [714.422362] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.887s) [715.213677] [123/132] (307s left) kms_cursor_crc (cursor-dpms) [715.347006] Starting subtest: cursor-dpms [715.349526] Starting dynamic subtest: pipe-A-eDP-1 [718.386965] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.040s) [718.398240] Starting dynamic subtest: pipe-D-eDP-1 [721.990162] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.601s) [721.992670] Subtest cursor-dpms: SUCCESS (6.644s) [722.821002] [124/132] (300s left) prime_vgem (shrink) [722.891457] Starting subtest: shrink [722.914585] Subtest shrink: SUCCESS (0.020s) [723.004810] [125/132] (299s left) device_reset (unbind-cold-reset-rebind) [723.052050] Starting subtest: unbind-cold-reset-rebind [723.057005] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [723.103032] [126/132] (299s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [723.196476] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [727.255087] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.062s) [728.429202] [127/132] (294s left) gem_basic (bad-close) [728.485306] Starting subtest: bad-close [728.490608] Subtest bad-close: SUCCESS (0.000s) [728.566922] [128/132] (294s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [728.669722] Starting subtest: psr-rgb565-draw-mmap-cpu [735.394879] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.728s) [735.489012] [129/132] (287s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [735.614592] Starting subtest: basic-flip-after-cursor-atomic [736.528220] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s) [737.374452] [130/132] (285s left) kms_pm_rpm (basic-pci-d3-state) [739.108016] Starting subtest: basic-pci-d3-state [740.561544] Subtest basic-pci-d3-state: SUCCESS (1.456s) [740.634902] [131/132] (282s left) kms_addfb_basic (too-wide) [740.727459] Starting subtest: too-wide [740.730248] Subtest too-wide: SUCCESS (0.000s) [740.807412] [132/132] (282s left) gem_exec_schedule (thriceslice) [740.876629] Starting subtest: thriceslice [740.879541] Starting dynamic subtest: rcs0 [740.892627] Dynamic subtest rcs0: SUCCESS (0.031s) [740.906324] Starting dynamic subtest: bcs0 [740.944094] Dynamic subtest bcs0: SUCCESS (0.051s) [740.960915] Starting dynamic subtest: vcs0 [740.997740] Dynamic subtest vcs0: SUCCESS (0.051s) [741.013575] Starting dynamic subtest: vcs1 [741.028467] Dynamic subtest vcs1: SUCCESS (0.029s) [741.039292] Starting dynamic subtest: vecs0 [741.056980] Dynamic subtest vecs0: SUCCESS (0.028s) [741.067958] Starting dynamic subtest: ccs0 [741.110051] Dynamic subtest ccs0: SUCCESS (0.052s) [741.112793] Subtest thriceslice: SUCCESS (0.250s) [742.899271] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: gem_eio results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: gem_partial_pwrite_pread results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: kms_color_pipeline results: parsing output: 12/ for test: kms_properties results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 15/ for test: kms_hdr results: parsing output: 16/ for test: i915_suspend results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_softpin results: parsing output: 20/ for test: kms_cursor_crc results: parsing output: 21/ for test: gem_exec_whisper results: parsing output: 22/ for test: gem_userptr_blits results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_exec_reloc results: parsing output: 25/ for test: gem_exec_nop results: parsing output: 26/ for test: gem_barrier_race results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_lease results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_async_flips results: parsing output: 31/ for test: i915_drm_fdinfo results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: kms_chamelium_color results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_chamelium_hpd results: parsing output: 38/ for test: gem_mmap_wc results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_content_protection results: parsing output: 41/ for test: gem_mmap_wc results: parsing output: 42/ for test: gem_ctx_engines results: parsing output: 43/ for test: kms_properties results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: gem_ctx_param results: parsing output: 50/ for test: kms_pipe_crc_basic results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: kms_flip_scaled_crc results: parsing output: 54/ for test: gem_gpgpu_fill results: parsing output: 55/ for test: prime_udl results: parsing output: 56/ for test: kms_async_flips results: parsing output: 57/ for test: gem_render_copy results: parsing output: 58/ for test: kms_plane_scaling results: parsing output: 59/ for test: gem_exec_params results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: gem_ctx_persistence results: parsing output: 62/ for test: gem_mmap_offset results: parsing output: 63/ for test: kms_dsc results: parsing output: 64/ for test: kms_joiner results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: kms_psr2_sf results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: kms_chamelium_frames results: parsing output: 69/ for test: gem_eio results: parsing output: 70/ for test: gem_exec_fence results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_render_copy_redux results: parsing output: 75/ for test: kms_plane_scaling results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: gem_busy results: parsing output: 78/ for test: gem_mmap results: parsing output: 79/ for test: kms_sequence results: parsing output: 80/ for test: api_intel_bb results: parsing output: 81/ for test: i915_pm_rpm results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_exec_balancer results: parsing output: 86/ for test: gem_pxp results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: gen9_exec_parse results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_plane results: parsing output: 91/ for test: gem_spin_batch results: parsing output: 92/ for test: gem_lmem_swapping results: parsing output: 93/ for test: gem_exec_params results: parsing output: 94/ for test: i915_drm_fdinfo results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_workarounds results: parsing output: 98/ for test: gem_exec_fence results: parsing output: 99/ for test: sw_sync results: parsing output: 100/ for test: kms_plane_multiple results: parsing output: 101/ for test: gem_wait results: parsing output: 102/ for test: perf_pmu results: parsing output: 103/ for test: syncobj_wait results: parsing output: 104/ for test: sysfs_timeslice_duration results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_pm_rpm results: parsing output: 110/ for test: kms_addfb_basic results: parsing output: 111/ for test: perf_pmu results: parsing output: 112/ for test: gem_partial_pwrite_pread results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: perf_pmu results: parsing output: 115/ for test: kms_vblank results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: kms_addfb_basic results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_psr2_sf results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: prime_vgem results: parsing output: 124/ for test: device_reset results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_basic results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: kms_pm_rpm results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: gem_exec_schedule Done.