[58.834365] Initializing watchdogs [58.834509] /dev/watchdog0 [58.850681] [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] [58.855196] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.857311] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.860464] [001/156] (960s left) gem_ctx_engines (invalid-engines) [58.947577] Starting subtest: invalid-engines [58.960727] Subtest invalid-engines: SUCCESS (0.014s) [59.195852] [002/156] (960s left) gem_linear_blits (normal) [59.465858] Starting subtest: normal [64.140819] Subtest normal: SUCCESS (4.730s) [64.284164] [003/156] (955s left) kms_flip (nonblocking-read) [64.439718] Starting subtest: nonblocking-read [64.441599] Subtest nonblocking-read: SUCCESS (0.000s) [64.541869] [004/156] (954s left) gem_ctx_bad_destroy (invalid-ctx) [64.597736] Starting subtest: invalid-ctx [64.599950] Subtest invalid-ctx: SUCCESS (0.000s) [64.663781] [005/156] (954s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [64.767690] Starting subtest: psr2-cursor-plane-move-continuous-sf [64.770643] Starting dynamic subtest: pipe-A-eDP-1 [75.118735] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.399s) [75.126907] Starting dynamic subtest: pipe-B-eDP-1 [86.181238] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.074s) [86.183532] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.476s) [87.077866] [006/156] (932s left) gem_exec_schedule (u-independent) [87.169789] Starting subtest: u-independent [87.172109] Starting dynamic subtest: rcs0 [88.316328] Dynamic subtest rcs0: SUCCESS (1.155s) [88.326263] Starting dynamic subtest: vcs0 [90.305128] Dynamic subtest vcs0: SUCCESS (1.988s) [90.317854] Starting dynamic subtest: vcs1 [92.299102] Dynamic subtest vcs1: SUCCESS (1.993s) [92.311715] Starting dynamic subtest: vecs0 [94.276984] Dynamic subtest vecs0: SUCCESS (1.976s) [94.286976] Starting dynamic subtest: ccs0 [96.316465] Dynamic subtest ccs0: SUCCESS (2.038s) [96.319043] Subtest u-independent: SUCCESS (9.154s) [96.626913] [007/156] (922s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render) [96.729811] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render [96.734304] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [96.809495] [008/156] (922s left) i915_hangman (engine-engine-hang) [96.879217] Starting subtest: engine-engine-hang [96.881438] Starting dynamic subtest: rcs0 [98.267994] Dynamic subtest rcs0: SUCCESS (1.388s) [98.278246] Starting dynamic subtest: bcs0 [100.186639] Dynamic subtest bcs0: SUCCESS (1.917s) [100.197773] Starting dynamic subtest: vcs0 [101.275144] Dynamic subtest vcs0: SUCCESS (1.087s) [101.285236] Starting dynamic subtest: vcs1 [103.259075] Dynamic subtest vcs1: SUCCESS (1.982s) [103.269036] Starting dynamic subtest: vecs0 [105.239234] Dynamic subtest vecs0: SUCCESS (1.979s) [105.254995] Starting dynamic subtest: ccs0 [107.228585] Dynamic subtest ccs0: SUCCESS (1.988s) [107.231565] Subtest engine-engine-hang: SUCCESS (10.349s) [107.309364] [009/156] (912s left) gem_lmem_swapping (massive-random) [107.356409] Subtest massive-random: SKIP (0.000s) [107.395825] [010/156] (912s left) gem_pwrite (basic-self) [107.458123] Subtest basic-self: SKIP (0.000s) [107.511643] [011/156] (912s left) i915_drm_fdinfo (isolation) [107.553493] Starting subtest: isolation [107.555623] Starting dynamic subtest: rcs0 [107.590893] Dynamic subtest rcs0: SKIP (0.035s) [107.598904] Starting dynamic subtest: bcs0 [107.603078] Dynamic subtest bcs0: SKIP (0.001s) [107.611020] Starting dynamic subtest: vcs0 [107.615210] Dynamic subtest vcs0: SKIP (0.000s) [107.622881] Starting dynamic subtest: vcs1 [107.627140] Dynamic subtest vcs1: SKIP (0.000s) [107.636354] Starting dynamic subtest: vecs0 [107.640392] Dynamic subtest vecs0: SKIP (0.000s) [107.647939] Starting dynamic subtest: ccs0 [107.651855] Dynamic subtest ccs0: SKIP (0.000s) [107.655813] Subtest isolation: SKIP (0.039s) [107.691740] [012/156] (912s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [107.793945] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [107.798326] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [107.876754] [013/156] (911s left) vgem_basic (busy-fence) [107.988116] Starting subtest: busy-fence [107.990197] Subtest busy-fence: SUCCESS (0.000s) [108.038459] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [108.041503] [014/156] (911s left) gem_exec_nop (basic-series) [108.121638] Starting subtest: basic-series [124.288689] Subtest basic-series: SUCCESS (16.175s) [124.530226] [015/156] (895s left) kms_fb_coherency (memset-crc) [124.620172] Starting subtest: memset-crc [124.622675] Starting dynamic subtest: mmap-offset-wc [125.018650] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s) [125.321687] Starting dynamic subtest: mmap-offset-uc [131.409827] Dynamic subtest mmap-offset-uc: SUCCESS (6.099s) [131.703294] Subtest memset-crc: SUCCESS (7.083s) [132.537375] [016/156] (887s left) kms_plane_scaling (planes-upscale-factor-0-25) [132.623209] Starting subtest: planes-upscale-factor-0-25 [132.625461] Starting dynamic subtest: pipe-A [132.685211] Dynamic subtest pipe-A: SUCCESS (0.064s) [132.695409] Starting dynamic subtest: pipe-B [133.855909] Dynamic subtest pipe-B: SUCCESS (1.171s) [133.866142] Starting dynamic subtest: pipe-C [134.966577] Dynamic subtest pipe-C: SUCCESS (1.110s) [134.975950] Starting dynamic subtest: pipe-D [136.094734] Dynamic subtest pipe-D: SUCCESS (1.128s) [136.097250] Subtest planes-upscale-factor-0-25: SUCCESS (3.474s) [137.260199] [017/156] (882s left) kms_big_fb (4-tiled-8bpp-rotate-0) [137.360357] Starting subtest: 4-tiled-8bpp-rotate-0 [138.575180] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.216s) [138.716495] [018/156] (881s left) gem_eio (create) [138.938117] Starting subtest: create [139.274177] Subtest create: SUCCESS (0.336s) [139.413160] [019/156] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [139.522241] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [139.525564] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [139.614687] [020/156] (880s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [139.713943] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [139.717272] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [139.800395] [021/156] (880s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [139.896367] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [139.899688] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [139.969228] [022/156] (880s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [140.064090] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [140.067917] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [140.151981] [023/156] (880s left) kms_vblank (ts-continuation-idle) [140.242414] Starting subtest: ts-continuation-idle [140.244422] Starting dynamic subtest: pipe-A-eDP-1 [140.662545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s) [140.677512] Starting dynamic subtest: pipe-D-eDP-1 [141.764432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s) [141.766799] Subtest ts-continuation-idle: SUCCESS (1.523s) [142.624668] [024/156] (877s left) kms_plane (plane-position-hole-dpms) [142.713298] Starting subtest: plane-position-hole-dpms [143.204965] Starting dynamic subtest: pipe-A-plane-1 [145.512943] Dynamic subtest pipe-A-plane-1: SUCCESS (2.308s) [145.521805] Starting dynamic subtest: pipe-A-plane-2 [147.771081] Dynamic subtest pipe-A-plane-2: SUCCESS (2.257s) [147.779772] Starting dynamic subtest: pipe-A-plane-3 [150.088549] Dynamic subtest pipe-A-plane-3: SUCCESS (2.313s) [150.098334] Starting dynamic subtest: pipe-A-plane-4 [152.538061] Dynamic subtest pipe-A-plane-4: SUCCESS (2.452s) [152.549371] Starting dynamic subtest: pipe-A-plane-5 [152.563743] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [153.718840] Starting dynamic subtest: pipe-B-plane-1 [156.149049] Dynamic subtest pipe-B-plane-1: SUCCESS (2.437s) [156.157956] Starting dynamic subtest: pipe-B-plane-2 [158.575651] Dynamic subtest pipe-B-plane-2: SUCCESS (2.428s) [158.584125] Starting dynamic subtest: pipe-B-plane-3 [160.866268] Dynamic subtest pipe-B-plane-3: SUCCESS (2.288s) [160.875043] Starting dynamic subtest: pipe-B-plane-4 [163.234192] Dynamic subtest pipe-B-plane-4: SUCCESS (2.368s) [163.243060] Starting dynamic subtest: pipe-B-plane-5 [163.260953] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s) [163.262888] Subtest plane-position-hole-dpms: SUCCESS (20.547s) [164.048432] [025/156] (856s left) kms_psr (pr-primary-mmap-cpu) [164.142346] Starting subtest: pr-primary-mmap-cpu [164.146930] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [164.229028] [026/156] (856s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [164.320137] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [164.322407] Starting dynamic subtest: pipe-A-eDP-1 [164.343065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [164.353390] Starting dynamic subtest: pipe-B-eDP-1 [164.373137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [164.381439] Starting dynamic subtest: pipe-C-eDP-1 [164.400215] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [164.408341] Starting dynamic subtest: pipe-D-eDP-1 [164.427960] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [164.430205] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s) [166.608808] [027/156] (853s left) kms_cursor_crc (cursor-sliding-max-size) [166.952202] Starting subtest: cursor-sliding-max-size [166.958938] Subtest cursor-sliding-max-size: SKIP (0.000s) [167.082943] [028/156] (853s left) kms_prop_blob (blob-prop-lifetime) [167.132976] Starting subtest: blob-prop-lifetime [167.135266] Subtest blob-prop-lifetime: SUCCESS (0.001s) [167.241752] [029/156] (853s left) kms_vblank (query-forked) [167.334358] Starting subtest: query-forked [167.336833] Starting dynamic subtest: pipe-A-eDP-1 [169.171970] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.834s) [169.186533] Starting dynamic subtest: pipe-D-eDP-1 [171.726269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s) [171.728694] Subtest query-forked: SUCCESS (4.391s) [172.586459] [030/156] (847s left) kms_flip (nonexisting-fb-interruptible) [172.684464] Starting subtest: nonexisting-fb-interruptible [172.686684] Starting dynamic subtest: A-eDP1 [173.861464] Dynamic subtest A-eDP1: SUCCESS (1.175s) [173.872889] Starting dynamic subtest: B-eDP1 [174.986957] Dynamic subtest B-eDP1: SUCCESS (1.125s) [175.001229] Starting dynamic subtest: C-eDP1 [176.114434] Dynamic subtest C-eDP1: SUCCESS (1.125s) [176.124366] Starting dynamic subtest: D-eDP1 [177.236543] Dynamic subtest D-eDP1: SUCCESS (1.121s) [177.241812] Subtest nonexisting-fb-interruptible: SUCCESS (4.555s) [178.407105] [031/156] (842s left) gem_userptr_blits (sd-probe) [178.479067] Starting subtest: sd-probe [178.481238] Subtest sd-probe: SUCCESS (0.000s) [178.608844] [032/156] (841s left) syncobj_wait (invalid-signal-illegal-handle) [178.657971] Starting subtest: invalid-signal-illegal-handle [178.660188] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [178.762330] [033/156] (841s left) gem_ctx_persistence (userptr) [178.806602] Starting subtest: userptr [178.954068] Subtest userptr: SUCCESS (0.147s) [179.029663] [034/156] (841s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [179.133031] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [185.895500] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.768s) [186.021192] [035/156] (834s left) kms_chamelium_edid (dp-edid-change-during-suspend) [186.418675] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [187.256396] [036/156] (833s left) kms_content_protection (dp-mst-lic-type-0) [187.400061] Starting subtest: dp-mst-lic-type-0 [187.404692] Subtest dp-mst-lic-type-0: SKIP (0.000s) [187.526237] [037/156] (833s left) gem_userptr_blits (sync-overlap) [187.585346] Starting subtest: sync-overlap [187.587333] Subtest sync-overlap: SUCCESS (0.000s) [187.706053] [038/156] (833s left) gem_mmap_gtt (medium-copy-xy) [187.769512] Subtest medium-copy-XY: SKIP (0.000s) [187.835176] [039/156] (833s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [187.939221] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [187.943151] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [188.061678] [040/156] (832s left) perf_pmu (init-wait) [188.104804] Starting subtest: init-wait [188.107225] Starting dynamic subtest: rcs0 [188.109516] Dynamic subtest rcs0: SUCCESS (0.002s) [188.120594] Starting dynamic subtest: bcs0 [188.122511] Dynamic subtest bcs0: SUCCESS (0.000s) [188.130631] Starting dynamic subtest: vcs0 [188.132587] Dynamic subtest vcs0: SUCCESS (0.001s) [188.140705] Starting dynamic subtest: vcs1 [188.142637] Dynamic subtest vcs1: SUCCESS (0.001s) [188.151244] Starting dynamic subtest: vecs0 [188.153438] Dynamic subtest vecs0: SUCCESS (0.001s) [188.163154] Starting dynamic subtest: ccs0 [188.165029] Dynamic subtest ccs0: SUCCESS (0.000s) [188.166941] Subtest init-wait: SUCCESS (0.007s) [188.207849] [041/156] (832s left) kms_flip (2x-nonexisting-fb) [188.291776] Starting subtest: 2x-nonexisting-fb [188.302350] Subtest 2x-nonexisting-fb: SKIP (0.010s) [188.379496] [042/156] (832s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [188.468818] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [188.472441] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [188.559213] [043/156] (832s left) gem_exec_balancer (parallel-out-fence) [188.814637] Starting subtest: parallel-out-fence [190.036321] Subtest parallel-out-fence: SUCCESS (1.222s) [190.163769] [044/156] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [190.264722] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [190.269210] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [190.360435] [045/156] (830s left) kms_big_fb (y-tiled-32bpp-rotate-90) [190.455591] Starting subtest: y-tiled-32bpp-rotate-90 [190.459693] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [190.558163] [046/156] (830s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [190.645744] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [190.650102] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [190.750116] [047/156] (830s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [190.848869] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [197.572747] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.729s) [197.696146] [048/156] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [197.805910] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [197.810404] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [197.897560] [049/156] (823s left) kms_atomic (plane-invalid-params-fence) [197.990075] Starting subtest: plane-invalid-params-fence [197.992438] Starting dynamic subtest: pipe-A-eDP-1 [198.360157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s) [198.362453] Subtest plane-invalid-params-fence: SUCCESS (0.371s) [199.231402] [050/156] (822s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [199.347419] Starting subtest: 2x-flip-vs-cursor-atomic [199.351935] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [199.507085] [051/156] (821s left) gen9_exec_parse (bb-chained) [199.563422] Subtest bb-chained: SKIP (0.000s) [199.645435] [052/156] (821s left) kms_psr (psr2-sprite-plane-onoff) [199.730121] Starting subtest: psr2-sprite-plane-onoff [199.732386] Starting dynamic subtest: eDP-1 [201.430980] Dynamic subtest eDP-1: SUCCESS (1.701s) [201.433588] Subtest psr2-sprite-plane-onoff: SUCCESS (1.702s) [202.301794] [053/156] (819s left) kms_big_fb (x-tiled-64bpp-rotate-90) [202.398771] Starting subtest: x-tiled-64bpp-rotate-90 [202.418545] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [202.533516] [054/156] (818s left) gem_exec_params (rel-constants-invalid) [202.604069] Starting subtest: rel-constants-invalid [202.606327] Subtest rel-constants-invalid: SUCCESS (0.000s) [202.724930] [055/156] (818s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [202.825157] Starting subtest: blocking-absolute-wf_vblank-interruptible [202.827518] Starting dynamic subtest: A-eDP1 [211.588375] Dynamic subtest A-eDP1: SUCCESS (8.727s) [211.599941] Starting dynamic subtest: B-eDP1 [220.322989] Dynamic subtest B-eDP1: SUCCESS (8.733s) [220.332229] Starting dynamic subtest: C-eDP1 [229.063370] Dynamic subtest C-eDP1: SUCCESS (8.726s) [229.077326] Starting dynamic subtest: D-eDP1 [237.794999] Dynamic subtest D-eDP1: SUCCESS (8.730s) [237.797434] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.926s) [238.977408] [056/156] (782s left) kms_pwrite_crc (basic) [239.074715] Starting subtest: basic [239.769303] Subtest basic: SUCCESS (0.696s) [240.610548] [057/156] (780s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [240.666418] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [240.670521] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [240.846758] [058/156] (780s left) kms_psr (fbc-psr2-cursor-blt) [240.934413] Starting subtest: fbc-psr2-cursor-blt [240.936838] Starting dynamic subtest: eDP-1 [240.941103] Dynamic subtest eDP-1: SKIP (0.000s) [240.945308] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [241.006511] [059/156] (780s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [241.057021] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [241.059361] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [241.177366] [060/156] (780s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [241.275042] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [241.279149] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [241.377338] [061/156] (780s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [241.487678] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite [241.491720] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [241.579461] [062/156] (780s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [241.698412] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [241.702889] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [241.842972] [063/156] (779s left) i915_suspend (sysfs-reader) [241.892481] Starting subtest: sysfs-reader [260.100587] Subtest sysfs-reader: SUCCESS (3.272s) [260.169210] [064/156] (761s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [260.281713] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [260.284917] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [260.381358] [065/156] (761s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [260.430489] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [260.432322] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [260.533471] [066/156] (761s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt) [260.640676] Starting subtest: hdr-farfromfence-mmap-gtt [260.644162] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s) [260.730201] [067/156] (761s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [260.828109] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [260.831528] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [260.918673] [068/156] (761s left) kms_async_flips (async-flip-dpms) [261.007702] Starting subtest: async-flip-dpms [261.382413] Starting dynamic subtest: pipe-A-eDP-1 [265.238538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.947s) [265.600211] Starting dynamic subtest: pipe-B-eDP-1 [268.451347] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.897s) [268.846979] Starting dynamic subtest: pipe-C-eDP-1 [271.696795] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.884s) [272.078775] Starting dynamic subtest: pipe-D-eDP-1 [274.964176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.913s) [274.966590] Subtest async-flip-dpms: SUCCESS (14.162s) [276.129955] [069/156] (745s left) kms_plane_cursor (overlay) [276.222709] Starting subtest: overlay [276.227213] Starting dynamic subtest: pipe-A-eDP-1-size-64 [278.768063] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.558s) [278.831287] Starting dynamic subtest: pipe-A-eDP-1-size-128 [281.373858] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.562s) [281.434489] Starting dynamic subtest: pipe-A-eDP-1-size-256 [283.979631] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s) [284.330033] Starting dynamic subtest: pipe-B-eDP-1-size-64 [287.611309] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.297s) [287.671613] Starting dynamic subtest: pipe-B-eDP-1-size-128 [290.142780] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.483s) [290.204199] Starting dynamic subtest: pipe-B-eDP-1-size-256 [292.755644] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s) [293.109296] Starting dynamic subtest: pipe-C-eDP-1-size-64 [295.961177] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.861s) [296.001993] Starting dynamic subtest: pipe-C-eDP-1-size-128 [298.161284] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s) [298.200907] Starting dynamic subtest: pipe-C-eDP-1-size-256 [300.406479] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s) [300.735235] Starting dynamic subtest: pipe-D-eDP-1-size-64 [303.656508] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.935s) [303.696203] Starting dynamic subtest: pipe-D-eDP-1-size-128 [305.823611] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s) [305.862357] Starting dynamic subtest: pipe-D-eDP-1-size-256 [308.012472] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.159s) [308.329991] Subtest overlay: SUCCESS (32.141s) [309.211254] [070/156] (712s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [309.311570] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [309.315950] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [309.413077] [071/156] (712s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [309.519330] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [309.523796] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [309.645096] [072/156] (712s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [309.768179] Starting subtest: modeset-atomic-cursor-hotspot [309.772753] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [309.926193] [073/156] (712s left) api_intel_bb (object-reloc-purge-cache) [309.982099] Starting subtest: object-reloc-purge-cache [309.986493] Subtest object-reloc-purge-cache: SKIP (0.002s) [310.104863] [074/156] (712s left) perf (gen8-unprivileged-single-ctx-counters) [310.238899] Starting subtest: gen8-unprivileged-single-ctx-counters [310.242568] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [310.280044] [075/156] (712s left) syncobj_timeline (wait-any-complex) [310.331690] Starting subtest: wait-any-complex [310.394222] Subtest wait-any-complex: SUCCESS (0.062s) [310.483570] [076/156] (711s left) gem_spin_batch (spin-all-new) [310.541971] Starting subtest: spin-all-new [310.556035] Subtest spin-all-new: SUCCESS (0.013s) [312.287944] [077/156] (710s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [312.385831] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [313.009670] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s) [313.183471] [078/156] (709s left) prime_mmap_kms (buffer-sharing) [313.276762] Starting subtest: buffer-sharing [313.721131] Subtest buffer-sharing: SUCCESS (0.446s) [314.546119] [079/156] (707s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [314.644537] Starting subtest: fbchdr-rgb101010-draw-pwrite [314.648730] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [314.743970] [080/156] (707s left) gem_readwrite (beyond-eob) [314.799567] Subtest beyond-EOB: SKIP (0.000s) [314.865126] [081/156] (707s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [314.967419] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [314.971645] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [315.053874] [082/156] (707s left) kms_psr (fbc-psr-cursor-blt) [315.153018] Starting subtest: fbc-psr-cursor-blt [315.155194] Starting dynamic subtest: eDP-1 [315.159214] Dynamic subtest eDP-1: SKIP (0.000s) [315.163304] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [315.226529] [083/156] (707s left) gem_exec_reloc (basic-scanout) [315.287675] Subtest basic-scanout: SKIP (0.000s) [315.359438] [084/156] (707s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [315.455723] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [319.310203] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.861s) [320.449301] [085/156] (702s left) kms_cursor_crc (cursor-alpha-transparent) [320.539733] Starting subtest: cursor-alpha-transparent [320.541902] Starting dynamic subtest: pipe-A-eDP-1 [321.179094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s) [321.189203] Starting dynamic subtest: pipe-D-eDP-1 [322.458680] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s) [322.461025] Subtest cursor-alpha-transparent: SUCCESS (1.920s) [323.325406] [086/156] (699s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [323.422462] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [327.909592] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.494s) [329.134660] [087/156] (693s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff) [329.237571] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff [329.241740] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [329.339070] [088/156] (693s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [329.435983] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [329.440256] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [329.532965] [089/156] (693s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [329.636451] Starting subtest: fbc-pr-cursor-plane-update-sf [329.640649] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [329.713306] [090/156] (693s left) sw_sync (sync_multi_timeline_wait) [329.752309] Starting subtest: sync_multi_timeline_wait [329.754197] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [329.827669] [091/156] (693s left) perf (invalid-oa-metric-set-id) [329.943048] Starting subtest: invalid-oa-metric-set-id [329.953825] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s) [330.000811] [092/156] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [330.097718] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [330.101426] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [330.191363] [093/156] (692s left) gem_exec_schedule (lateslice) [330.253045] Starting subtest: lateslice [330.254718] Starting dynamic subtest: rcs0 [330.265153] Dynamic subtest rcs0: SUCCESS (0.020s) [330.275869] Starting dynamic subtest: bcs0 [330.283543] Dynamic subtest bcs0: SUCCESS (0.017s) [330.292766] Starting dynamic subtest: vcs0 [330.301026] Dynamic subtest vcs0: SUCCESS (0.017s) [330.310215] Starting dynamic subtest: vcs1 [330.318313] Dynamic subtest vcs1: SUCCESS (0.017s) [330.327609] Starting dynamic subtest: vecs0 [330.334827] Dynamic subtest vecs0: SUCCESS (0.016s) [330.344128] Starting dynamic subtest: ccs0 [330.352058] Dynamic subtest ccs0: SUCCESS (0.016s) [330.354059] Subtest lateslice: SUCCESS (0.107s) [332.340503] [094/156] (690s left) kms_atomic_interruptible (universal-setplane-primary) [332.436753] Starting subtest: universal-setplane-primary [332.438933] Starting dynamic subtest: pipe-A-eDP-1 [339.823071] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s) [339.825388] Subtest universal-setplane-primary: SUCCESS (7.390s) [340.687366] [095/156] (682s left) gem_exec_balancer (hog) [340.745358] Starting subtest: hog [340.749688] Subtest hog: SKIP (0.000s) [341.049977] [096/156] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [341.147140] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [341.151813] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [341.227168] [097/156] (682s left) gem_partial_pwrite_pread (writes-after-reads) [341.279767] Subtest writes-after-reads: SKIP (0.000s) [341.342924] [098/156] (681s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [341.441667] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [341.446044] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [341.535473] [099/156] (681s left) gem_exec_whisper (basic-contexts-forked) [341.596547] Starting subtest: basic-contexts-forked [364.856669] Subtest basic-contexts-forked: SUCCESS (23.256s) [365.042159] [100/156] (658s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [365.145678] Starting subtest: ccs-on-another-bo-y-tiled-ccs [365.148001] Starting dynamic subtest: pipe-A-eDP-1 [365.170668] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [365.182287] Starting dynamic subtest: pipe-B-eDP-1 [365.203965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [365.213963] Starting dynamic subtest: pipe-C-eDP-1 [365.235288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [365.244763] Starting dynamic subtest: pipe-D-eDP-1 [365.267232] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [365.271722] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [367.432064] [101/156] (656s left) api_intel_allocator (simple-allocator) [367.494780] Starting subtest: simple-allocator [367.497226] Starting dynamic subtest: basic [367.499333] Dynamic subtest basic: SUCCESS (0.004s) [367.516278] Starting dynamic subtest: parallel-one [367.680502] Dynamic subtest parallel-one: SUCCESS (0.184s) [367.691587] Starting dynamic subtest: print [367.693764] Dynamic subtest print: SUCCESS (0.000s) [367.703911] Starting dynamic subtest: reuse [367.705816] Dynamic subtest reuse: SUCCESS (0.000s) [367.715384] Starting dynamic subtest: reserve [367.717305] Dynamic subtest reserve: SUCCESS (0.000s) [367.727263] Starting dynamic subtest: fork-reopen-allocator [367.729207] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [367.731250] Subtest simple-allocator: SUCCESS (0.206s) [367.827504] [102/156] (655s left) kms_chamelium_hpd (dp-hpd-storm-disable) [368.217877] Subtest dp-hpd-storm-disable: SKIP (0.000s) [369.039284] [103/156] (654s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [369.142022] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [369.144091] Starting dynamic subtest: pipe-A-eDP-1 [369.886603] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s) [369.897968] Starting dynamic subtest: pipe-B-eDP-1 [371.693057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.804s) [371.704829] Starting dynamic subtest: pipe-C-eDP-1 [373.522078] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.828s) [373.533301] Starting dynamic subtest: pipe-D-eDP-1 [375.351590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s) [375.353909] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.202s) [376.500881] [104/156] (647s left) gem_lmem_swapping (verify-ccs) [376.543482] Subtest verify-ccs: SKIP (0.000s) [376.584115] [105/156] (647s left) prime_vgem (basic-fence-mmap) [376.663545] Starting subtest: basic-fence-mmap [376.668578] Subtest basic-fence-mmap: SKIP (0.000s) [376.752469] [106/156] (646s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [376.850697] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [377.641764] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s) [377.805530] [107/156] (645s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [377.913867] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [377.918230] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [378.021885] [108/156] (645s left) kms_joiner (invalid-modeset-force-big-joiner) [378.126056] Starting subtest: invalid-modeset-force-big-joiner [378.130497] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [378.193868] [109/156] (645s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [378.288717] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [378.290977] Starting dynamic subtest: pipe-A-eDP-1 [378.316046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [378.328763] Starting dynamic subtest: pipe-B-eDP-1 [378.353366] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [378.363856] Starting dynamic subtest: pipe-C-eDP-1 [378.388626] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [378.398660] Starting dynamic subtest: pipe-D-eDP-1 [378.423227] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [378.427309] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [380.561909] [110/156] (643s left) kms_plane_multiple (tiling-4) [380.658449] Starting subtest: tiling-4 [380.660367] Starting dynamic subtest: pipe-A-eDP-1 [384.359972] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.701s) [384.371155] Starting dynamic subtest: pipe-B-eDP-1 [388.778453] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.416s) [388.789652] Starting dynamic subtest: pipe-C-eDP-1 [393.296966] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.518s) [393.307747] Starting dynamic subtest: pipe-D-eDP-1 [397.727251] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.431s) [397.729658] Subtest tiling-4: SUCCESS (17.071s) [398.545106] [111/156] (625s left) prime_vgem (fence-wait) [398.618788] Starting subtest: fence-wait [398.620620] Starting dynamic subtest: rcs0 [399.681284] Dynamic subtest rcs0: SUCCESS (1.060s) [399.697450] Starting dynamic subtest: bcs0 [400.736833] Dynamic subtest bcs0: SUCCESS (1.055s) [400.748692] Starting dynamic subtest: vcs0 [401.787352] Dynamic subtest vcs0: SUCCESS (1.048s) [401.799331] Starting dynamic subtest: vcs1 [402.827299] Dynamic subtest vcs1: SUCCESS (1.038s) [402.844119] Starting dynamic subtest: vecs0 [403.867754] Dynamic subtest vecs0: SUCCESS (1.038s) [403.881756] Starting dynamic subtest: ccs0 [404.916743] Dynamic subtest ccs0: SUCCESS (1.046s) [404.919618] Subtest fence-wait: SUCCESS (6.298s) [405.040674] [112/156] (618s left) perf (enable-disable) [405.132860] Starting subtest: enable-disable [405.135282] Starting dynamic subtest: 0-rcs0 [407.455809] Dynamic subtest 0-rcs0: SUCCESS (2.278s) [407.469382] Starting dynamic subtest: 1-vcs0 [411.922081] Dynamic subtest 1-vcs0: SUCCESS (4.459s) [411.924222] Subtest enable-disable: SUCCESS (6.739s) [411.966296] [113/156] (611s left) kms_flip (nonexisting-fb) [412.064692] Starting subtest: nonexisting-fb [412.066604] Starting dynamic subtest: A-eDP1 [413.226844] Dynamic subtest A-eDP1: SUCCESS (1.160s) [413.239077] Starting dynamic subtest: B-eDP1 [414.359614] Dynamic subtest B-eDP1: SUCCESS (1.132s) [414.373625] Starting dynamic subtest: C-eDP1 [415.504874] Dynamic subtest C-eDP1: SUCCESS (1.143s) [415.517313] Starting dynamic subtest: D-eDP1 [416.642610] Dynamic subtest D-eDP1: SUCCESS (1.137s) [416.645006] Subtest nonexisting-fb: SUCCESS (4.582s) [417.819852] [114/156] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [417.911654] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [417.915720] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [418.037474] [115/156] (605s left) gem_userptr_blits (input-checking) [418.101214] Starting subtest: input-checking [418.104114] Subtest input-checking: SUCCESS (0.000s) [418.226495] [116/156] (605s left) kms_cursor_legacy (cursor-vs-flip-toggle) [418.345977] Starting subtest: cursor-vs-flip-toggle [449.445718] Subtest cursor-vs-flip-toggle: SUCCESS (31.104s) [450.264060] [117/156] (573s left) gem_busy (extended) [450.469381] Starting subtest: extended [450.471946] Starting dynamic subtest: rcs0 [450.563691] Dynamic subtest rcs0: SUCCESS (0.095s) [450.577441] Starting dynamic subtest: bcs0 [450.604735] Dynamic subtest bcs0: SUCCESS (0.039s) [450.615826] Starting dynamic subtest: vcs0 [452.268312] Dynamic subtest vcs0: SUCCESS (1.659s) [452.280739] Starting dynamic subtest: vcs1 [454.251563] Dynamic subtest vcs1: SUCCESS (1.981s) [454.265139] Starting dynamic subtest: vecs0 [456.235897] Dynamic subtest vecs0: SUCCESS (1.981s) [456.249935] Starting dynamic subtest: ccs0 [456.280486] Dynamic subtest ccs0: SUCCESS (0.044s) [456.282733] Subtest extended: SUCCESS (5.814s) [456.542260] [118/156] (567s left) prime_mmap (test_refcounting) [456.592405] Starting subtest: test_refcounting [456.594290] Starting dynamic subtest: test_refcounting-smem [456.630589] Dynamic subtest test_refcounting-smem: SUCCESS (0.039s) [456.633098] Subtest test_refcounting: SUCCESS (0.040s) [456.757376] [119/156] (567s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [456.850459] Starting subtest: primary-y-tiled-reflect-x-180 [456.910331] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [457.012961] [120/156] (567s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [457.105783] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [457.110329] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [458.216943] [121/156] (566s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [458.317920] Starting subtest: psr-1p-pri-indfb-multidraw [481.136949] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.831s) [481.248056] [122/156] (543s left) kms_pm_dc (dc5-psr) [482.344083] Starting subtest: dc5-psr [485.213382] Subtest dc5-psr: SUCCESS (2.868s) [486.054567] [123/156] (538s left) i915_pm_rpm (gem-idle) [487.577042] Starting subtest: gem-idle [493.802727] Subtest gem-idle: SUCCESS (6.205s) [494.129607] [124/156] (530s left) gem_render_copy_redux (interruptible) [495.249293] Starting subtest: interruptible [495.525722] Subtest interruptible: SUCCESS (0.277s) [495.661067] [125/156] (528s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [495.762435] Starting subtest: fbcpsrhdr-rgb101010-draw-render [495.766654] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [495.853770] [126/156] (528s left) sw_sync (timeline_closed) [495.887145] Starting subtest: timeline_closed [495.889537] Subtest timeline_closed: SUCCESS (0.000s) [495.936760] [127/156] (528s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [496.036844] Starting subtest: plane-lut1d-ctm3x4-lut1d [496.160563] Starting dynamic subtest: pipe-A-plane-0 [496.350713] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [496.361430] Starting dynamic subtest: pipe-A-plane-1 [496.526667] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s) [496.540083] Starting dynamic subtest: pipe-A-plane-2 [496.682515] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [497.924686] Starting dynamic subtest: pipe-B-plane-0 [498.108153] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s) [498.120579] Starting dynamic subtest: pipe-B-plane-1 [498.294318] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [498.305729] Starting dynamic subtest: pipe-B-plane-2 [498.472214] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s) [499.645967] Starting dynamic subtest: pipe-C-plane-0 [499.802894] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [499.813603] Starting dynamic subtest: pipe-C-plane-1 [499.946998] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [499.958254] Starting dynamic subtest: pipe-C-plane-2 [500.115278] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [501.308344] Starting dynamic subtest: pipe-D-plane-0 [501.452926] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [501.463828] Starting dynamic subtest: pipe-D-plane-1 [501.608813] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [501.619926] Starting dynamic subtest: pipe-D-plane-2 [501.778606] Dynamic subtest pipe-D-plane-2: SUCCESS (0.167s) [502.064268] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.027s) [502.950381] [128/156] (521s left) kms_psr (fbc-pr-cursor-plane-move) [503.046595] Starting subtest: fbc-pr-cursor-plane-move [503.050812] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [503.121720] [129/156] (521s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [503.230339] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [510.337399] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.112s) [510.479678] [130/156] (514s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [510.544881] Starting subtest: etime-multi-wait-all-for-submit-submitted [510.647815] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [510.723967] [131/156] (513s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [510.785762] Starting subtest: yf-tiled-ccs-to-y-tiled [510.790555] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [510.972727] [132/156] (513s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt) [511.070348] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt [511.074471] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [511.151617] [133/156] (513s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [511.275220] Starting subtest: cursorB-vs-flipB-toggle [511.279657] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [511.420706] [134/156] (513s left) drm_mm (drm_mm) [511.462270] Starting subtest: drm_mm [511.503569] Starting dynamic subtest: drm_test_mm_init [511.613709] Dynamic subtest drm_test_mm_init: SUCCESS (0.110s) [511.625876] Starting dynamic subtest: drm_test_mm_debug [511.704896] Dynamic subtest drm_test_mm_debug: SUCCESS (0.089s) [511.717567] Starting dynamic subtest: drm_test_mm_align32 [511.808715] Dynamic subtest drm_test_mm_align32: SUCCESS (0.102s) [511.819756] Starting dynamic subtest: drm_test_mm_align64 [511.906833] Dynamic subtest drm_test_mm_align64: SUCCESS (0.096s) [511.917196] Starting dynamic subtest: drm_test_mm_lowest [512.006404] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.097s) [512.018678] Starting dynamic subtest: drm_test_mm_highest [512.107830] Dynamic subtest drm_test_mm_highest: SUCCESS (0.102s) [512.110152] Subtest drm_mm: SUCCESS (0.646s) [512.268281] [135/156] (512s left) perf_pmu (busy-check-all) [512.305099] Starting subtest: busy-check-all [512.307425] Starting dynamic subtest: rcs0 [512.857342] Dynamic subtest rcs0: SUCCESS (0.551s) [512.874595] Starting dynamic subtest: bcs0 [513.408386] Dynamic subtest bcs0: SUCCESS (0.549s) [513.423458] Starting dynamic subtest: vcs0 [515.243087] Dynamic subtest vcs0: SUCCESS (1.830s) [515.258342] Starting dynamic subtest: vcs1 [517.228587] Dynamic subtest vcs1: SUCCESS (1.981s) [517.241717] Starting dynamic subtest: vecs0 [519.275933] Dynamic subtest vecs0: SUCCESS (2.043s) [519.289156] Starting dynamic subtest: ccs0 [519.830940] Dynamic subtest ccs0: SUCCESS (0.554s) [519.833412] Subtest busy-check-all: SUCCESS (7.526s) [519.929416] [136/156] (505s left) kms_flip (2x-flip-vs-dpms-on-nop) [520.025692] Starting subtest: 2x-flip-vs-dpms-on-nop [520.034795] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [520.115880] [137/156] (504s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [520.200474] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [520.202787] Starting dynamic subtest: pipe-A-default-mode [522.925665] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s) [522.927986] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.727s) [523.795579] [138/156] (501s left) gem_exec_suspend (basic-s3-devices) [523.860780] Starting subtest: basic-S3-devices [523.863226] Starting dynamic subtest: smem [535.211422] Dynamic subtest smem: SUCCESS (11.347s) [535.214493] Subtest basic-S3-devices: SUCCESS (11.349s) [535.401022] [139/156] (489s left) gem_ctx_persistence (engines-mixed) [535.465202] Starting subtest: engines-mixed [535.467648] Starting dynamic subtest: rcs0 [535.545448] Dynamic subtest rcs0: SUCCESS (0.080s) [535.561185] Starting dynamic subtest: bcs0 [535.604462] Dynamic subtest bcs0: SUCCESS (0.058s) [535.616757] Starting dynamic subtest: vcs0 [535.659210] Dynamic subtest vcs0: SUCCESS (0.053s) [535.671434] Starting dynamic subtest: vcs1 [535.711228] Dynamic subtest vcs1: SUCCESS (0.050s) [535.724102] Starting dynamic subtest: vecs0 [535.767237] Dynamic subtest vecs0: SUCCESS (0.055s) [535.779575] Starting dynamic subtest: ccs0 [535.828289] Dynamic subtest ccs0: SUCCESS (0.060s) [535.831093] Subtest engines-mixed: SUCCESS (0.364s) [535.910924] [140/156] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [536.020997] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [536.025006] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [536.130124] [141/156] (489s left) kms_cursor_crc (cursor-sliding-128x42) [536.338986] Starting subtest: cursor-sliding-128x42 [536.387359] Subtest cursor-sliding-128x42: SKIP (0.043s) [536.592942] [142/156] (488s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [536.699404] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [541.133121] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.437s) [542.289433] [143/156] (482s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [542.389722] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [542.394095] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [542.499670] [144/156] (482s left) syncobj_wait (reset-during-wait-for-submit) [542.553035] Starting subtest: reset-during-wait-for-submit [542.657042] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [542.746405] [145/156] (482s left) kms_lease (lease-invalid-plane) [542.834003] Starting subtest: lease-invalid-plane [542.836323] Starting dynamic subtest: pipe-A-eDP-1 [542.838698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [542.850672] Starting dynamic subtest: pipe-B-eDP-1 [542.852641] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [542.863037] Starting dynamic subtest: pipe-C-eDP-1 [542.865373] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [542.875951] Starting dynamic subtest: pipe-D-eDP-1 [542.878230] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [542.880546] Subtest lease-invalid-plane: SUCCESS (0.004s) [542.918875] [146/156] (482s left) kms_flip (basic-plain-flip) [543.005319] Starting subtest: basic-plain-flip [543.007805] Starting dynamic subtest: A-eDP1 [544.684823] Dynamic subtest A-eDP1: SUCCESS (1.679s) [544.698837] Starting dynamic subtest: B-eDP1 [546.411356] Dynamic subtest B-eDP1: SUCCESS (1.724s) [546.424588] Starting dynamic subtest: C-eDP1 [548.134236] Dynamic subtest C-eDP1: SUCCESS (1.720s) [548.149959] Starting dynamic subtest: D-eDP1 [549.771279] Dynamic subtest D-eDP1: SUCCESS (1.634s) [549.773989] Subtest basic-plain-flip: SUCCESS (6.771s) [550.949740] [147/156] (474s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [551.050161] Starting subtest: hdr-2p-primscrn-spr-indfb-move [551.054484] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [551.150332] [148/156] (474s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [551.200482] Starting subtest: invalid-multi-wait-all-unsubmitted [551.202657] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [551.300771] [149/156] (474s left) gem_mmap_offset (clear-via-pagefault) [551.349688] Starting subtest: clear-via-pagefault [551.351662] Starting dynamic subtest: smem0 [585.966815] Dynamic subtest smem0: SUCCESS (34.615s) [585.969160] Subtest clear-via-pagefault: SUCCESS (34.616s) [586.098723] [150/156] (439s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [586.155896] Starting subtest: multi-wait-all-for-submit-available-signaled [586.158200] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [586.255114] [151/156] (439s left) kms_atomic_transition (plane-toggle-modeset-transition) [586.362273] Starting subtest: plane-toggle-modeset-transition [586.364684] Starting dynamic subtest: pipe-A-eDP-1 [599.128513] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.769s) [599.146728] Starting dynamic subtest: pipe-B-eDP-1 [611.523914] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.389s) [611.526595] Subtest plane-toggle-modeset-transition: SUCCESS (25.165s) [612.350139] [152/156] (413s left) gem_exec_fence (syncobj-import) [612.802492] Starting subtest: syncobj-import [612.805025] Subtest syncobj-import: SUCCESS (0.005s) [614.327057] [153/156] (411s left) kms_getfb (getfb2-handle-not-fb) [614.416402] Starting subtest: getfb2-handle-not-fb [614.418634] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [614.521562] [154/156] (411s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [614.616922] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [614.621261] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [614.739503] [155/156] (411s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [614.837498] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [614.841601] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [614.938947] [156/156] (410s left) prime_vgem (basic-write) [615.011438] Starting subtest: basic-write [615.018869] Subtest basic-write: SKIP (0.008s) [615.137862] 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.