[57.857287] Initializing watchdogs [57.857386] /dev/watchdog0 [57.873251] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.877963] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.880336] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.883994] [001/156] (960s left) gem_ctx_engines (invalid-engines) [57.968160] Starting subtest: invalid-engines [57.982419] Subtest invalid-engines: SUCCESS (0.014s) [58.214868] [002/156] (960s left) gem_linear_blits (normal) [58.498527] Starting subtest: normal [63.115411] Subtest normal: SUCCESS (4.598s) [63.237367] [003/156] (955s left) kms_flip (nonblocking-read) [63.395288] Starting subtest: nonblocking-read [63.397281] Subtest nonblocking-read: SUCCESS (0.000s) [63.492657] [004/156] (955s left) gem_ctx_bad_destroy (invalid-ctx) [63.554704] Starting subtest: invalid-ctx [63.557035] Subtest invalid-ctx: SUCCESS (0.000s) [63.627367] [005/156] (954s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [63.717371] Starting subtest: psr2-cursor-plane-move-continuous-sf [63.719640] Starting dynamic subtest: pipe-A-eDP-1 [74.134220] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.404s) [74.143222] Starting dynamic subtest: pipe-B-eDP-1 [85.277409] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.138s) [85.279684] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.543s) [86.155871] [006/156] (932s left) gem_exec_schedule (u-independent) [86.236214] Starting subtest: u-independent [86.238166] Starting dynamic subtest: rcs0 [88.319544] Dynamic subtest rcs0: SUCCESS (2.090s) [88.330390] Starting dynamic subtest: vcs0 [90.312485] Dynamic subtest vcs0: SUCCESS (1.991s) [90.324558] Starting dynamic subtest: vcs1 [92.301027] Dynamic subtest vcs1: SUCCESS (1.988s) [92.312253] Starting dynamic subtest: vecs0 [94.270607] Dynamic subtest vecs0: SUCCESS (1.967s) [94.279874] Starting dynamic subtest: ccs0 [96.317578] Dynamic subtest ccs0: SUCCESS (2.046s) [96.320245] Subtest u-independent: SUCCESS (10.087s) [96.638635] [007/156] (921s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render) [96.771115] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render [96.775570] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [96.861309] [008/156] (921s left) i915_hangman (engine-engine-hang) [96.920312] Starting subtest: engine-engine-hang [96.922565] Starting dynamic subtest: rcs0 [98.272695] Dynamic subtest rcs0: SUCCESS (1.350s) [98.286466] Starting dynamic subtest: bcs0 [100.253139] Dynamic subtest bcs0: SUCCESS (1.979s) [100.264258] Starting dynamic subtest: vcs0 [102.236497] Dynamic subtest vcs0: SUCCESS (1.981s) [102.247493] Starting dynamic subtest: vcs1 [104.284786] Dynamic subtest vcs1: SUCCESS (2.046s) [104.297751] Starting dynamic subtest: vecs0 [106.268269] Dynamic subtest vecs0: SUCCESS (1.982s) [106.280941] Starting dynamic subtest: ccs0 [108.252421] Dynamic subtest ccs0: SUCCESS (1.982s) [108.255391] Subtest engine-engine-hang: SUCCESS (11.329s) [108.329894] [009/156] (910s left) gem_lmem_swapping (massive-random) [108.371711] Subtest massive-random: SKIP (0.000s) [108.410515] [010/156] (910s left) gem_pwrite (basic-self) [108.466520] Subtest basic-self: SKIP (0.000s) [108.532324] [011/156] (910s left) i915_drm_fdinfo (isolation) [108.572607] Starting subtest: isolation [108.574880] Starting dynamic subtest: rcs0 [108.613177] Dynamic subtest rcs0: SKIP (0.038s) [108.623346] Starting dynamic subtest: bcs0 [108.627481] Dynamic subtest bcs0: SKIP (0.001s) [108.635940] Starting dynamic subtest: vcs0 [108.640327] Dynamic subtest vcs0: SKIP (0.001s) [108.648678] Starting dynamic subtest: vcs1 [108.652778] Dynamic subtest vcs1: SKIP (0.000s) [108.660731] Starting dynamic subtest: vecs0 [108.664786] Dynamic subtest vecs0: SKIP (0.000s) [108.672960] Starting dynamic subtest: ccs0 [108.677114] Dynamic subtest ccs0: SKIP (0.000s) [108.681332] Subtest isolation: SKIP (0.043s) [108.717160] [012/156] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [108.812617] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [108.816780] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [108.904211] [013/156] (909s left) vgem_basic (busy-fence) [109.023511] Starting subtest: busy-fence [109.025778] Subtest busy-fence: SUCCESS (0.000s) [109.088466] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [109.091705] [014/156] (909s left) gem_exec_nop (basic-series) [109.163338] Starting subtest: basic-series [125.313818] Subtest basic-series: SUCCESS (16.155s) [125.539976] [015/156] (893s left) kms_fb_coherency (memset-crc) [125.634756] Starting subtest: memset-crc [125.636735] Starting dynamic subtest: mmap-offset-wc [126.064636] Dynamic subtest mmap-offset-wc: SUCCESS (0.430s) [126.370530] Starting dynamic subtest: mmap-offset-uc [132.355976] Dynamic subtest mmap-offset-uc: SUCCESS (5.994s) [132.649868] Subtest memset-crc: SUCCESS (7.015s) [133.530698] [016/156] (885s left) kms_plane_scaling (planes-upscale-factor-0-25) [133.625994] Starting subtest: planes-upscale-factor-0-25 [133.628383] Starting dynamic subtest: pipe-A [133.686511] Dynamic subtest pipe-A: SUCCESS (0.062s) [133.698219] Starting dynamic subtest: pipe-B [134.855714] Dynamic subtest pipe-B: SUCCESS (1.169s) [134.866943] Starting dynamic subtest: pipe-C [135.966772] Dynamic subtest pipe-C: SUCCESS (1.110s) [135.977511] Starting dynamic subtest: pipe-D [137.099740] Dynamic subtest pipe-D: SUCCESS (1.133s) [137.102197] Subtest planes-upscale-factor-0-25: SUCCESS (3.476s) [138.263505] [017/156] (880s left) kms_big_fb (4-tiled-8bpp-rotate-0) [138.368381] Starting subtest: 4-tiled-8bpp-rotate-0 [139.613629] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.247s) [139.751892] [018/156] (879s left) gem_eio (create) [139.993683] Starting subtest: create [140.345927] Subtest create: SUCCESS (0.353s) [140.475413] [019/156] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [140.571931] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [140.575763] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [140.675716] [020/156] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [140.771682] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [140.775035] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [140.871661] [021/156] (878s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [140.971979] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [140.975858] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [141.045665] [022/156] (878s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [141.142118] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [141.145783] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [141.211162] [023/156] (878s left) kms_vblank (ts-continuation-idle) [141.304401] Starting subtest: ts-continuation-idle [141.306353] Starting dynamic subtest: pipe-A-eDP-1 [141.704852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s) [141.719776] Starting dynamic subtest: pipe-D-eDP-1 [142.858186] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s) [142.860572] Subtest ts-continuation-idle: SUCCESS (1.554s) [143.736347] [024/156] (875s left) kms_plane (plane-position-hole-dpms) [143.825446] Starting subtest: plane-position-hole-dpms [144.366067] Starting dynamic subtest: pipe-A-plane-1 [146.735597] Dynamic subtest pipe-A-plane-1: SUCCESS (2.369s) [146.745881] Starting dynamic subtest: pipe-A-plane-2 [149.008438] Dynamic subtest pipe-A-plane-2: SUCCESS (2.272s) [149.017598] Starting dynamic subtest: pipe-A-plane-3 [151.377303] Dynamic subtest pipe-A-plane-3: SUCCESS (2.369s) [151.387094] Starting dynamic subtest: pipe-A-plane-4 [153.746714] Dynamic subtest pipe-A-plane-4: SUCCESS (2.370s) [153.757037] Starting dynamic subtest: pipe-A-plane-5 [153.777073] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s) [154.906038] Starting dynamic subtest: pipe-B-plane-1 [157.375912] Dynamic subtest pipe-B-plane-1: SUCCESS (2.476s) [157.387130] Starting dynamic subtest: pipe-B-plane-2 [159.819238] Dynamic subtest pipe-B-plane-2: SUCCESS (2.442s) [159.830247] Starting dynamic subtest: pipe-B-plane-3 [162.191892] Dynamic subtest pipe-B-plane-3: SUCCESS (2.374s) [162.201679] Starting dynamic subtest: pipe-B-plane-4 [164.551296] Dynamic subtest pipe-B-plane-4: SUCCESS (2.360s) [164.561283] Starting dynamic subtest: pipe-B-plane-5 [164.581186] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s) [164.583421] Subtest plane-position-hole-dpms: SUCCESS (20.756s) [165.374999] [025/156] (853s left) kms_psr (pr-primary-mmap-cpu) [165.474587] Starting subtest: pr-primary-mmap-cpu [165.478901] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [165.546670] [026/156] (853s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [165.630162] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [165.632534] Starting dynamic subtest: pipe-A-eDP-1 [165.653280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [165.664174] Starting dynamic subtest: pipe-B-eDP-1 [165.683277] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [165.691969] Starting dynamic subtest: pipe-C-eDP-1 [165.712149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [165.720798] Starting dynamic subtest: pipe-D-eDP-1 [165.740586] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [165.742540] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s) [167.928670] [027/156] (851s left) kms_cursor_crc (cursor-sliding-max-size) [168.264819] Starting subtest: cursor-sliding-max-size [168.271701] Subtest cursor-sliding-max-size: SKIP (0.000s) [168.413465] [028/156] (851s left) kms_prop_blob (blob-prop-lifetime) [168.470775] Starting subtest: blob-prop-lifetime [168.472630] Subtest blob-prop-lifetime: SUCCESS (0.001s) [168.587930] [029/156] (850s left) kms_vblank (query-forked) [168.684901] Starting subtest: query-forked [168.687213] Starting dynamic subtest: pipe-A-eDP-1 [170.509143] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s) [170.526239] Starting dynamic subtest: pipe-D-eDP-1 [173.061492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [173.063601] Subtest query-forked: SUCCESS (4.377s) [173.914594] [030/156] (845s left) kms_flip (nonexisting-fb-interruptible) [174.001512] Starting subtest: nonexisting-fb-interruptible [174.006067] Starting dynamic subtest: A-eDP1 [175.207595] Dynamic subtest A-eDP1: SUCCESS (1.203s) [175.223469] Starting dynamic subtest: B-eDP1 [176.341534] Dynamic subtest B-eDP1: SUCCESS (1.132s) [176.352064] Starting dynamic subtest: C-eDP1 [177.470622] Dynamic subtest C-eDP1: SUCCESS (1.128s) [177.482282] Starting dynamic subtest: D-eDP1 [178.592777] Dynamic subtest D-eDP1: SUCCESS (1.121s) [178.598095] Subtest nonexisting-fb-interruptible: SUCCESS (4.594s) [179.765638] [031/156] (839s left) gem_userptr_blits (sd-probe) [179.835790] Starting subtest: sd-probe [179.838595] Subtest sd-probe: SUCCESS (0.000s) [179.974368] [032/156] (839s left) syncobj_wait (invalid-signal-illegal-handle) [180.025799] Starting subtest: invalid-signal-illegal-handle [180.028006] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [180.128261] [033/156] (839s left) gem_ctx_persistence (userptr) [180.194938] Starting subtest: userptr [180.369828] Subtest userptr: SUCCESS (0.175s) [180.459697] [034/156] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [180.568988] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [187.670305] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (7.107s) [187.781788] [035/156] (831s left) kms_chamelium_edid (dp-edid-change-during-suspend) [188.175648] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [189.022188] [036/156] (830s left) kms_content_protection (dp-mst-lic-type-0) [189.172359] Starting subtest: dp-mst-lic-type-0 [189.176972] Subtest dp-mst-lic-type-0: SKIP (0.000s) [189.311820] [037/156] (830s left) gem_userptr_blits (sync-overlap) [189.371859] Starting subtest: sync-overlap [189.373716] Subtest sync-overlap: SUCCESS (0.000s) [189.503150] [038/156] (830s left) gem_mmap_gtt (medium-copy-xy) [189.548347] Subtest medium-copy-XY: SKIP (0.000s) [189.604300] [039/156] (830s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [189.706917] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [189.711309] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [189.787933] [040/156] (830s left) perf_pmu (init-wait) [189.829644] Starting subtest: init-wait [189.832660] Starting dynamic subtest: rcs0 [189.834863] Dynamic subtest rcs0: SUCCESS (0.002s) [189.844066] Starting dynamic subtest: bcs0 [189.845905] Dynamic subtest bcs0: SUCCESS (0.001s) [189.854264] Starting dynamic subtest: vcs0 [189.856075] Dynamic subtest vcs0: SUCCESS (0.001s) [189.864636] Starting dynamic subtest: vcs1 [189.866499] Dynamic subtest vcs1: SUCCESS (0.001s) [189.874866] Starting dynamic subtest: vecs0 [189.876676] Dynamic subtest vecs0: SUCCESS (0.001s) [189.885112] Starting dynamic subtest: ccs0 [189.886952] Dynamic subtest ccs0: SUCCESS (0.000s) [189.888788] Subtest init-wait: SUCCESS (0.008s) [189.966471] [041/156] (830s left) kms_flip (2x-nonexisting-fb) [190.064840] Starting subtest: 2x-nonexisting-fb [190.076386] Subtest 2x-nonexisting-fb: SKIP (0.011s) [190.176914] [042/156] (829s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [190.273813] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [190.277557] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [190.383488] [043/156] (829s left) gem_exec_balancer (parallel-out-fence) [190.661257] Starting subtest: parallel-out-fence [191.908135] Subtest parallel-out-fence: SUCCESS (1.246s) [192.014307] [044/156] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [192.132764] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [192.136914] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [192.220996] [045/156] (827s left) kms_big_fb (y-tiled-32bpp-rotate-90) [192.315463] Starting subtest: y-tiled-32bpp-rotate-90 [192.319830] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [192.422379] [046/156] (827s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [192.528329] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [192.532744] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [192.614753] [047/156] (827s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [192.703657] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [199.466971] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.767s) [199.591153] [048/156] (820s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [199.693884] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [199.698056] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [199.800011] [049/156] (820s left) kms_atomic (plane-invalid-params-fence) [199.895105] Starting subtest: plane-invalid-params-fence [199.897387] Starting dynamic subtest: pipe-A-eDP-1 [200.250529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s) [200.252826] Subtest plane-invalid-params-fence: SUCCESS (0.356s) [201.102832] [050/156] (819s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [201.219500] Starting subtest: 2x-flip-vs-cursor-atomic [201.225259] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [201.367178] [051/156] (819s left) gen9_exec_parse (bb-chained) [201.439243] Subtest bb-chained: SKIP (0.000s) [201.510628] [052/156] (818s left) kms_psr (psr2-sprite-plane-onoff) [201.603236] Starting subtest: psr2-sprite-plane-onoff [201.605475] Starting dynamic subtest: eDP-1 [203.329636] Dynamic subtest eDP-1: SUCCESS (1.726s) [203.332218] Subtest psr2-sprite-plane-onoff: SUCCESS (1.727s) [204.170489] [053/156] (816s left) kms_big_fb (x-tiled-64bpp-rotate-90) [204.265830] Starting subtest: x-tiled-64bpp-rotate-90 [204.285483] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [204.390400] [054/156] (816s left) gem_exec_params (rel-constants-invalid) [204.438216] Starting subtest: rel-constants-invalid [204.440516] Subtest rel-constants-invalid: SUCCESS (0.000s) [204.566584] [055/156] (816s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [204.671311] Starting subtest: blocking-absolute-wf_vblank-interruptible [204.673563] Starting dynamic subtest: A-eDP1 [213.442143] Dynamic subtest A-eDP1: SUCCESS (8.770s) [213.454168] Starting dynamic subtest: B-eDP1 [222.165704] Dynamic subtest B-eDP1: SUCCESS (8.722s) [222.178137] Starting dynamic subtest: C-eDP1 [230.883685] Dynamic subtest C-eDP1: SUCCESS (8.715s) [230.893531] Starting dynamic subtest: D-eDP1 [239.614334] Dynamic subtest D-eDP1: SUCCESS (8.730s) [239.619541] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.946s) [240.844032] [056/156] (779s left) kms_pwrite_crc (basic) [240.936856] Starting subtest: basic [241.659752] Subtest basic: SUCCESS (0.725s) [242.470642] [057/156] (778s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [242.531496] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [242.535686] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [242.715220] [058/156] (778s left) kms_psr (fbc-psr2-cursor-blt) [242.818644] Starting subtest: fbc-psr2-cursor-blt [242.820772] Starting dynamic subtest: eDP-1 [242.824731] Dynamic subtest eDP-1: SKIP (0.000s) [242.828727] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [242.894475] [059/156] (777s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [242.943719] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [242.945645] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [243.047622] [060/156] (777s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [243.139661] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [243.144086] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [243.233489] [061/156] (777s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [243.333063] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite [243.337599] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [243.416366] [062/156] (777s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [243.539283] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [243.543770] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [243.685518] [063/156] (777s left) i915_suspend (sysfs-reader) [243.732395] Starting subtest: sysfs-reader [262.157092] Subtest sysfs-reader: SUCCESS (3.265s) [262.208707] [064/156] (758s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [262.333170] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [262.336629] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [262.449594] [065/156] (758s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [262.506031] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [262.508119] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [262.596729] [066/156] (758s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt) [262.696064] Starting subtest: hdr-farfromfence-mmap-gtt [262.699581] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s) [262.807431] [067/156] (758s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [262.913129] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [262.916880] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [263.027775] [068/156] (758s left) kms_async_flips (async-flip-dpms) [263.124988] Starting subtest: async-flip-dpms [263.504526] Starting dynamic subtest: pipe-A-eDP-1 [267.388990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.855s) [267.776232] Starting dynamic subtest: pipe-B-eDP-1 [270.661728] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.882s) [271.055009] Starting dynamic subtest: pipe-C-eDP-1 [273.861341] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.803s) [274.250472] Starting dynamic subtest: pipe-D-eDP-1 [277.043814] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.801s) [277.046282] Subtest async-flip-dpms: SUCCESS (13.855s) [278.231370] [069/156] (742s left) kms_plane_cursor (overlay) [278.326982] Starting subtest: overlay [278.331520] Starting dynamic subtest: pipe-A-eDP-1-size-64 [280.917750] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.586s) [280.977999] Starting dynamic subtest: pipe-A-eDP-1-size-128 [283.634444] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.663s) [283.692134] Starting dynamic subtest: pipe-A-eDP-1-size-256 [286.313567] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.627s) [286.665047] Starting dynamic subtest: pipe-B-eDP-1-size-64 [289.982745] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.326s) [290.044575] Starting dynamic subtest: pipe-B-eDP-1-size-128 [292.629376] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s) [292.688225] Starting dynamic subtest: pipe-B-eDP-1-size-256 [295.319353] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.639s) [295.670767] Starting dynamic subtest: pipe-C-eDP-1-size-64 [298.600636] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.943s) [298.638690] Starting dynamic subtest: pipe-C-eDP-1-size-128 [300.856066] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.226s) [300.895279] Starting dynamic subtest: pipe-C-eDP-1-size-256 [303.156409] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.270s) [303.483328] Starting dynamic subtest: pipe-D-eDP-1-size-64 [306.463078] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.990s) [306.502092] Starting dynamic subtest: pipe-D-eDP-1-size-128 [308.718243] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s) [308.758962] Starting dynamic subtest: pipe-D-eDP-1-size-256 [311.052596] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.303s) [311.372961] Subtest overlay: SUCCESS (33.031s) [312.248640] [070/156] (708s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [312.348801] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [312.353022] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [312.452319] [071/156] (708s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [312.546828] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [312.551155] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [312.644241] [072/156] (708s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [312.763769] Starting subtest: modeset-atomic-cursor-hotspot [312.768394] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [312.910443] [073/156] (708s left) api_intel_bb (object-reloc-purge-cache) [312.965391] Starting subtest: object-reloc-purge-cache [312.969976] Subtest object-reloc-purge-cache: SKIP (0.003s) [313.098461] [074/156] (708s left) perf (gen8-unprivileged-single-ctx-counters) [313.241281] Starting subtest: gen8-unprivileged-single-ctx-counters [313.244788] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [313.287856] [075/156] (708s left) syncobj_timeline (wait-any-complex) [313.345326] Starting subtest: wait-any-complex [313.405384] Subtest wait-any-complex: SUCCESS (0.062s) [313.483345] [076/156] (708s left) gem_spin_batch (spin-all-new) [313.545353] Starting subtest: spin-all-new [313.559933] Subtest spin-all-new: SUCCESS (0.014s) [315.481169] [077/156] (706s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [315.591363] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [316.226796] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s) [316.400168] [078/156] (705s left) prime_mmap_kms (buffer-sharing) [316.492279] Starting subtest: buffer-sharing [316.925156] Subtest buffer-sharing: SUCCESS (0.433s) [317.775067] [079/156] (703s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [317.877551] Starting subtest: fbchdr-rgb101010-draw-pwrite [317.881854] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [317.977521] [080/156] (703s left) gem_readwrite (beyond-eob) [318.038377] Subtest beyond-EOB: SKIP (0.000s) [318.100260] [081/156] (703s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [318.202405] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [318.206635] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [318.303620] [082/156] (703s left) kms_psr (fbc-psr-cursor-blt) [318.394240] Starting subtest: fbc-psr-cursor-blt [318.396503] Starting dynamic subtest: eDP-1 [318.400562] Dynamic subtest eDP-1: SKIP (0.000s) [318.404698] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [318.471228] [083/156] (703s left) gem_exec_reloc (basic-scanout) [318.538833] Subtest basic-scanout: SKIP (0.000s) [318.612747] [084/156] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [318.714905] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [322.570586] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.858s) [323.717158] [085/156] (698s left) kms_cursor_crc (cursor-alpha-transparent) [323.819387] Starting subtest: cursor-alpha-transparent [323.821661] Starting dynamic subtest: pipe-A-eDP-1 [324.452779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s) [324.463855] Starting dynamic subtest: pipe-D-eDP-1 [325.792546] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s) [325.794983] Subtest cursor-alpha-transparent: SUCCESS (1.972s) [326.652036] [086/156] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [326.745647] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [331.305055] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.563s) [332.438508] [087/156] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff) [332.548597] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff [332.552559] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [332.672131] [088/156] (689s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [332.768068] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [332.772520] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [332.875633] [089/156] (689s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [332.974889] Starting subtest: fbc-pr-cursor-plane-update-sf [332.979171] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [333.048359] [090/156] (689s left) sw_sync (sync_multi_timeline_wait) [333.092093] Starting subtest: sync_multi_timeline_wait [333.094501] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [333.143019] [091/156] (688s left) perf (invalid-oa-metric-set-id) [333.236020] Starting subtest: invalid-oa-metric-set-id [333.245670] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s) [333.300603] [092/156] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [333.396202] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [333.399707] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [333.494152] [093/156] (688s left) gem_exec_schedule (lateslice) [333.557849] Starting subtest: lateslice [333.559479] Starting dynamic subtest: rcs0 [333.572745] Dynamic subtest rcs0: SUCCESS (0.022s) [333.583722] Starting dynamic subtest: bcs0 [333.590725] Dynamic subtest bcs0: SUCCESS (0.017s) [333.600756] Starting dynamic subtest: vcs0 [333.608497] Dynamic subtest vcs0: SUCCESS (0.017s) [333.618917] Starting dynamic subtest: vcs1 [333.626337] Dynamic subtest vcs1: SUCCESS (0.017s) [333.636666] Starting dynamic subtest: vecs0 [333.648511] Dynamic subtest vecs0: SUCCESS (0.021s) [333.658637] Starting dynamic subtest: ccs0 [333.665234] Dynamic subtest ccs0: SUCCESS (0.016s) [333.667081] Subtest lateslice: SUCCESS (0.115s) [335.553873] [094/156] (686s left) kms_atomic_interruptible (universal-setplane-primary) [335.648389] Starting subtest: universal-setplane-primary [335.650607] Starting dynamic subtest: pipe-A-eDP-1 [343.039406] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.386s) [343.041753] Subtest universal-setplane-primary: SUCCESS (7.388s) [343.877063] [095/156] (678s left) gem_exec_balancer (hog) [343.939972] Starting subtest: hog [343.944522] Subtest hog: SKIP (0.000s) [344.250481] [096/156] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [344.353037] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [344.356963] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [344.481591] [097/156] (677s left) gem_partial_pwrite_pread (writes-after-reads) [344.532666] Subtest writes-after-reads: SKIP (0.000s) [344.608514] [098/156] (677s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [344.716290] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [344.720449] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [344.823790] [099/156] (677s left) gem_exec_whisper (basic-contexts-forked) [344.892769] Starting subtest: basic-contexts-forked [369.812451] Subtest basic-contexts-forked: SUCCESS (24.915s) [369.996530] [100/156] (652s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [370.093981] Starting subtest: ccs-on-another-bo-y-tiled-ccs [370.096131] Starting dynamic subtest: pipe-A-eDP-1 [370.117744] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.129664] Starting dynamic subtest: pipe-B-eDP-1 [370.150383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.161693] Starting dynamic subtest: pipe-C-eDP-1 [370.182679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.193352] Starting dynamic subtest: pipe-D-eDP-1 [370.214330] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.218168] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [372.338778] [101/156] (650s left) api_intel_allocator (simple-allocator) [372.395724] Starting subtest: simple-allocator [372.398003] Starting dynamic subtest: basic [372.400411] Dynamic subtest basic: SUCCESS (0.004s) [372.414711] Starting dynamic subtest: parallel-one [372.589073] Dynamic subtest parallel-one: SUCCESS (0.189s) [372.602684] Starting dynamic subtest: print [372.604837] Dynamic subtest print: SUCCESS (0.000s) [372.616042] Starting dynamic subtest: reuse [372.617979] Dynamic subtest reuse: SUCCESS (0.000s) [372.628726] Starting dynamic subtest: reserve [372.630667] Dynamic subtest reserve: SUCCESS (0.000s) [372.641226] Starting dynamic subtest: fork-reopen-allocator [372.643278] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [372.645161] Subtest simple-allocator: SUCCESS (0.214s) [372.722825] [102/156] (649s left) kms_chamelium_hpd (dp-hpd-storm-disable) [373.103497] Subtest dp-hpd-storm-disable: SKIP (0.000s) [373.945515] [103/156] (648s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [374.041862] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [374.043742] Starting dynamic subtest: pipe-A-eDP-1 [374.805125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s) [374.816926] Starting dynamic subtest: pipe-B-eDP-1 [376.609263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.802s) [376.623163] Starting dynamic subtest: pipe-C-eDP-1 [378.448950] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.839s) [378.461169] Starting dynamic subtest: pipe-D-eDP-1 [380.270536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.819s) [380.272429] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.221s) [381.401884] [104/156] (641s left) gem_lmem_swapping (verify-ccs) [381.445050] Subtest verify-ccs: SKIP (0.000s) [381.488958] [105/156] (641s left) prime_vgem (basic-fence-mmap) [381.550233] Starting subtest: basic-fence-mmap [381.554575] Subtest basic-fence-mmap: SKIP (0.000s) [381.673180] [106/156] (641s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [381.770207] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [382.583284] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s) [382.756772] [107/156] (640s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [382.856283] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [382.860512] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [382.968960] [108/156] (639s left) kms_joiner (invalid-modeset-force-big-joiner) [383.070811] Starting subtest: invalid-modeset-force-big-joiner [383.075027] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [383.153764] [109/156] (639s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [383.255489] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [383.257792] Starting dynamic subtest: pipe-A-eDP-1 [383.282487] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [383.295733] Starting dynamic subtest: pipe-B-eDP-1 [383.319631] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [383.331111] Starting dynamic subtest: pipe-C-eDP-1 [383.355040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [383.366006] Starting dynamic subtest: pipe-D-eDP-1 [383.391913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [383.396286] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [385.572394] [110/156] (637s left) kms_plane_multiple (tiling-4) [385.672997] Starting subtest: tiling-4 [385.675319] Starting dynamic subtest: pipe-A-eDP-1 [389.502991] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.827s) [389.515023] Starting dynamic subtest: pipe-B-eDP-1 [394.160866] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.658s) [394.173190] Starting dynamic subtest: pipe-C-eDP-1 [398.602286] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.438s) [398.613971] Starting dynamic subtest: pipe-D-eDP-1 [403.119218] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.515s) [403.121462] Subtest tiling-4: SUCCESS (17.444s) [403.931328] [111/156] (619s left) prime_vgem (fence-wait) [404.018816] Starting subtest: fence-wait [404.021252] Starting dynamic subtest: rcs0 [405.103656] Dynamic subtest rcs0: SUCCESS (1.083s) [405.119275] Starting dynamic subtest: bcs0 [406.173830] Dynamic subtest bcs0: SUCCESS (1.069s) [406.187408] Starting dynamic subtest: vcs0 [407.218653] Dynamic subtest vcs0: SUCCESS (1.044s) [407.234168] Starting dynamic subtest: vcs1 [408.260552] Dynamic subtest vcs1: SUCCESS (1.040s) [408.274457] Starting dynamic subtest: vecs0 [409.303976] Dynamic subtest vecs0: SUCCESS (1.041s) [409.317379] Starting dynamic subtest: ccs0 [410.347922] Dynamic subtest ccs0: SUCCESS (1.042s) [410.350540] Subtest fence-wait: SUCCESS (6.328s) [410.477912] [112/156] (612s left) perf (enable-disable) [410.557840] Starting subtest: enable-disable [410.560047] Starting dynamic subtest: 0-rcs0 [412.852632] Dynamic subtest 0-rcs0: SUCCESS (2.293s) [412.865393] Starting dynamic subtest: 1-vcs1 [417.353614] Dynamic subtest 1-vcs1: SUCCESS (4.499s) [417.356300] Subtest enable-disable: SUCCESS (6.794s) [417.408055] [113/156] (605s left) kms_flip (nonexisting-fb) [417.502286] Starting subtest: nonexisting-fb [417.504577] Starting dynamic subtest: A-eDP1 [418.722016] Dynamic subtest A-eDP1: SUCCESS (1.218s) [418.733875] Starting dynamic subtest: B-eDP1 [419.844858] Dynamic subtest B-eDP1: SUCCESS (1.122s) [419.858421] Starting dynamic subtest: C-eDP1 [420.982197] Dynamic subtest C-eDP1: SUCCESS (1.136s) [420.994559] Starting dynamic subtest: D-eDP1 [422.133782] Dynamic subtest D-eDP1: SUCCESS (1.150s) [422.138986] Subtest nonexisting-fb: SUCCESS (4.635s) [423.325264] [114/156] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [423.431972] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [423.435898] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [423.549364] [115/156] (599s left) gem_userptr_blits (input-checking) [423.611563] Starting subtest: input-checking [423.613717] Subtest input-checking: SUCCESS (0.000s) [423.745869] [116/156] (599s left) kms_cursor_legacy (cursor-vs-flip-toggle) [423.865409] Starting subtest: cursor-vs-flip-toggle [455.157516] Subtest cursor-vs-flip-toggle: SUCCESS (31.283s) [456.054696] [117/156] (567s left) gem_busy (extended) [456.245431] Starting subtest: extended [456.247876] Starting dynamic subtest: rcs0 [456.337620] Dynamic subtest rcs0: SUCCESS (0.091s) [456.351100] Starting dynamic subtest: bcs0 [456.380665] Dynamic subtest bcs0: SUCCESS (0.041s) [456.396466] Starting dynamic subtest: vcs0 [458.416866] Dynamic subtest vcs0: SUCCESS (2.032s) [458.431089] Starting dynamic subtest: vcs1 [460.402658] Dynamic subtest vcs1: SUCCESS (1.981s) [460.416965] Starting dynamic subtest: vecs0 [462.448862] Dynamic subtest vecs0: SUCCESS (2.041s) [462.463272] Starting dynamic subtest: ccs0 [462.497154] Dynamic subtest ccs0: SUCCESS (0.046s) [462.499932] Subtest extended: SUCCESS (6.251s) [462.744786] [118/156] (560s left) prime_mmap (test_refcounting) [462.789379] Starting subtest: test_refcounting [462.791244] Starting dynamic subtest: test_refcounting-smem [462.821853] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s) [462.824051] Subtest test_refcounting: SUCCESS (0.034s) [462.937640] [119/156] (560s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [463.035595] Starting subtest: primary-y-tiled-reflect-x-180 [463.096145] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [463.201910] [120/156] (560s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [463.293511] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [463.298002] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [464.475174] [121/156] (559s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [464.576636] Starting subtest: psr-1p-pri-indfb-multidraw [487.909521] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.333s) [488.047422] [122/156] (535s left) kms_pm_dc (dc5-psr) [489.162170] Starting subtest: dc5-psr [492.045622] Subtest dc5-psr: SUCCESS (2.883s) [492.947608] [123/156] (530s left) i915_pm_rpm (gem-idle) [494.570556] Starting subtest: gem-idle [500.764122] Subtest gem-idle: SUCCESS (6.196s) [501.114899] [124/156] (522s left) gem_render_copy_redux (interruptible) [502.425631] Starting subtest: interruptible [502.704188] Subtest interruptible: SUCCESS (0.279s) [502.821378] [125/156] (520s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [502.918782] Starting subtest: fbcpsrhdr-rgb101010-draw-render [502.922957] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [503.012058] [126/156] (520s left) sw_sync (timeline_closed) [503.052591] Starting subtest: timeline_closed [503.054776] Subtest timeline_closed: SUCCESS (0.000s) [503.107602] [127/156] (520s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [503.202936] Starting subtest: plane-lut1d-ctm3x4-lut1d [503.371216] Starting dynamic subtest: pipe-A-plane-0 [503.571266] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s) [503.582639] Starting dynamic subtest: pipe-A-plane-1 [503.739166] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [503.754247] Starting dynamic subtest: pipe-A-plane-2 [503.926969] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [505.120483] Starting dynamic subtest: pipe-B-plane-0 [505.310861] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [505.323079] Starting dynamic subtest: pipe-B-plane-1 [505.477065] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [505.489031] Starting dynamic subtest: pipe-B-plane-2 [505.633054] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [506.835649] Starting dynamic subtest: pipe-C-plane-0 [506.991500] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [507.003763] Starting dynamic subtest: pipe-C-plane-1 [507.147168] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [507.159151] Starting dynamic subtest: pipe-C-plane-2 [507.313546] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [508.550282] Starting dynamic subtest: pipe-D-plane-0 [508.706622] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [508.719297] Starting dynamic subtest: pipe-D-plane-1 [508.873471] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [508.886305] Starting dynamic subtest: pipe-D-plane-2 [509.040638] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [509.329266] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.128s) [510.223462] [128/156] (513s left) kms_psr (fbc-pr-cursor-plane-move) [510.323513] Starting subtest: fbc-pr-cursor-plane-move [510.327865] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [510.410161] [129/156] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [510.515859] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [517.842000] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.331s) [517.983668] [130/156] (505s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [518.054891] Starting subtest: etime-multi-wait-all-for-submit-submitted [518.156547] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s) [518.249197] [131/156] (505s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [518.317838] Starting subtest: yf-tiled-ccs-to-y-tiled [518.322407] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [518.515269] [132/156] (505s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt) [518.607399] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt [518.611467] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [518.709387] [133/156] (505s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [518.832482] Starting subtest: cursorB-vs-flipB-toggle [518.837279] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [518.982820] [134/156] (505s left) drm_mm (drm_mm) [519.016368] Starting subtest: drm_mm [519.046239] Starting dynamic subtest: drm_test_mm_init [519.145426] Dynamic subtest drm_test_mm_init: SUCCESS (0.099s) [519.157805] Starting dynamic subtest: drm_test_mm_debug [519.252857] Dynamic subtest drm_test_mm_debug: SUCCESS (0.107s) [519.268935] Starting dynamic subtest: drm_test_mm_align32 [519.360291] Dynamic subtest drm_test_mm_align32: SUCCESS (0.107s) [519.371580] Starting dynamic subtest: drm_test_mm_align64 [519.463943] Dynamic subtest drm_test_mm_align64: SUCCESS (0.104s) [519.475056] Starting dynamic subtest: drm_test_mm_lowest [519.587306] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.120s) [519.601437] Starting dynamic subtest: drm_test_mm_highest [519.678291] Dynamic subtest drm_test_mm_highest: SUCCESS (0.091s) [519.680307] Subtest drm_mm: SUCCESS (0.661s) [519.846304] [135/156] (504s left) perf_pmu (busy-check-all) [519.888062] Starting subtest: busy-check-all [519.890037] Starting dynamic subtest: rcs0 [520.449295] Dynamic subtest rcs0: SUCCESS (0.562s) [520.466681] Starting dynamic subtest: bcs0 [520.999189] Dynamic subtest bcs0: SUCCESS (0.548s) [521.015024] Starting dynamic subtest: vcs0 [522.417278] Dynamic subtest vcs0: SUCCESS (1.415s) [522.431003] Starting dynamic subtest: vcs1 [524.464705] Dynamic subtest vcs1: SUCCESS (2.044s) [524.479548] Starting dynamic subtest: vecs0 [526.449493] Dynamic subtest vecs0: SUCCESS (1.982s) [526.462233] Starting dynamic subtest: ccs0 [527.005405] Dynamic subtest ccs0: SUCCESS (0.554s) [527.007822] Subtest busy-check-all: SUCCESS (7.121s) [527.114926] [136/156] (497s left) kms_flip (2x-flip-vs-dpms-on-nop) [527.207487] Starting subtest: 2x-flip-vs-dpms-on-nop [527.216583] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [527.348134] [137/156] (496s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [527.443963] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [527.446233] Starting dynamic subtest: pipe-A-default-mode [530.227197] Dynamic subtest pipe-A-default-mode: SUCCESS (2.784s) [530.229566] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.786s) [531.061200] [138/156] (493s left) gem_exec_suspend (basic-s3-devices) [531.128312] Starting subtest: basic-S3-devices [531.130610] Starting dynamic subtest: smem [542.449544] Dynamic subtest smem: SUCCESS (11.319s) [542.452511] Subtest basic-S3-devices: SUCCESS (11.321s) [542.665501] [139/156] (481s left) gem_ctx_persistence (engines-mixed) [542.728827] Starting subtest: engines-mixed [542.730793] Starting dynamic subtest: rcs0 [542.787898] Dynamic subtest rcs0: SUCCESS (0.062s) [542.804429] Starting dynamic subtest: bcs0 [542.837909] Dynamic subtest bcs0: SUCCESS (0.048s) [542.850825] Starting dynamic subtest: vcs0 [542.889400] Dynamic subtest vcs0: SUCCESS (0.049s) [542.901981] Starting dynamic subtest: vcs1 [542.940799] Dynamic subtest vcs1: SUCCESS (0.050s) [542.954745] Starting dynamic subtest: vecs0 [542.989974] Dynamic subtest vecs0: SUCCESS (0.048s) [543.002071] Starting dynamic subtest: ccs0 [543.057279] Dynamic subtest ccs0: SUCCESS (0.065s) [543.060131] Subtest engines-mixed: SUCCESS (0.332s) [543.142435] [140/156] (481s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [543.246723] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [543.250926] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [543.357341] [141/156] (481s left) kms_cursor_crc (cursor-sliding-128x42) [543.578375] Starting subtest: cursor-sliding-128x42 [543.626542] Subtest cursor-sliding-128x42: SKIP (0.046s) [543.813818] [142/156] (480s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [543.916816] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [548.455112] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.541s) [549.703490] [143/156] (474s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [549.799010] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [549.803399] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [549.907251] [144/156] (474s left) syncobj_wait (reset-during-wait-for-submit) [549.966808] Starting subtest: reset-during-wait-for-submit [550.068554] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [550.149854] [145/156] (474s left) kms_lease (lease-invalid-plane) [550.250283] Starting subtest: lease-invalid-plane [550.252608] Starting dynamic subtest: pipe-A-eDP-1 [550.254918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [550.266784] Starting dynamic subtest: pipe-B-eDP-1 [550.269014] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [550.280887] Starting dynamic subtest: pipe-C-eDP-1 [550.283101] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [550.294877] Starting dynamic subtest: pipe-D-eDP-1 [550.296789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [550.299972] Subtest lease-invalid-plane: SUCCESS (0.004s) [550.339509] [146/156] (474s left) kms_flip (basic-plain-flip) [550.441292] Starting subtest: basic-plain-flip [550.443636] Starting dynamic subtest: A-eDP1 [552.171456] Dynamic subtest A-eDP1: SUCCESS (1.731s) [552.183894] Starting dynamic subtest: B-eDP1 [553.908181] Dynamic subtest B-eDP1: SUCCESS (1.734s) [553.922123] Starting dynamic subtest: C-eDP1 [555.628247] Dynamic subtest C-eDP1: SUCCESS (1.718s) [555.641441] Starting dynamic subtest: D-eDP1 [557.251033] Dynamic subtest D-eDP1: SUCCESS (1.621s) [557.257179] Subtest basic-plain-flip: SUCCESS (6.818s) [558.427990] [147/156] (466s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [558.528275] Starting subtest: hdr-2p-primscrn-spr-indfb-move [558.532486] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [558.634778] [148/156] (466s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [558.682124] Starting subtest: invalid-multi-wait-all-unsubmitted [558.684273] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [558.788378] [149/156] (465s left) gem_mmap_offset (clear-via-pagefault) [558.832353] Starting subtest: clear-via-pagefault [558.834645] Starting dynamic subtest: smem0 [592.621501] [150/156] (432s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [592.769745] Starting subtest: multi-wait-all-for-submit-available-signaled [592.772033] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [592.878280] [151/156] (431s left) kms_atomic_transition (plane-toggle-modeset-transition) [592.990025] Starting subtest: plane-toggle-modeset-transition [592.992169] Starting dynamic subtest: pipe-A-eDP-1 [605.765718] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.773s) [605.781185] Starting dynamic subtest: pipe-B-eDP-1 [618.203603] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.430s) [618.206195] Subtest plane-toggle-modeset-transition: SUCCESS (25.210s) [619.033446] [152/156] (405s left) gem_exec_fence (syncobj-import) [619.454908] Starting subtest: syncobj-import [619.460843] Subtest syncobj-import: SUCCESS (0.005s) [620.550170] [153/156] (404s left) kms_getfb (getfb2-handle-not-fb) [620.638184] Starting subtest: getfb2-handle-not-fb [620.640527] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [620.755662] [154/156] (404s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [620.849836] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [620.854032] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [620.958561] [155/156] (404s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [621.061200] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [621.065645] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [621.166672] [156/156] (403s left) prime_vgem (basic-write) [621.257859] Starting subtest: basic-write [621.267539] Subtest basic-write: SKIP (0.008s) [621.385956] 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.