[59.186366] Initializing watchdogs [59.186414] /dev/watchdog0 [59.201646] [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] [59.206401] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.208806] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.212626] [001/156] (960s left) gem_ctx_engines (invalid-engines) [59.296715] Starting subtest: invalid-engines [59.309699] Subtest invalid-engines: SUCCESS (0.013s) [59.537961] [002/156] (960s left) gem_linear_blits (normal) [59.789616] Starting subtest: normal [64.395147] Subtest normal: SUCCESS (4.604s) [64.561917] [003/156] (955s left) kms_flip (nonblocking-read) [64.716425] Starting subtest: nonblocking-read [64.718302] Subtest nonblocking-read: SUCCESS (0.000s) [64.824056] [004/156] (955s left) gem_ctx_bad_destroy (invalid-ctx) [64.889854] Starting subtest: invalid-ctx [64.892499] Subtest invalid-ctx: SUCCESS (0.000s) [64.961701] [005/156] (954s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [65.059490] Starting subtest: psr2-cursor-plane-move-continuous-sf [65.061755] Starting dynamic subtest: pipe-A-eDP-1 [75.473137] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.416s) [75.482306] Starting dynamic subtest: pipe-B-eDP-1 [86.553556] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.076s) [86.556161] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.496s) [87.455774] [006/156] (932s left) gem_exec_schedule (u-independent) [87.538064] Starting subtest: u-independent [87.540060] Starting dynamic subtest: rcs0 [89.281536] Dynamic subtest rcs0: SUCCESS (1.751s) [89.293270] Starting dynamic subtest: vcs0 [91.272780] Dynamic subtest vcs0: SUCCESS (1.990s) [91.283817] Starting dynamic subtest: vcs1 [93.321238] Dynamic subtest vcs1: SUCCESS (2.047s) [93.335252] Starting dynamic subtest: vecs0 [95.309326] Dynamic subtest vecs0: SUCCESS (1.987s) [95.320029] Starting dynamic subtest: ccs0 [97.280891] Dynamic subtest ccs0: SUCCESS (1.970s) [97.283816] Subtest u-independent: SUCCESS (9.750s) [97.584316] [007/156] (922s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render) [97.702628] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render [97.706688] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [97.791380] [008/156] (922s left) i915_hangman (engine-engine-hang) [97.854447] Starting subtest: engine-engine-hang [97.856465] Starting dynamic subtest: rcs0 [99.296282] Dynamic subtest rcs0: SUCCESS (1.441s) [99.308592] Starting dynamic subtest: bcs0 [101.277496] Dynamic subtest bcs0: SUCCESS (1.980s) [101.289820] Starting dynamic subtest: vcs0 [103.261867] Dynamic subtest vcs0: SUCCESS (1.982s) [103.273738] Starting dynamic subtest: vcs1 [105.246067] Dynamic subtest vcs1: SUCCESS (1.983s) [105.257332] Starting dynamic subtest: vecs0 [107.230447] Dynamic subtest vecs0: SUCCESS (1.982s) [107.240919] Starting dynamic subtest: ccs0 [109.285865] Dynamic subtest ccs0: SUCCESS (2.046s) [109.290672] Subtest engine-engine-hang: SUCCESS (11.422s) [109.359252] [009/156] (910s left) gem_lmem_swapping (massive-random) [109.404944] Subtest massive-random: SKIP (0.000s) [109.458074] [010/156] (910s left) gem_pwrite (basic-self) [109.502593] Subtest basic-self: SKIP (0.000s) [109.557658] [011/156] (910s left) i915_drm_fdinfo (isolation) [109.597683] Starting subtest: isolation [109.599681] Starting dynamic subtest: rcs0 [109.626755] Dynamic subtest rcs0: SKIP (0.029s) [109.643341] Starting dynamic subtest: bcs0 [109.647803] Dynamic subtest bcs0: SKIP (0.000s) [109.660692] Starting dynamic subtest: vcs0 [109.664924] Dynamic subtest vcs0: SKIP (0.000s) [109.673324] Starting dynamic subtest: vcs1 [109.677467] Dynamic subtest vcs1: SKIP (0.000s) [109.686652] Starting dynamic subtest: vecs0 [109.690777] Dynamic subtest vecs0: SKIP (0.000s) [109.699176] Starting dynamic subtest: ccs0 [109.703245] Dynamic subtest ccs0: SKIP (0.000s) [109.707318] Subtest isolation: SKIP (0.033s) [109.742570] [012/156] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [109.842991] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [109.847335] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [109.959890] [013/156] (910s left) vgem_basic (busy-fence) [110.069326] Starting subtest: busy-fence [110.071595] Subtest busy-fence: SUCCESS (0.001s) [110.122637] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [110.125722] [014/156] (910s left) gem_exec_nop (basic-series) [110.207301] Starting subtest: basic-series [126.275925] Subtest basic-series: SUCCESS (16.076s) [126.510057] [015/156] (893s left) kms_fb_coherency (memset-crc) [126.605672] Starting subtest: memset-crc [126.607791] Starting dynamic subtest: mmap-offset-wc [127.018636] Dynamic subtest mmap-offset-wc: SUCCESS (0.413s) [127.319216] Starting dynamic subtest: mmap-offset-uc [133.493598] Dynamic subtest mmap-offset-uc: SUCCESS (6.185s) [133.790720] Subtest memset-crc: SUCCESS (7.185s) [134.604737] [016/156] (885s left) kms_plane_scaling (planes-upscale-factor-0-25) [134.695231] Starting subtest: planes-upscale-factor-0-25 [134.697608] Starting dynamic subtest: pipe-A [134.755451] Dynamic subtest pipe-A: SUCCESS (0.063s) [134.766565] Starting dynamic subtest: pipe-B [135.924379] Dynamic subtest pipe-B: SUCCESS (1.169s) [135.938246] Starting dynamic subtest: pipe-C [137.035848] Dynamic subtest pipe-C: SUCCESS (1.110s) [137.047072] Starting dynamic subtest: pipe-D [138.162724] Dynamic subtest pipe-D: SUCCESS (1.127s) [138.165125] Subtest planes-upscale-factor-0-25: SUCCESS (3.470s) [139.346464] [017/156] (881s left) kms_big_fb (4-tiled-8bpp-rotate-0) [139.454498] Starting subtest: 4-tiled-8bpp-rotate-0 [140.678241] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.225s) [140.839200] [018/156] (879s left) gem_eio (create) [141.086337] Starting subtest: create [141.445882] Subtest create: SUCCESS (0.362s) [141.592775] [019/156] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [141.697104] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [141.700680] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [141.804538] [020/156] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [141.899749] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [141.903243] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [141.998169] [021/156] (878s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [142.089074] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [142.092752] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [142.161310] [022/156] (878s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [142.255513] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [142.258996] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [142.334750] [023/156] (878s left) kms_vblank (ts-continuation-idle) [142.428948] Starting subtest: ts-continuation-idle [142.430566] Starting dynamic subtest: pipe-A-eDP-1 [142.838917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s) [142.854425] Starting dynamic subtest: pipe-D-eDP-1 [143.913694] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.073s) [143.916098] Subtest ts-continuation-idle: SUCCESS (1.485s) [144.789674] [024/156] (875s left) kms_plane (plane-position-hole-dpms) [144.885771] Starting subtest: plane-position-hole-dpms [145.419952] Starting dynamic subtest: pipe-A-plane-1 [147.816570] Dynamic subtest pipe-A-plane-1: SUCCESS (2.397s) [147.826960] Starting dynamic subtest: pipe-A-plane-2 [150.277444] Dynamic subtest pipe-A-plane-2: SUCCESS (2.459s) [150.288442] Starting dynamic subtest: pipe-A-plane-3 [152.737639] Dynamic subtest pipe-A-plane-3: SUCCESS (2.458s) [152.749304] Starting dynamic subtest: pipe-A-plane-4 [155.176432] Dynamic subtest pipe-A-plane-4: SUCCESS (2.440s) [155.187308] Starting dynamic subtest: pipe-A-plane-5 [155.204192] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [156.371339] Starting dynamic subtest: pipe-B-plane-1 [158.816515] Dynamic subtest pipe-B-plane-1: SUCCESS (2.454s) [158.827263] Starting dynamic subtest: pipe-B-plane-2 [161.237069] Dynamic subtest pipe-B-plane-2: SUCCESS (2.420s) [161.247952] Starting dynamic subtest: pipe-B-plane-3 [163.594503] Dynamic subtest pipe-B-plane-3: SUCCESS (2.357s) [163.605610] Starting dynamic subtest: pipe-B-plane-4 [165.943172] Dynamic subtest pipe-B-plane-4: SUCCESS (2.347s) [165.954213] Starting dynamic subtest: pipe-B-plane-5 [165.970784] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s) [165.972963] Subtest plane-position-hole-dpms: SUCCESS (21.085s) [166.772891] [025/156] (853s left) kms_psr (pr-primary-mmap-cpu) [166.881270] Starting subtest: pr-primary-mmap-cpu [166.885848] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [166.960927] [026/156] (853s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [167.060024] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [167.062248] Starting dynamic subtest: pipe-A-eDP-1 [167.082339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [167.093500] Starting dynamic subtest: pipe-B-eDP-1 [167.112517] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [167.121350] Starting dynamic subtest: pipe-C-eDP-1 [167.140839] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [167.152468] Starting dynamic subtest: pipe-D-eDP-1 [167.172234] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [167.174146] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [169.337984] [027/156] (851s left) kms_cursor_crc (cursor-sliding-max-size) [169.693089] Starting subtest: cursor-sliding-max-size [169.699386] Subtest cursor-sliding-max-size: SKIP (0.000s) [169.836334] [028/156] (850s left) kms_prop_blob (blob-prop-lifetime) [169.888866] Starting subtest: blob-prop-lifetime [169.891068] Subtest blob-prop-lifetime: SUCCESS (0.001s) [169.985092] [029/156] (850s left) kms_vblank (query-forked) [170.086894] Starting subtest: query-forked [170.089125] Starting dynamic subtest: pipe-A-eDP-1 [171.900739] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s) [171.916410] Starting dynamic subtest: pipe-D-eDP-1 [174.444129] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s) [174.446519] Subtest query-forked: SUCCESS (4.357s) [175.290723] [030/156] (845s left) kms_flip (nonexisting-fb-interruptible) [175.397926] Starting subtest: nonexisting-fb-interruptible [175.400363] Starting dynamic subtest: A-eDP1 [176.586336] Dynamic subtest A-eDP1: SUCCESS (1.187s) [176.597171] Starting dynamic subtest: B-eDP1 [177.718743] Dynamic subtest B-eDP1: SUCCESS (1.131s) [177.731576] Starting dynamic subtest: C-eDP1 [178.844952] Dynamic subtest C-eDP1: SUCCESS (1.125s) [178.856438] Starting dynamic subtest: D-eDP1 [179.982645] Dynamic subtest D-eDP1: SUCCESS (1.135s) [179.985158] Subtest nonexisting-fb-interruptible: SUCCESS (4.587s) [181.167602] [031/156] (839s left) gem_userptr_blits (sd-probe) [181.236664] Starting subtest: sd-probe [181.239058] Subtest sd-probe: SUCCESS (0.000s) [181.381115] [032/156] (839s left) syncobj_wait (invalid-signal-illegal-handle) [181.438938] Starting subtest: invalid-signal-illegal-handle [181.441334] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [181.553794] [033/156] (839s left) gem_ctx_persistence (userptr) [181.616071] Starting subtest: userptr [181.818046] Subtest userptr: SUCCESS (0.201s) [181.920353] [034/156] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [182.019065] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [188.968550] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.953s) [189.079837] [035/156] (832s left) kms_chamelium_edid (dp-edid-change-during-suspend) [189.478538] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [190.277698] [036/156] (830s left) kms_content_protection (dp-mst-lic-type-0) [190.431281] Starting subtest: dp-mst-lic-type-0 [190.435569] Subtest dp-mst-lic-type-0: SKIP (0.000s) [190.572769] [037/156] (830s left) gem_userptr_blits (sync-overlap) [190.636945] Starting subtest: sync-overlap [190.639162] Subtest sync-overlap: SUCCESS (0.000s) [190.763250] [038/156] (830s left) gem_mmap_gtt (medium-copy-xy) [190.819485] Subtest medium-copy-XY: SKIP (0.000s) [190.888049] [039/156] (830s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [190.994728] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [190.999257] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [191.082526] [040/156] (830s left) perf_pmu (init-wait) [191.118855] Starting subtest: init-wait [191.120870] Starting dynamic subtest: rcs0 [191.123191] Dynamic subtest rcs0: SUCCESS (0.004s) [191.133893] Starting dynamic subtest: bcs0 [191.135720] Dynamic subtest bcs0: SUCCESS (0.000s) [191.145086] Starting dynamic subtest: vcs0 [191.146918] Dynamic subtest vcs0: SUCCESS (0.001s) [191.156062] Starting dynamic subtest: vcs1 [191.157922] Dynamic subtest vcs1: SUCCESS (0.000s) [191.166870] Starting dynamic subtest: vecs0 [191.168833] Dynamic subtest vecs0: SUCCESS (0.000s) [191.177811] Starting dynamic subtest: ccs0 [191.179673] Dynamic subtest ccs0: SUCCESS (0.000s) [191.181519] Subtest init-wait: SUCCESS (0.010s) [191.254535] [041/156] (830s left) kms_flip (2x-nonexisting-fb) [191.355985] Starting subtest: 2x-nonexisting-fb [191.365986] Subtest 2x-nonexisting-fb: SKIP (0.011s) [191.445960] [042/156] (829s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [191.555424] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [191.558904] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [191.661666] [043/156] (829s left) gem_exec_balancer (parallel-out-fence) [191.928094] Starting subtest: parallel-out-fence [193.152600] Subtest parallel-out-fence: SUCCESS (1.224s) [193.272220] [044/156] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [193.371232] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [193.375166] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [193.475445] [045/156] (828s left) kms_big_fb (y-tiled-32bpp-rotate-90) [193.581043] Starting subtest: y-tiled-32bpp-rotate-90 [193.585604] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [193.694689] [046/156] (827s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [193.793978] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [193.798640] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [193.878109] [047/156] (827s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [193.986755] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [200.933696] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.952s) [201.073372] [048/156] (820s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [201.169830] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [201.174112] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [201.281555] [049/156] (820s left) kms_atomic (plane-invalid-params-fence) [201.368660] Starting subtest: plane-invalid-params-fence [201.370779] Starting dynamic subtest: pipe-A-eDP-1 [201.735752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s) [201.738104] Subtest plane-invalid-params-fence: SUCCESS (0.367s) [202.570353] [050/156] (819s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [202.692524] Starting subtest: 2x-flip-vs-cursor-atomic [202.697143] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [202.849197] [051/156] (818s left) gen9_exec_parse (bb-chained) [202.913321] Subtest bb-chained: SKIP (0.000s) [202.988203] [052/156] (818s left) kms_psr (psr2-sprite-plane-onoff) [203.086843] Starting subtest: psr2-sprite-plane-onoff [203.089620] Starting dynamic subtest: eDP-1 [204.889564] Dynamic subtest eDP-1: SUCCESS (1.803s) [204.891739] Subtest psr2-sprite-plane-onoff: SUCCESS (1.804s) [205.730959] [053/156] (816s left) kms_big_fb (x-tiled-64bpp-rotate-90) [205.832551] Starting subtest: x-tiled-64bpp-rotate-90 [205.851994] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [205.978669] [054/156] (815s left) gem_exec_params (rel-constants-invalid) [206.029165] Starting subtest: rel-constants-invalid [206.031340] Subtest rel-constants-invalid: SUCCESS (0.000s) [206.141476] [055/156] (815s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [206.232676] Starting subtest: blocking-absolute-wf_vblank-interruptible [206.235192] Starting dynamic subtest: A-eDP1 [214.988995] Dynamic subtest A-eDP1: SUCCESS (8.755s) [214.999463] Starting dynamic subtest: B-eDP1 [223.723067] Dynamic subtest B-eDP1: SUCCESS (8.732s) [223.734820] Starting dynamic subtest: C-eDP1 [232.446640] Dynamic subtest C-eDP1: SUCCESS (8.722s) [232.460160] Starting dynamic subtest: D-eDP1 [241.179135] Dynamic subtest D-eDP1: SUCCESS (8.730s) [241.184357] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.951s) [242.405191] [056/156] (779s left) kms_pwrite_crc (basic) [242.503226] Starting subtest: basic [243.206845] Subtest basic: SUCCESS (0.703s) [244.036619] [057/156] (777s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [244.101267] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [244.105829] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [244.285888] [058/156] (777s left) kms_psr (fbc-psr2-cursor-blt) [244.381800] Starting subtest: fbc-psr2-cursor-blt [244.384065] Starting dynamic subtest: eDP-1 [244.388186] Dynamic subtest eDP-1: SKIP (0.000s) [244.392417] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [244.457131] [059/156] (777s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [244.512607] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [244.514925] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [244.614454] [060/156] (777s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [244.721695] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [244.725627] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [244.815079] [061/156] (777s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [244.917194] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite [244.921369] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [245.013629] [062/156] (777s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [245.135919] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [245.139731] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [245.281490] [063/156] (777s left) i915_suspend (sysfs-reader) [245.326420] Starting subtest: sysfs-reader [263.373831] Subtest sysfs-reader: SUCCESS (3.217s) [263.433718] [064/156] (758s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [263.547020] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [263.550410] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [263.638159] [065/156] (758s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [263.696440] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [263.698550] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [263.806645] [066/156] (758s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt) [263.895869] Starting subtest: hdr-farfromfence-mmap-gtt [263.899402] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s) [263.985279] [067/156] (758s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [264.091868] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [264.095500] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [264.203906] [068/156] (758s left) kms_async_flips (async-flip-dpms) [264.297753] Starting subtest: async-flip-dpms [264.678386] Starting dynamic subtest: pipe-A-eDP-1 [268.574610] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.891s) [268.958904] Starting dynamic subtest: pipe-B-eDP-1 [271.826347] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.876s) [272.221876] Starting dynamic subtest: pipe-C-eDP-1 [275.094161] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.879s) [275.483312] Starting dynamic subtest: pipe-D-eDP-1 [278.270612] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s) [278.272917] Subtest async-flip-dpms: SUCCESS (13.966s) [279.454562] [069/156] (743s left) kms_plane_cursor (overlay) [279.557829] Starting subtest: overlay [279.562524] Starting dynamic subtest: pipe-A-eDP-1-size-64 [282.212340] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.654s) [282.273461] Starting dynamic subtest: pipe-A-eDP-1-size-128 [284.902073] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.638s) [284.963700] Starting dynamic subtest: pipe-A-eDP-1-size-256 [287.669983] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.716s) [288.022793] Starting dynamic subtest: pipe-B-eDP-1-size-64 [291.487160] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.475s) [291.548906] Starting dynamic subtest: pipe-B-eDP-1-size-128 [294.177499] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.638s) [294.237751] Starting dynamic subtest: pipe-B-eDP-1-size-256 [296.878675] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.649s) [297.229371] Starting dynamic subtest: pipe-C-eDP-1-size-64 [300.238121] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.021s) [300.278114] Starting dynamic subtest: pipe-C-eDP-1-size-128 [302.604996] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.336s) [302.644995] Starting dynamic subtest: pipe-C-eDP-1-size-256 [304.972200] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.336s) [305.305660] Starting dynamic subtest: pipe-D-eDP-1-size-64 [308.403199] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.111s) [308.443688] Starting dynamic subtest: pipe-D-eDP-1-size-128 [310.794484] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.358s) [310.832902] Starting dynamic subtest: pipe-D-eDP-1-size-256 [313.137324] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.314s) [313.456116] Subtest overlay: SUCCESS (33.894s) [314.299306] [070/156] (708s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [314.401986] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [314.406010] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [314.485828] [071/156] (708s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [314.587061] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [314.591235] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [314.692950] [072/156] (707s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [314.826002] Starting subtest: modeset-atomic-cursor-hotspot [314.831145] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [314.984231] [073/156] (707s left) api_intel_bb (object-reloc-purge-cache) [315.046863] Starting subtest: object-reloc-purge-cache [315.051566] Subtest object-reloc-purge-cache: SKIP (0.003s) [315.184782] [074/156] (707s left) perf (gen8-unprivileged-single-ctx-counters) [315.315388] Starting subtest: gen8-unprivileged-single-ctx-counters [315.319010] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [315.357894] [075/156] (707s left) syncobj_timeline (wait-any-complex) [315.410485] Starting subtest: wait-any-complex [315.472726] Subtest wait-any-complex: SUCCESS (0.062s) [315.554211] [076/156] (707s left) gem_spin_batch (spin-all-new) [315.610095] Starting subtest: spin-all-new [315.628095] Subtest spin-all-new: SUCCESS (0.018s) [317.156521] [077/156] (705s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [317.254923] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [317.878538] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s) [318.046403] [078/156] (704s left) prime_mmap_kms (buffer-sharing) [318.145121] Starting subtest: buffer-sharing [318.589168] Subtest buffer-sharing: SUCCESS (0.444s) [319.407228] [079/156] (703s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [319.515620] Starting subtest: fbchdr-rgb101010-draw-pwrite [319.520125] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [319.639081] [080/156] (703s left) gem_readwrite (beyond-eob) [319.704592] Subtest beyond-EOB: SKIP (0.000s) [319.774345] [081/156] (703s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [319.884033] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [319.888212] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [319.988335] [082/156] (703s left) kms_psr (fbc-psr-cursor-blt) [320.081992] Starting subtest: fbc-psr-cursor-blt [320.084299] Starting dynamic subtest: eDP-1 [320.088331] Dynamic subtest eDP-1: SKIP (0.000s) [320.092513] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [320.157629] [083/156] (703s left) gem_exec_reloc (basic-scanout) [320.223717] Subtest basic-scanout: SKIP (0.000s) [320.296448] [084/156] (702s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [320.400062] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [324.312413] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.915s) [325.518716] [085/156] (697s left) kms_cursor_crc (cursor-alpha-transparent) [325.611161] Starting subtest: cursor-alpha-transparent [325.613060] Starting dynamic subtest: pipe-A-eDP-1 [326.220605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s) [326.232340] Starting dynamic subtest: pipe-D-eDP-1 [327.503470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s) [327.505868] Subtest cursor-alpha-transparent: SUCCESS (1.893s) [328.377636] [086/156] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [328.490989] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [332.997271] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.513s) [334.176666] [087/156] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff) [334.280371] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff [334.284972] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [334.381642] [088/156] (689s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [334.476777] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [334.481272] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [334.601741] [089/156] (688s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [334.694564] Starting subtest: fbc-pr-cursor-plane-update-sf [334.698691] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [334.780162] [090/156] (688s left) sw_sync (sync_multi_timeline_wait) [334.822513] Starting subtest: sync_multi_timeline_wait [334.824798] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [334.881716] [091/156] (688s left) perf (invalid-oa-metric-set-id) [334.977772] Starting subtest: invalid-oa-metric-set-id [334.994131] Subtest invalid-oa-metric-set-id: SUCCESS (0.015s) [335.039397] [092/156] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [335.136836] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [335.141402] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [335.243927] [093/156] (688s left) gem_exec_schedule (lateslice) [335.313736] Starting subtest: lateslice [335.315461] Starting dynamic subtest: rcs0 [335.329054] Dynamic subtest rcs0: SUCCESS (0.021s) [335.340876] Starting dynamic subtest: bcs0 [335.346957] Dynamic subtest bcs0: SUCCESS (0.017s) [335.357645] Starting dynamic subtest: vcs0 [335.365153] Dynamic subtest vcs0: SUCCESS (0.017s) [335.380413] Starting dynamic subtest: vcs1 [335.384408] Dynamic subtest vcs1: SUCCESS (0.018s) [335.394808] Starting dynamic subtest: vecs0 [335.401736] Dynamic subtest vecs0: SUCCESS (0.017s) [335.412291] Starting dynamic subtest: ccs0 [335.419817] Dynamic subtest ccs0: SUCCESS (0.017s) [335.421765] Subtest lateslice: SUCCESS (0.112s) [337.221511] [094/156] (686s left) kms_atomic_interruptible (universal-setplane-primary) [337.332189] Starting subtest: universal-setplane-primary [337.334533] Starting dynamic subtest: pipe-A-eDP-1 [344.785142] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.449s) [344.787424] Subtest universal-setplane-primary: SUCCESS (7.451s) [345.631837] [095/156] (678s left) gem_exec_balancer (hog) [345.690859] Starting subtest: hog [345.695371] Subtest hog: SKIP (0.000s) [346.000866] [096/156] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [346.098826] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [346.103024] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [346.195714] [097/156] (677s left) gem_partial_pwrite_pread (writes-after-reads) [346.266725] Subtest writes-after-reads: SKIP (0.000s) [346.343194] [098/156] (677s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [346.442607] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [346.447086] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [346.544307] [099/156] (677s left) gem_exec_whisper (basic-contexts-forked) [346.602609] Starting subtest: basic-contexts-forked [371.529787] Subtest basic-contexts-forked: SUCCESS (24.924s) [371.735521] [100/156] (652s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [371.844830] Starting subtest: ccs-on-another-bo-y-tiled-ccs [371.847118] Starting dynamic subtest: pipe-A-eDP-1 [371.869609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [371.885775] Starting dynamic subtest: pipe-B-eDP-1 [371.906334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [371.918035] Starting dynamic subtest: pipe-C-eDP-1 [371.938619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [371.950413] Starting dynamic subtest: pipe-D-eDP-1 [371.972670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [371.976929] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [374.097689] [101/156] (649s left) api_intel_allocator (simple-allocator) [374.145164] Starting subtest: simple-allocator [374.147338] Starting dynamic subtest: basic [374.149526] Dynamic subtest basic: SUCCESS (0.004s) [374.165995] Starting dynamic subtest: parallel-one [374.315252] Dynamic subtest parallel-one: SUCCESS (0.166s) [374.329716] Starting dynamic subtest: print [374.332060] Dynamic subtest print: SUCCESS (0.000s) [374.344083] Starting dynamic subtest: reuse [374.346040] Dynamic subtest reuse: SUCCESS (0.000s) [374.357562] Starting dynamic subtest: reserve [374.359528] Dynamic subtest reserve: SUCCESS (0.000s) [374.370831] Starting dynamic subtest: fork-reopen-allocator [374.372855] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [374.374887] Subtest simple-allocator: SUCCESS (0.188s) [374.463556] [102/156] (649s left) kms_chamelium_hpd (dp-hpd-storm-disable) [374.858332] Subtest dp-hpd-storm-disable: SKIP (0.000s) [375.706322] [103/156] (648s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [375.819839] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [375.821679] Starting dynamic subtest: pipe-A-eDP-1 [376.579544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [376.592877] Starting dynamic subtest: pipe-B-eDP-1 [378.387758] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.808s) [378.400249] Starting dynamic subtest: pipe-C-eDP-1 [380.192246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.803s) [380.205859] Starting dynamic subtest: pipe-D-eDP-1 [382.026075] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.833s) [382.028194] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.202s) [383.249846] [104/156] (640s left) gem_lmem_swapping (verify-ccs) [383.296564] Subtest verify-ccs: SKIP (0.000s) [383.342593] [105/156] (640s left) prime_vgem (basic-fence-mmap) [383.420317] Starting subtest: basic-fence-mmap [383.424901] Subtest basic-fence-mmap: SKIP (0.000s) [383.534361] [106/156] (640s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [383.652252] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [384.453856] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s) [384.621117] [107/156] (639s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [384.720559] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [384.725087] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [384.819369] [108/156] (639s left) kms_joiner (invalid-modeset-force-big-joiner) [384.913897] Starting subtest: invalid-modeset-force-big-joiner [384.917991] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [384.984141] [109/156] (639s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [385.071952] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [385.074217] Starting dynamic subtest: pipe-A-eDP-1 [385.098135] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [385.110311] Starting dynamic subtest: pipe-B-eDP-1 [385.135766] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [385.147063] Starting dynamic subtest: pipe-C-eDP-1 [385.171260] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [385.182428] Starting dynamic subtest: pipe-D-eDP-1 [385.206746] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [385.210908] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [387.426077] [110/156] (636s left) kms_plane_multiple (tiling-4) [387.538928] Starting subtest: tiling-4 [387.540879] Starting dynamic subtest: pipe-A-eDP-1 [391.354055] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.816s) [391.367582] Starting dynamic subtest: pipe-B-eDP-1 [395.898396] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.544s) [395.913008] Starting dynamic subtest: pipe-C-eDP-1 [400.337836] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.437s) [400.351385] Starting dynamic subtest: pipe-D-eDP-1 [404.906288] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.565s) [404.908520] Subtest tiling-4: SUCCESS (17.368s) [405.723827] [111/156] (618s left) prime_vgem (fence-wait) [405.805867] Starting subtest: fence-wait [405.808291] Starting dynamic subtest: rcs0 [406.871153] Dynamic subtest rcs0: SUCCESS (1.063s) [406.888154] Starting dynamic subtest: bcs0 [407.928494] Dynamic subtest bcs0: SUCCESS (1.055s) [407.942532] Starting dynamic subtest: vcs0 [408.975118] Dynamic subtest vcs0: SUCCESS (1.044s) [408.989587] Starting dynamic subtest: vcs1 [410.025413] Dynamic subtest vcs1: SUCCESS (1.047s) [410.038957] Starting dynamic subtest: vecs0 [411.067157] Dynamic subtest vecs0: SUCCESS (1.040s) [411.080927] Starting dynamic subtest: ccs0 [412.109015] Dynamic subtest ccs0: SUCCESS (1.040s) [412.111912] Subtest fence-wait: SUCCESS (6.303s) [412.237276] [112/156] (612s left) perf (enable-disable) [412.324913] Starting subtest: enable-disable [412.327200] Starting dynamic subtest: 0-rcs0 [414.623787] Dynamic subtest 0-rcs0: SUCCESS (2.296s) [414.636426] Starting dynamic subtest: 1-vcs0 [419.113805] Dynamic subtest 1-vcs0: SUCCESS (4.488s) [419.116039] Subtest enable-disable: SUCCESS (6.787s) [419.167375] [113/156] (605s left) kms_flip (nonexisting-fb) [419.293863] Starting subtest: nonexisting-fb [419.296223] Starting dynamic subtest: A-eDP1 [420.512527] Dynamic subtest A-eDP1: SUCCESS (1.220s) [420.527313] Starting dynamic subtest: B-eDP1 [421.655812] Dynamic subtest B-eDP1: SUCCESS (1.141s) [421.671833] Starting dynamic subtest: C-eDP1 [422.794487] Dynamic subtest C-eDP1: SUCCESS (1.136s) [422.808140] Starting dynamic subtest: D-eDP1 [423.935292] Dynamic subtest D-eDP1: SUCCESS (1.140s) [423.937716] Subtest nonexisting-fb: SUCCESS (4.647s) [425.101042] [114/156] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [425.196062] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [425.200160] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [425.302120] [115/156] (599s left) gem_userptr_blits (input-checking) [425.361732] Starting subtest: input-checking [425.363686] Subtest input-checking: SUCCESS (0.000s) [425.504479] [116/156] (599s left) kms_cursor_legacy (cursor-vs-flip-toggle) [425.630414] Starting subtest: cursor-vs-flip-toggle [456.998895] Subtest cursor-vs-flip-toggle: SUCCESS (31.366s) [457.850142] [117/156] (566s left) gem_busy (extended) [458.037568] Starting subtest: extended [458.039986] Starting dynamic subtest: rcs0 [458.125245] Dynamic subtest rcs0: SUCCESS (0.087s) [458.139860] Starting dynamic subtest: bcs0 [458.168439] Dynamic subtest bcs0: SUCCESS (0.041s) [458.180994] Starting dynamic subtest: vcs0 [460.144252] Dynamic subtest vcs0: SUCCESS (1.971s) [460.159129] Starting dynamic subtest: vcs1 [462.128603] Dynamic subtest vcs1: SUCCESS (1.980s) [462.147006] Starting dynamic subtest: vecs0 [464.112269] Dynamic subtest vecs0: SUCCESS (1.980s) [464.128843] Starting dynamic subtest: ccs0 [464.158804] Dynamic subtest ccs0: SUCCESS (0.045s) [464.161141] Subtest extended: SUCCESS (6.121s) [464.412083] [118/156] (560s left) prime_mmap (test_refcounting) [464.474376] Starting subtest: test_refcounting [464.476391] Starting dynamic subtest: test_refcounting-smem [464.506455] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s) [464.509009] Subtest test_refcounting: SUCCESS (0.035s) [464.623397] [119/156] (560s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [464.725634] Starting subtest: primary-y-tiled-reflect-x-180 [464.797199] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s) [464.915856] [120/156] (559s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [465.011828] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [465.016386] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [466.177835] [121/156] (558s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [466.285967] Starting subtest: psr-1p-pri-indfb-multidraw [489.776741] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.494s) [489.905425] [122/156] (535s left) kms_pm_dc (dc5-psr) [491.014281] Starting subtest: dc5-psr [494.000159] Subtest dc5-psr: SUCCESS (2.986s) [494.820698] [123/156] (530s left) i915_pm_rpm (gem-idle) [496.360981] Starting subtest: gem-idle [502.560882] Subtest gem-idle: SUCCESS (6.202s) [502.921746] [124/156] (522s left) gem_render_copy_redux (interruptible) [504.087467] Starting subtest: interruptible [504.366193] Subtest interruptible: SUCCESS (0.280s) [504.496319] [125/156] (520s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [504.591332] Starting subtest: fbcpsrhdr-rgb101010-draw-render [504.595885] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [504.706623] [126/156] (520s left) sw_sync (timeline_closed) [504.742888] Starting subtest: timeline_closed [504.744981] Subtest timeline_closed: SUCCESS (0.000s) [504.806306] [127/156] (520s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [504.891039] Starting subtest: plane-lut1d-ctm3x4-lut1d [505.070797] Starting dynamic subtest: pipe-A-plane-0 [505.270284] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s) [505.282925] Starting dynamic subtest: pipe-A-plane-1 [505.436948] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [505.449099] Starting dynamic subtest: pipe-A-plane-2 [505.625591] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [506.854878] Starting dynamic subtest: pipe-B-plane-0 [507.044180] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s) [507.056681] Starting dynamic subtest: pipe-B-plane-1 [507.233124] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [507.246073] Starting dynamic subtest: pipe-B-plane-2 [507.421923] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s) [508.661600] Starting dynamic subtest: pipe-C-plane-0 [508.817317] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [508.831425] Starting dynamic subtest: pipe-C-plane-1 [508.984019] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [508.997026] Starting dynamic subtest: pipe-C-plane-2 [509.150511] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [510.397475] Starting dynamic subtest: pipe-D-plane-0 [510.552340] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [510.565290] Starting dynamic subtest: pipe-D-plane-1 [510.719221] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [510.732446] Starting dynamic subtest: pipe-D-plane-2 [510.886477] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [511.172536] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.282s) [512.035713] [128/156] (513s left) kms_psr (fbc-pr-cursor-plane-move) [512.123563] Starting subtest: fbc-pr-cursor-plane-move [512.127878] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [512.198179] [129/156] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [512.305079] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [519.446305] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.146s) [519.578011] [130/156] (505s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [519.627888] Starting subtest: etime-multi-wait-all-for-submit-submitted [519.730767] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s) [519.810106] [131/156] (505s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [519.863461] Starting subtest: yf-tiled-ccs-to-y-tiled [519.867977] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [520.064334] [132/156] (505s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt) [520.177740] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt [520.182032] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [520.286400] [133/156] (505s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [520.408559] Starting subtest: cursorB-vs-flipB-toggle [520.413215] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [520.557719] [134/156] (504s left) drm_mm (drm_mm) [520.594183] Starting subtest: drm_mm [520.633630] Starting dynamic subtest: drm_test_mm_init [520.737026] Dynamic subtest drm_test_mm_init: SUCCESS (0.101s) [520.749071] Starting dynamic subtest: drm_test_mm_debug [520.840502] Dynamic subtest drm_test_mm_debug: SUCCESS (0.102s) [520.852464] Starting dynamic subtest: drm_test_mm_align32 [520.945295] Dynamic subtest drm_test_mm_align32: SUCCESS (0.103s) [520.956899] Starting dynamic subtest: drm_test_mm_align64 [521.057999] Dynamic subtest drm_test_mm_align64: SUCCESS (0.112s) [521.069458] Starting dynamic subtest: drm_test_mm_lowest [521.152883] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.093s) [521.166011] Starting dynamic subtest: drm_test_mm_highest [521.242857] Dynamic subtest drm_test_mm_highest: SUCCESS (0.088s) [521.244491] Subtest drm_mm: SUCCESS (0.648s) [521.413782] [135/156] (504s left) perf_pmu (busy-check-all) [521.451624] Starting subtest: busy-check-all [521.453577] Starting dynamic subtest: rcs0 [522.003822] Dynamic subtest rcs0: SUCCESS (0.551s) [522.019881] Starting dynamic subtest: bcs0 [522.556716] Dynamic subtest bcs0: SUCCESS (0.551s) [522.572024] Starting dynamic subtest: vcs0 [524.144469] Dynamic subtest vcs0: SUCCESS (1.583s) [524.160256] Starting dynamic subtest: vcs1 [526.128337] Dynamic subtest vcs1: SUCCESS (1.980s) [526.142138] Starting dynamic subtest: vecs0 [528.111740] Dynamic subtest vecs0: SUCCESS (1.980s) [528.132288] Starting dynamic subtest: ccs0 [528.666399] Dynamic subtest ccs0: SUCCESS (0.554s) [528.668899] Subtest busy-check-all: SUCCESS (7.215s) [528.788597] [136/156] (496s left) kms_flip (2x-flip-vs-dpms-on-nop) [528.883985] Starting subtest: 2x-flip-vs-dpms-on-nop [528.896215] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [528.981746] [137/156] (496s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [529.070803] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [529.072986] Starting dynamic subtest: pipe-A-default-mode [531.794583] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s) [531.796988] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.725s) [532.670180] [138/156] (493s left) gem_exec_suspend (basic-s3-devices) [532.728503] Starting subtest: basic-S3-devices [532.730986] Starting dynamic subtest: smem [544.112315] Dynamic subtest smem: SUCCESS (11.381s) [544.115162] Subtest basic-S3-devices: SUCCESS (11.383s) [544.313189] [139/156] (481s left) gem_ctx_persistence (engines-mixed) [544.377036] Starting subtest: engines-mixed [544.378988] Starting dynamic subtest: rcs0 [544.448348] Dynamic subtest rcs0: SUCCESS (0.074s) [544.461594] Starting dynamic subtest: bcs0 [544.499418] Dynamic subtest bcs0: SUCCESS (0.049s) [544.512369] Starting dynamic subtest: vcs0 [544.548208] Dynamic subtest vcs0: SUCCESS (0.047s) [544.559783] Starting dynamic subtest: vcs1 [544.606569] Dynamic subtest vcs1: SUCCESS (0.056s) [544.620091] Starting dynamic subtest: vecs0 [544.676531] Dynamic subtest vecs0: SUCCESS (0.068s) [544.690963] Starting dynamic subtest: ccs0 [544.743508] Dynamic subtest ccs0: SUCCESS (0.065s) [544.746158] Subtest engines-mixed: SUCCESS (0.370s) [544.840149] [140/156] (480s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [544.952224] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [544.956295] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [545.056977] [141/156] (480s left) kms_cursor_crc (cursor-sliding-128x42) [545.269741] Starting subtest: cursor-sliding-128x42 [545.326627] Subtest cursor-sliding-128x42: SKIP (0.052s) [545.530912] [142/156] (480s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [545.647281] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [550.160612] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.517s) [551.376417] [143/156] (474s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [551.477510] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [551.481605] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [551.593363] [144/156] (474s left) syncobj_wait (reset-during-wait-for-submit) [551.650579] Starting subtest: reset-during-wait-for-submit [551.753546] Subtest reset-during-wait-for-submit: SUCCESS (0.102s) [551.852727] [145/156] (474s left) kms_lease (lease-invalid-plane) [551.945825] Starting subtest: lease-invalid-plane [551.948176] Starting dynamic subtest: pipe-A-eDP-1 [551.950374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [551.962804] Starting dynamic subtest: pipe-B-eDP-1 [551.965033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [551.977130] Starting dynamic subtest: pipe-C-eDP-1 [551.979008] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [551.990631] Starting dynamic subtest: pipe-D-eDP-1 [551.992540] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [551.994465] Subtest lease-invalid-plane: SUCCESS (0.004s) [552.036758] [146/156] (474s left) kms_flip (basic-plain-flip) [552.137530] Starting subtest: basic-plain-flip [552.139891] Starting dynamic subtest: A-eDP1 [553.844259] Dynamic subtest A-eDP1: SUCCESS (1.707s) [553.858191] Starting dynamic subtest: B-eDP1 [555.571256] Dynamic subtest B-eDP1: SUCCESS (1.725s) [555.585603] Starting dynamic subtest: C-eDP1 [557.297401] Dynamic subtest C-eDP1: SUCCESS (1.725s) [557.312086] Starting dynamic subtest: D-eDP1 [558.927441] Dynamic subtest D-eDP1: SUCCESS (1.626s) [558.929607] Subtest basic-plain-flip: SUCCESS (6.795s) [560.103047] [147/156] (465s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [560.206295] Starting subtest: hdr-2p-primscrn-spr-indfb-move [560.210752] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [560.319883] [148/156] (465s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [560.374975] Starting subtest: invalid-multi-wait-all-unsubmitted [560.377262] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [560.505727] [149/156] (465s left) gem_mmap_offset (clear-via-pagefault) [560.561534] Starting subtest: clear-via-pagefault [560.563492] Starting dynamic subtest: smem0 [596.575391] Dynamic subtest smem0: SUCCESS (36.008s) [596.577541] Subtest clear-via-pagefault: SUCCESS (36.009s) [596.695408] [150/156] (429s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [596.752595] Starting subtest: multi-wait-all-for-submit-available-signaled [596.754999] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [596.861396] [151/156] (429s left) kms_atomic_transition (plane-toggle-modeset-transition) [596.952129] Starting subtest: plane-toggle-modeset-transition [596.954210] Starting dynamic subtest: pipe-A-eDP-1 [597.840035] Dynamic subtest pipe-A-eDP-1: FAIL (0.306s) [597.854500] Starting dynamic subtest: pipe-B-eDP-1 [609.644704] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.383s) [609.648004] Subtest plane-toggle-modeset-transition: FAIL (12.694s) [610.461563] [152/156] (415s left) gem_exec_fence (syncobj-import) [610.908083] Starting subtest: syncobj-import [610.913782] Subtest syncobj-import: SUCCESS (0.005s) [612.235007] [153/156] (414s left) kms_getfb (getfb2-handle-not-fb) [612.328900] Starting subtest: getfb2-handle-not-fb [612.331203] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [612.426624] [154/156] (413s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [612.526405] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [612.530773] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [612.615909] [155/156] (413s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [612.713339] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [612.717727] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [612.835425] [156/156] (413s left) prime_vgem (basic-write) [612.923617] Starting subtest: basic-write [612.933018] Subtest basic-write: SKIP (0.007s) [613.051902] Closing watchdogs results: parsing output: 0/ for test: gem_ctx_engines results: parsing output: 1/ for test: gem_linear_blits results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: gem_ctx_bad_destroy results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: i915_hangman results: parsing output: 8/ for test: gem_lmem_swapping results: parsing output: 9/ for test: gem_pwrite results: parsing output: 10/ for test: i915_drm_fdinfo results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: vgem_basic results: parsing output: 13/ for test: gem_exec_nop results: parsing output: 14/ for test: kms_fb_coherency results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: gem_eio results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_plane results: parsing output: 21/ for test: kms_flip_scaled_crc results: parsing output: 22/ for test: kms_vblank results: parsing output: 23/ for test: kms_plane results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_cursor_crc results: parsing output: 27/ for test: kms_prop_blob results: parsing output: 28/ for test: kms_vblank results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_userptr_blits results: parsing output: 31/ for test: syncobj_wait results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_chamelium_edid results: parsing output: 35/ for test: kms_content_protection results: parsing output: 36/ for test: gem_userptr_blits results: parsing output: 37/ for test: gem_mmap_gtt results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: perf_pmu results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_big_fb 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_frontbuffer_tracking results: parsing output: 48/ for test: kms_atomic results: parsing output: 49/ for test: kms_cursor_legacy results: parsing output: 50/ for test: gen9_exec_parse results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_params results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_pwrite_crc results: parsing output: 56/ for test: gem_render_copy results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_cursor_legacy results: parsing output: 62/ for test: i915_suspend results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_async_flips results: parsing output: 68/ for test: kms_plane_cursor results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_cursor_legacy results: parsing output: 72/ for test: api_intel_bb results: parsing output: 73/ for test: perf results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: gem_spin_batch results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: prime_mmap_kms results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_readwrite results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: gem_exec_reloc results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_psr2_sf results: parsing output: 89/ for test: sw_sync results: parsing output: 90/ for test: perf results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: kms_atomic_interruptible results: parsing output: 94/ for test: gem_exec_balancer results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_partial_pwrite_pread results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_exec_whisper results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: api_intel_allocator results: parsing output: 101/ for test: kms_chamelium_hpd results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: gem_lmem_swapping results: parsing output: 104/ for test: prime_vgem results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_joiner results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: kms_plane_multiple results: parsing output: 110/ for test: prime_vgem results: parsing output: 111/ for test: perf results: parsing output: 112/ for test: kms_flip results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: gem_busy results: parsing output: 117/ for test: prime_mmap results: parsing output: 118/ for test: kms_rotation_crc results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_pm_dc results: parsing output: 122/ for test: i915_pm_rpm results: parsing output: 123/ for test: gem_render_copy_redux results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: sw_sync results: parsing output: 126/ for test: kms_color_pipeline results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: gem_render_copy results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_cursor_legacy results: parsing output: 133/ for test: drm_mm results: parsing output: 134/ for test: perf_pmu results: parsing output: 135/ for test: kms_flip results: parsing output: 136/ for test: kms_flip_scaled_crc results: parsing output: 137/ for test: gem_exec_suspend results: parsing output: 138/ for test: gem_ctx_persistence results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_cursor_crc results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: syncobj_wait results: parsing output: 144/ for test: kms_lease results: parsing output: 145/ for test: kms_flip results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: syncobj_wait results: parsing output: 148/ for test: gem_mmap_offset results: parsing output: 149/ for test: syncobj_timeline results: parsing output: 150/ for test: kms_atomic_transition results: parsing output: 151/ for test: gem_exec_fence results: parsing output: 152/ for test: kms_getfb results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: prime_vgem Done.