[58.202514] Initializing watchdogs [58.202639] /dev/watchdog0 [58.219570] [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.223924] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.226365] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.228437] [001/156] (960s left) gem_ctx_engines (invalid-engines) [58.299861] Starting subtest: invalid-engines [58.313299] Subtest invalid-engines: SUCCESS (0.014s) [58.525449] [002/156] (960s left) gem_linear_blits (normal) [58.874260] Starting subtest: normal [63.391088] Subtest normal: SUCCESS (4.521s) [63.528196] [003/156] (955s left) kms_flip (nonblocking-read) [63.678709] Starting subtest: nonblocking-read [63.679470] Subtest nonblocking-read: SUCCESS (0.000s) [63.759742] [004/156] (955s left) gem_ctx_bad_destroy (invalid-ctx) [63.814400] Starting subtest: invalid-ctx [63.815491] Subtest invalid-ctx: SUCCESS (0.000s) [63.868887] [005/156] (954s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [63.955147] Starting subtest: psr2-cursor-plane-move-continuous-sf [63.956140] Starting dynamic subtest: pipe-A-eDP-1 [75.165151] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.212s) [75.172371] Starting dynamic subtest: pipe-B-eDP-1 [85.793699] Dynamic subtest pipe-B-eDP-1: SUCCESS (10.638s) [85.794701] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.854s) [86.670364] [006/156] (932s left) gem_exec_schedule (u-independent) [86.730600] Starting subtest: u-independent [86.731398] Starting dynamic subtest: rcs0 [88.356350] Dynamic subtest rcs0: SUCCESS (1.616s) [88.367354] Starting dynamic subtest: vcs0 [90.346437] Dynamic subtest vcs0: SUCCESS (1.998s) [90.356088] Starting dynamic subtest: vcs1 [92.342281] Dynamic subtest vcs1: SUCCESS (1.986s) [92.351264] Starting dynamic subtest: vecs0 [94.318903] Dynamic subtest vecs0: SUCCESS (1.976s) [94.328562] Starting dynamic subtest: ccs0 [96.355319] Dynamic subtest ccs0: SUCCESS (2.035s) [96.356742] Subtest u-independent: SUCCESS (9.615s) [96.648622] [007/156] (922s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render) [96.765410] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render [96.766954] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [96.862516] [008/156] (922s left) i915_hangman (engine-engine-hang) [96.922664] Starting subtest: engine-engine-hang [96.923736] Starting dynamic subtest: rcs0 [98.307376] Dynamic subtest rcs0: SUCCESS (1.374s) [98.318885] Starting dynamic subtest: bcs0 [100.288605] Dynamic subtest bcs0: SUCCESS (1.980s) [100.299712] Starting dynamic subtest: vcs0 [102.274044] Dynamic subtest vcs0: SUCCESS (1.984s) [102.283249] Starting dynamic subtest: vcs1 [104.321905] Dynamic subtest vcs1: SUCCESS (2.046s) [104.331343] Starting dynamic subtest: vecs0 [106.305673] Dynamic subtest vecs0: SUCCESS (1.982s) [106.315266] Starting dynamic subtest: ccs0 [108.290340] Dynamic subtest ccs0: SUCCESS (1.982s) [108.291724] Subtest engine-engine-hang: SUCCESS (11.358s) [108.412061] [009/156] (910s left) gem_lmem_swapping (massive-random) [108.447486] Subtest massive-random: SKIP (0.000s) [108.482802] [010/156] (910s left) gem_pwrite (basic-self) [108.525292] Subtest basic-self: SKIP (0.000s) [108.577082] [011/156] (910s left) i915_drm_fdinfo (isolation) [108.607825] Starting subtest: isolation [108.608838] Starting dynamic subtest: rcs0 [108.634293] Dynamic subtest rcs0: SKIP (0.025s) [108.642748] Starting dynamic subtest: bcs0 [108.644484] Dynamic subtest bcs0: SKIP (0.000s) [108.651318] Starting dynamic subtest: vcs0 [108.652968] Dynamic subtest vcs0: SKIP (0.000s) [108.659589] Starting dynamic subtest: vcs1 [108.661633] Dynamic subtest vcs1: SKIP (0.000s) [108.668648] Starting dynamic subtest: vecs0 [108.670412] Dynamic subtest vecs0: SKIP (0.000s) [108.677849] Starting dynamic subtest: ccs0 [108.679698] Dynamic subtest ccs0: SKIP (0.000s) [108.681465] Subtest isolation: SKIP (0.028s) [108.712682] [012/156] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [108.799568] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [108.801242] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [108.886160] [013/156] (910s left) vgem_basic (busy-fence) [108.989884] Starting subtest: busy-fence [108.991057] Subtest busy-fence: SUCCESS (0.000s) [109.038570] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [109.040190] [014/156] (910s left) gem_exec_nop (basic-series) [109.092849] Starting subtest: basic-series [125.349933] Subtest basic-series: SUCCESS (16.248s) [125.578811] [015/156] (893s left) kms_fb_coherency (memset-crc) [125.669115] Starting subtest: memset-crc [125.670058] Starting dynamic subtest: mmap-offset-wc [126.078278] Dynamic subtest mmap-offset-wc: SUCCESS (0.410s) [126.378657] Starting dynamic subtest: mmap-offset-uc [132.582113] Dynamic subtest mmap-offset-uc: SUCCESS (6.211s) [132.878288] Subtest memset-crc: SUCCESS (7.208s) [133.756208] [016/156] (885s left) kms_plane_scaling (planes-upscale-factor-0-25) [133.847355] Starting subtest: planes-upscale-factor-0-25 [133.848274] Starting dynamic subtest: pipe-A [133.909829] Dynamic subtest pipe-A: SUCCESS (0.063s) [133.919285] Starting dynamic subtest: pipe-B [135.090685] Dynamic subtest pipe-B: SUCCESS (1.180s) [135.100516] Starting dynamic subtest: pipe-C [136.216735] Dynamic subtest pipe-C: SUCCESS (1.125s) [136.225417] Starting dynamic subtest: pipe-D [137.349911] Dynamic subtest pipe-D: SUCCESS (1.133s) [137.351027] Subtest planes-upscale-factor-0-25: SUCCESS (3.503s) [138.515871] [017/156] (880s left) kms_big_fb (4-tiled-8bpp-rotate-0) [138.619077] Starting subtest: 4-tiled-8bpp-rotate-0 [139.855201] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.236s) [139.996477] [018/156] (879s left) gem_eio (create) [140.226143] Starting subtest: create [140.580896] Subtest create: SUCCESS (0.356s) [140.690982] [019/156] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [140.782037] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [140.783875] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [140.884583] [020/156] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt) [140.972725] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt [140.974505] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [141.060091] [021/156] (878s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [141.136944] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [141.138756] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [141.210925] [022/156] (878s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [141.300148] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [141.302482] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [141.366493] [023/156] (878s left) kms_vblank (ts-continuation-idle) [141.451113] Starting subtest: ts-continuation-idle [141.452046] Starting dynamic subtest: pipe-A-eDP-1 [141.858897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s) [141.869478] Starting dynamic subtest: pipe-D-eDP-1 [142.999813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [143.000868] Subtest ts-continuation-idle: SUCCESS (1.549s) [143.863446] [024/156] (875s left) kms_plane (plane-position-hole-dpms) [143.942894] Starting subtest: plane-position-hole-dpms [144.488326] Starting dynamic subtest: pipe-A-plane-1 [146.896987] Dynamic subtest pipe-A-plane-1: SUCCESS (2.408s) [146.904890] Starting dynamic subtest: pipe-A-plane-2 [149.378924] Dynamic subtest pipe-A-plane-2: SUCCESS (2.482s) [149.388435] Starting dynamic subtest: pipe-A-plane-3 [151.832873] Dynamic subtest pipe-A-plane-3: SUCCESS (2.452s) [151.841061] Starting dynamic subtest: pipe-A-plane-4 [154.311050] Dynamic subtest pipe-A-plane-4: SUCCESS (2.478s) [154.319016] Starting dynamic subtest: pipe-A-plane-5 [154.334993] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [155.562537] Starting dynamic subtest: pipe-B-plane-1 [157.996478] Dynamic subtest pipe-B-plane-1: SUCCESS (2.443s) [158.004678] Starting dynamic subtest: pipe-B-plane-2 [160.430351] Dynamic subtest pipe-B-plane-2: SUCCESS (2.432s) [160.437980] Starting dynamic subtest: pipe-B-plane-3 [162.788908] Dynamic subtest pipe-B-plane-3: SUCCESS (2.358s) [162.797100] Starting dynamic subtest: pipe-B-plane-4 [165.164873] Dynamic subtest pipe-B-plane-4: SUCCESS (2.375s) [165.172587] Starting dynamic subtest: pipe-B-plane-5 [165.190495] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [165.191603] Subtest plane-position-hole-dpms: SUCCESS (21.245s) [165.967611] [025/156] (853s left) kms_psr (pr-primary-mmap-cpu) [166.066535] Starting subtest: pr-primary-mmap-cpu [166.068430] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [166.130774] [026/156] (853s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [166.210155] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [166.211084] Starting dynamic subtest: pipe-A-eDP-1 [166.219405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [166.227248] Starting dynamic subtest: pipe-B-eDP-1 [166.235270] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [166.242985] Starting dynamic subtest: pipe-C-eDP-1 [166.251723] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [166.258972] Starting dynamic subtest: pipe-D-eDP-1 [166.265916] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [166.266757] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [168.550867] [027/156] (851s left) kms_cursor_crc (cursor-sliding-max-size) [168.870069] Starting subtest: cursor-sliding-max-size [168.872892] Subtest cursor-sliding-max-size: SKIP (0.000s) [168.980666] [028/156] (850s left) kms_prop_blob (blob-prop-lifetime) [169.028634] Starting subtest: blob-prop-lifetime [169.029796] Subtest blob-prop-lifetime: SUCCESS (0.001s) [169.131036] [029/156] (850s left) kms_vblank (query-forked) [169.215544] Starting subtest: query-forked [169.216514] Starting dynamic subtest: pipe-A-eDP-1 [171.028882] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s) [171.040265] Starting dynamic subtest: pipe-D-eDP-1 [173.542522] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.510s) [173.543415] Subtest query-forked: SUCCESS (4.327s) [174.395485] [030/156] (845s left) kms_flip (nonexisting-fb-interruptible) [174.492769] Starting subtest: nonexisting-fb-interruptible [174.494890] Starting dynamic subtest: A-eDP1 [175.691161] Dynamic subtest A-eDP1: SUCCESS (1.196s) [175.700077] Starting dynamic subtest: B-eDP1 [176.825616] Dynamic subtest B-eDP1: SUCCESS (1.134s) [176.834858] Starting dynamic subtest: C-eDP1 [177.950604] Dynamic subtest C-eDP1: SUCCESS (1.124s) [177.961351] Starting dynamic subtest: D-eDP1 [179.084281] Dynamic subtest D-eDP1: SUCCESS (1.132s) [179.086381] Subtest nonexisting-fb-interruptible: SUCCESS (4.593s) [180.249127] [031/156] (839s left) gem_userptr_blits (sd-probe) [180.307475] Starting subtest: sd-probe [180.308420] Subtest sd-probe: SUCCESS (0.000s) [180.413363] [032/156] (839s left) syncobj_wait (invalid-signal-illegal-handle) [180.458773] Starting subtest: invalid-signal-illegal-handle [180.459792] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [180.558061] [033/156] (839s left) gem_ctx_persistence (userptr) [180.614513] Starting subtest: userptr [180.829680] Subtest userptr: SUCCESS (0.215s) [180.913899] [034/156] (838s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [181.006929] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [187.963121] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.958s) [188.086087] [035/156] (831s left) kms_chamelium_edid (dp-edid-change-during-suspend) [188.468776] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [189.300833] [036/156] (830s left) kms_content_protection (dp-mst-lic-type-0) [189.434556] Starting subtest: dp-mst-lic-type-0 [189.436259] Subtest dp-mst-lic-type-0: SKIP (0.000s) [189.539120] [037/156] (830s left) gem_userptr_blits (sync-overlap) [189.592538] Starting subtest: sync-overlap [189.593469] Subtest sync-overlap: SUCCESS (0.000s) [189.700163] [038/156] (830s left) gem_mmap_gtt (medium-copy-xy) [189.745345] Subtest medium-copy-XY: SKIP (0.000s) [189.798383] [039/156] (830s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [189.882160] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [189.883863] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [189.971748] [040/156] (830s left) perf_pmu (init-wait) [190.009103] Starting subtest: init-wait [190.010342] Starting dynamic subtest: rcs0 [190.013092] Dynamic subtest rcs0: SUCCESS (0.002s) [190.023577] Starting dynamic subtest: bcs0 [190.024469] Dynamic subtest bcs0: SUCCESS (0.000s) [190.031936] Starting dynamic subtest: vcs0 [190.032877] Dynamic subtest vcs0: SUCCESS (0.001s) [190.040303] Starting dynamic subtest: vcs1 [190.041175] Dynamic subtest vcs1: SUCCESS (0.001s) [190.048445] Starting dynamic subtest: vecs0 [190.049488] Dynamic subtest vecs0: SUCCESS (0.000s) [190.056723] Starting dynamic subtest: ccs0 [190.057641] Dynamic subtest ccs0: SUCCESS (0.000s) [190.058559] Subtest init-wait: SUCCESS (0.008s) [190.116172] [041/156] (829s left) kms_flip (2x-nonexisting-fb) [190.202242] Starting subtest: 2x-nonexisting-fb [190.214099] Subtest 2x-nonexisting-fb: SKIP (0.011s) [190.313015] [042/156] (829s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [190.397345] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [190.399340] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [190.489817] [043/156] (829s left) gem_exec_balancer (parallel-out-fence) [190.757709] Starting subtest: parallel-out-fence [192.036105] Subtest parallel-out-fence: SUCCESS (1.279s) [192.129643] [044/156] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [192.222623] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [192.224351] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [192.297889] [045/156] (827s left) kms_big_fb (y-tiled-32bpp-rotate-90) [192.396551] Starting subtest: y-tiled-32bpp-rotate-90 [192.398581] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [192.508728] [046/156] (827s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [192.610059] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [192.611879] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [192.713330] [047/156] (827s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [192.806116] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [199.655413] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.847s) [199.775723] [048/156] (820s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [199.865986] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [199.867951] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [199.986068] [049/156] (820s left) kms_atomic (plane-invalid-params-fence) [200.082431] Starting subtest: plane-invalid-params-fence [200.083387] Starting dynamic subtest: pipe-A-eDP-1 [200.450280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s) [200.451215] Subtest plane-invalid-params-fence: SUCCESS (0.368s) [201.273865] [050/156] (819s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [201.390860] Starting subtest: 2x-flip-vs-cursor-atomic [201.393838] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [201.542142] [051/156] (818s left) gen9_exec_parse (bb-chained) [201.594946] Subtest bb-chained: SKIP (0.000s) [201.654949] [052/156] (818s left) kms_psr (psr2-sprite-plane-onoff) [201.745342] Starting subtest: psr2-sprite-plane-onoff [201.746298] Starting dynamic subtest: eDP-1 [203.500778] Dynamic subtest eDP-1: SUCCESS (1.754s) [203.501700] Subtest psr2-sprite-plane-onoff: SUCCESS (1.755s) [204.355330] [053/156] (816s left) kms_big_fb (x-tiled-64bpp-rotate-90) [204.449602] Starting subtest: x-tiled-64bpp-rotate-90 [204.470180] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [204.592245] [054/156] (815s left) gem_exec_params (rel-constants-invalid) [204.648473] Starting subtest: rel-constants-invalid [204.649600] Subtest rel-constants-invalid: SUCCESS (0.000s) [204.746062] [055/156] (815s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [204.837455] Starting subtest: blocking-absolute-wf_vblank-interruptible [204.839585] Starting dynamic subtest: A-eDP1 [213.548535] Dynamic subtest A-eDP1: SUCCESS (8.681s) [213.556950] Starting dynamic subtest: B-eDP1 [222.282384] Dynamic subtest B-eDP1: SUCCESS (8.729s) [222.292619] Starting dynamic subtest: C-eDP1 [231.010811] Dynamic subtest C-eDP1: SUCCESS (8.715s) [231.021275] Starting dynamic subtest: D-eDP1 [239.738999] Dynamic subtest D-eDP1: SUCCESS (8.725s) [239.740316] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.865s) [240.914581] [056/156] (779s left) kms_pwrite_crc (basic) [240.998622] Starting subtest: basic [241.690539] Subtest basic: SUCCESS (0.691s) [242.539128] [057/156] (778s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [242.597646] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [242.599321] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [242.772284] [058/156] (777s left) kms_psr (fbc-psr2-cursor-blt) [242.857855] Starting subtest: fbc-psr2-cursor-blt [242.859059] Starting dynamic subtest: eDP-1 [242.860895] Dynamic subtest eDP-1: SKIP (0.000s) [242.862600] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [242.957880] [059/156] (777s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [243.002447] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [243.003752] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [243.092623] [060/156] (777s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [243.198474] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [243.200211] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [243.287939] [061/156] (777s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [243.381149] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite [243.382676] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [243.475482] [062/156] (777s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [243.585614] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [243.588567] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [243.725126] [063/156] (777s left) i915_suspend (sysfs-reader) [243.771853] Starting subtest: sysfs-reader [262.783840] Subtest sysfs-reader: SUCCESS (3.632s) [269.844352] [064/156] (758s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [269.951414] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [269.953215] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [270.059954] [065/156] (757s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [270.102026] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [270.102949] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [270.197273] [066/156] (757s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt) [270.283140] Starting subtest: hdr-farfromfence-mmap-gtt [270.284898] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s) [270.381293] [067/156] (757s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [270.466256] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [270.467976] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [270.557589] [068/156] (757s left) kms_async_flips (async-flip-dpms) [270.653452] Starting subtest: async-flip-dpms [271.040282] Starting dynamic subtest: pipe-A-eDP-1 [274.952643] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.937s) [275.323456] Starting dynamic subtest: pipe-B-eDP-1 [278.206598] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.903s) [278.596971] Starting dynamic subtest: pipe-C-eDP-1 [281.472277] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.891s) [281.849995] Starting dynamic subtest: pipe-D-eDP-1 [284.736827] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.899s) [284.738416] Subtest async-flip-dpms: SUCCESS (14.142s) [285.914464] [069/156] (742s left) kms_plane_cursor (overlay) [286.003642] Starting subtest: overlay [286.005591] Starting dynamic subtest: pipe-A-eDP-1-size-64 [288.564227] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s) [288.628252] Starting dynamic subtest: pipe-A-eDP-1-size-128 [291.173448] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s) [291.235431] Starting dynamic subtest: pipe-A-eDP-1-size-256 [293.828167] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s) [294.173243] Starting dynamic subtest: pipe-B-eDP-1-size-64 [297.557577] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.394s) [297.620147] Starting dynamic subtest: pipe-B-eDP-1-size-128 [300.213910] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s) [300.276405] Starting dynamic subtest: pipe-B-eDP-1-size-256 [302.837392] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s) [303.188098] Starting dynamic subtest: pipe-C-eDP-1-size-64 [306.095036] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.923s) [306.134296] Starting dynamic subtest: pipe-C-eDP-1-size-128 [308.383772] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.259s) [308.424020] Starting dynamic subtest: pipe-C-eDP-1-size-256 [310.671909] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s) [311.014533] Starting dynamic subtest: pipe-D-eDP-1-size-64 [313.923247] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.935s) [313.962446] Starting dynamic subtest: pipe-D-eDP-1-size-128 [316.167635] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [316.205643] Starting dynamic subtest: pipe-D-eDP-1-size-256 [318.444441] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.248s) [318.773885] Subtest overlay: SUCCESS (32.782s) [319.637835] [070/156] (708s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [319.732497] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [319.734339] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [319.852669] [071/156] (708s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [319.940064] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [319.941737] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [320.027703] [072/156] (708s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [320.153290] Starting subtest: modeset-atomic-cursor-hotspot [320.155076] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [320.308293] [073/156] (707s left) api_intel_bb (object-reloc-purge-cache) [320.365921] Starting subtest: object-reloc-purge-cache [320.368489] Subtest object-reloc-purge-cache: SKIP (0.003s) [320.479095] [074/156] (707s left) perf (gen8-unprivileged-single-ctx-counters) [320.605421] Starting subtest: gen8-unprivileged-single-ctx-counters [320.607105] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [320.644465] [075/156] (707s left) syncobj_timeline (wait-any-complex) [320.689289] Starting subtest: wait-any-complex [320.751421] Subtest wait-any-complex: SUCCESS (0.062s) [320.833349] [076/156] (707s left) gem_spin_batch (spin-all-new) [320.894615] Starting subtest: spin-all-new [320.907136] Subtest spin-all-new: SUCCESS (0.014s) [322.703561] [077/156] (705s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [322.798023] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [323.434883] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s) [323.614333] [078/156] (704s left) prime_mmap_kms (buffer-sharing) [323.698478] Starting subtest: buffer-sharing [324.158489] Subtest buffer-sharing: SUCCESS (0.459s) [324.971844] [079/156] (703s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [325.062590] Starting subtest: fbchdr-rgb101010-draw-pwrite [325.064343] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [325.145219] [080/156] (703s left) gem_readwrite (beyond-eob) [325.201943] Subtest beyond-EOB: SKIP (0.000s) [325.262756] [081/156] (703s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [325.344493] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [325.346543] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [325.452931] [082/156] (703s left) kms_psr (fbc-psr-cursor-blt) [325.546627] Starting subtest: fbc-psr-cursor-blt [325.547702] Starting dynamic subtest: eDP-1 [325.549677] Dynamic subtest eDP-1: SKIP (0.000s) [325.551707] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [325.616259] [083/156] (702s left) gem_exec_reloc (basic-scanout) [325.670530] Subtest basic-scanout: SKIP (0.000s) [325.734553] [084/156] (702s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [325.830618] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [329.791025] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.963s) [330.986326] [085/156] (697s left) kms_cursor_crc (cursor-alpha-transparent) [331.074274] Starting subtest: cursor-alpha-transparent [331.075199] Starting dynamic subtest: pipe-A-eDP-1 [331.696650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s) [331.706022] Starting dynamic subtest: pipe-D-eDP-1 [332.942332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s) [332.943331] Subtest cursor-alpha-transparent: SUCCESS (1.868s) [333.831770] [086/156] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [333.922321] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [338.527038] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.608s) [339.646543] [087/156] (689s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff) [339.738736] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff [339.740914] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [339.824034] [088/156] (688s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [339.920285] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [339.922320] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [340.003032] [089/156] (688s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [340.091399] Starting subtest: fbc-pr-cursor-plane-update-sf [340.101311] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [340.160981] [090/156] (688s left) sw_sync (sync_multi_timeline_wait) [340.191220] Starting subtest: sync_multi_timeline_wait [340.192103] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [340.260142] [091/156] (688s left) perf (invalid-oa-metric-set-id) [340.347752] Starting subtest: invalid-oa-metric-set-id [340.361988] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s) [340.405180] [092/156] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [340.495357] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [340.496904] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [340.589384] [093/156] (688s left) gem_exec_schedule (lateslice) [340.646186] Starting subtest: lateslice [340.646966] Starting dynamic subtest: rcs0 [340.667175] Dynamic subtest rcs0: SUCCESS (0.022s) [340.676266] Starting dynamic subtest: bcs0 [340.688605] Dynamic subtest bcs0: SUCCESS (0.020s) [340.697347] Starting dynamic subtest: vcs0 [340.707757] Dynamic subtest vcs0: SUCCESS (0.018s) [340.716959] Starting dynamic subtest: vcs1 [340.727665] Dynamic subtest vcs1: SUCCESS (0.020s) [340.736655] Starting dynamic subtest: vecs0 [340.749324] Dynamic subtest vecs0: SUCCESS (0.020s) [340.758521] Starting dynamic subtest: ccs0 [340.769830] Dynamic subtest ccs0: SUCCESS (0.020s) [340.770621] Subtest lateslice: SUCCESS (0.125s) [342.765078] [094/156] (686s left) kms_atomic_interruptible (universal-setplane-primary) [342.858582] Starting subtest: universal-setplane-primary [342.859625] Starting dynamic subtest: pipe-A-eDP-1 [350.241145] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s) [350.242078] Subtest universal-setplane-primary: SUCCESS (7.385s) [351.083359] [095/156] (677s left) gem_exec_balancer (hog) [351.144438] Starting subtest: hog [351.146245] Subtest hog: SKIP (0.000s) [351.442696] [096/156] (677s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [351.543874] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [351.545448] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [351.639689] [097/156] (677s left) gem_partial_pwrite_pread (writes-after-reads) [351.692436] Subtest writes-after-reads: SKIP (0.000s) [351.751385] [098/156] (677s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [351.837587] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [351.839116] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [351.924733] [099/156] (677s left) gem_exec_whisper (basic-contexts-forked) [351.987191] Starting subtest: basic-contexts-forked [375.376015] Subtest basic-contexts-forked: SUCCESS (23.370s) [375.543229] [100/156] (653s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [375.649351] Starting subtest: ccs-on-another-bo-y-tiled-ccs [375.650198] Starting dynamic subtest: pipe-A-eDP-1 [375.659587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [375.670712] Starting dynamic subtest: pipe-B-eDP-1 [375.679523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [375.693677] Starting dynamic subtest: pipe-C-eDP-1 [375.702015] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [375.712653] Starting dynamic subtest: pipe-D-eDP-1 [375.721430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [375.723031] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [377.944402] [101/156] (651s left) api_intel_allocator (simple-allocator) [377.994275] Starting subtest: simple-allocator [377.995466] Starting dynamic subtest: basic [377.998105] Dynamic subtest basic: SUCCESS (0.004s) [378.009028] Starting dynamic subtest: parallel-one [378.186418] Dynamic subtest parallel-one: SUCCESS (0.178s) [378.196411] Starting dynamic subtest: print [378.197789] Dynamic subtest print: SUCCESS (0.000s) [378.207633] Starting dynamic subtest: reuse [378.208582] Dynamic subtest reuse: SUCCESS (0.000s) [378.218166] Starting dynamic subtest: reserve [378.218984] Dynamic subtest reserve: SUCCESS (0.000s) [378.228154] Starting dynamic subtest: fork-reopen-allocator [378.228927] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [378.229662] Subtest simple-allocator: SUCCESS (0.202s) [378.313207] [102/156] (650s left) kms_chamelium_hpd (dp-hpd-storm-disable) [378.695435] Subtest dp-hpd-storm-disable: SKIP (0.000s) [379.558150] [103/156] (649s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [379.645846] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [379.646810] Starting dynamic subtest: pipe-A-eDP-1 [380.401256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s) [380.412025] Starting dynamic subtest: pipe-B-eDP-1 [382.456482] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.053s) [382.467576] Starting dynamic subtest: pipe-C-eDP-1 [384.303891] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.846s) [384.314219] Starting dynamic subtest: pipe-D-eDP-1 [386.132933] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s) [386.133808] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.486s) [387.362052] [104/156] (641s left) gem_lmem_swapping (verify-ccs) [387.407331] Subtest verify-ccs: SKIP (0.000s) [387.443873] [105/156] (641s left) prime_vgem (basic-fence-mmap) [387.500332] Starting subtest: basic-fence-mmap [387.502122] Subtest basic-fence-mmap: SKIP (0.000s) [387.622411] [106/156] (641s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [387.713384] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [388.528347] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s) [388.700098] [107/156] (640s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [388.795859] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [388.797819] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [388.899131] [108/156] (640s left) kms_joiner (invalid-modeset-force-big-joiner) [388.990661] Starting subtest: invalid-modeset-force-big-joiner [388.992298] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [389.087540] [109/156] (640s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [389.170768] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [389.172905] Starting dynamic subtest: pipe-A-eDP-1 [389.182409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [389.192488] Starting dynamic subtest: pipe-B-eDP-1 [389.202182] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [389.211986] Starting dynamic subtest: pipe-C-eDP-1 [389.221045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [389.230552] Starting dynamic subtest: pipe-D-eDP-1 [389.239659] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [389.241397] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s) [391.492590] [110/156] (638s left) kms_plane_multiple (tiling-4) [391.577360] Starting subtest: tiling-4 [391.578264] Starting dynamic subtest: pipe-A-eDP-1 [395.330252] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.752s) [395.343282] Starting dynamic subtest: pipe-B-eDP-1 [399.877526] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.546s) [399.887637] Starting dynamic subtest: pipe-C-eDP-1 [404.395618] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.518s) [404.406169] Starting dynamic subtest: pipe-D-eDP-1 [408.946669] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.542s) [408.948177] Subtest tiling-4: SUCCESS (17.363s) [409.766912] [111/156] (619s left) prime_vgem (fence-wait) [409.849213] Starting subtest: fence-wait [409.850033] Starting dynamic subtest: rcs0 [410.921063] Dynamic subtest rcs0: SUCCESS (1.063s) [410.935582] Starting dynamic subtest: bcs0 [411.990973] Dynamic subtest bcs0: SUCCESS (1.069s) [412.003036] Starting dynamic subtest: vcs0 [413.035065] Dynamic subtest vcs0: SUCCESS (1.043s) [413.047401] Starting dynamic subtest: vcs1 [414.075909] Dynamic subtest vcs1: SUCCESS (1.040s) [414.087277] Starting dynamic subtest: vecs0 [415.117018] Dynamic subtest vecs0: SUCCESS (1.039s) [415.131205] Starting dynamic subtest: ccs0 [416.161286] Dynamic subtest ccs0: SUCCESS (1.042s) [416.162377] Subtest fence-wait: SUCCESS (6.305s) [416.291047] [112/156] (613s left) perf (enable-disable) [416.377804] Starting subtest: enable-disable [416.378930] Starting dynamic subtest: 0-rcs0 [418.712599] Dynamic subtest 0-rcs0: SUCCESS (2.289s) [418.725871] Starting dynamic subtest: 1-vcs0 [423.161627] Dynamic subtest 1-vcs0: SUCCESS (4.494s) [423.162873] Subtest enable-disable: SUCCESS (6.785s) [423.209790] [113/156] (606s left) kms_flip (nonexisting-fb) [423.297697] Starting subtest: nonexisting-fb [423.300276] Starting dynamic subtest: A-eDP1 [424.457216] Dynamic subtest A-eDP1: SUCCESS (1.158s) [424.469563] Starting dynamic subtest: B-eDP1 [425.592318] Dynamic subtest B-eDP1: SUCCESS (1.134s) [425.605012] Starting dynamic subtest: C-eDP1 [426.729511] Dynamic subtest C-eDP1: SUCCESS (1.134s) [426.741695] Starting dynamic subtest: D-eDP1 [427.864947] Dynamic subtest D-eDP1: SUCCESS (1.133s) [427.867685] Subtest nonexisting-fb: SUCCESS (4.571s) [429.043943] [114/156] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [429.139909] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [429.141540] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [429.231531] [115/156] (600s left) gem_userptr_blits (input-checking) [429.281839] Starting subtest: input-checking [429.282758] Subtest input-checking: SUCCESS (0.000s) [429.417341] [116/156] (600s left) kms_cursor_legacy (cursor-vs-flip-toggle) [429.527658] Starting subtest: cursor-vs-flip-toggle [460.914148] Subtest cursor-vs-flip-toggle: SUCCESS (31.393s) [461.763944] [117/156] (568s left) gem_busy (extended) [461.956148] Starting subtest: extended [461.957056] Starting dynamic subtest: rcs0 [462.040461] Dynamic subtest rcs0: SUCCESS (0.090s) [462.056999] Starting dynamic subtest: bcs0 [462.082073] Dynamic subtest bcs0: SUCCESS (0.040s) [462.094524] Starting dynamic subtest: vcs0 [463.734113] Dynamic subtest vcs0: SUCCESS (1.641s) [463.746603] Starting dynamic subtest: vcs1 [465.716381] Dynamic subtest vcs1: SUCCESS (1.980s) [465.729848] Starting dynamic subtest: vecs0 [467.701500] Dynamic subtest vecs0: SUCCESS (1.983s) [467.712557] Starting dynamic subtest: ccs0 [467.738699] Dynamic subtest ccs0: SUCCESS (0.044s) [467.739763] Subtest extended: SUCCESS (5.791s) [467.978247] [118/156] (561s left) prime_mmap (test_refcounting) [468.037123] Starting subtest: test_refcounting [468.038010] Starting dynamic subtest: test_refcounting-smem [468.067983] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s) [468.069414] Subtest test_refcounting: SUCCESS (0.033s) [468.185451] [119/156] (561s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [468.282999] Starting subtest: primary-y-tiled-reflect-x-180 [468.344597] Subtest primary-y-tiled-reflect-x-180: SKIP (0.061s) [468.454350] [120/156] (561s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [468.533750] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [468.535660] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [469.687895] [121/156] (560s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [469.783785] Starting subtest: psr-1p-pri-indfb-multidraw [493.072513] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.293s) [493.183992] [122/156] (536s left) kms_pm_dc (dc5-psr) [494.286554] Starting subtest: dc5-psr [497.156708] Subtest dc5-psr: SUCCESS (2.869s) [498.040925] [123/156] (532s left) i915_pm_rpm (gem-idle) [499.866970] Starting subtest: gem-idle [506.068323] Subtest gem-idle: SUCCESS (6.201s) [506.406698] [124/156] (523s left) gem_render_copy_redux (interruptible) [507.669949] Starting subtest: interruptible [507.928339] Subtest interruptible: SUCCESS (0.260s) [508.030283] [125/156] (522s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [508.117507] Starting subtest: fbcpsrhdr-rgb101010-draw-render [508.119431] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [508.211682] [126/156] (521s left) sw_sync (timeline_closed) [508.241134] Starting subtest: timeline_closed [508.242058] Subtest timeline_closed: SUCCESS (0.000s) [508.297746] [127/156] (521s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [508.379424] Starting subtest: plane-lut1d-ctm3x4-lut1d [508.527518] Starting dynamic subtest: pipe-A-plane-0 [508.704830] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [508.715609] Starting dynamic subtest: pipe-A-plane-1 [508.893892] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [508.904339] Starting dynamic subtest: pipe-A-plane-2 [509.060834] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [510.343365] Starting dynamic subtest: pipe-B-plane-0 [510.510857] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [510.521512] Starting dynamic subtest: pipe-B-plane-1 [510.677474] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [510.688308] Starting dynamic subtest: pipe-B-plane-2 [510.844399] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [512.063960] Starting dynamic subtest: pipe-C-plane-0 [512.221057] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [512.237379] Starting dynamic subtest: pipe-C-plane-1 [512.387743] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [512.398151] Starting dynamic subtest: pipe-C-plane-2 [512.543374] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [513.794861] Starting dynamic subtest: pipe-D-plane-0 [513.952013] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [513.962324] Starting dynamic subtest: pipe-D-plane-1 [514.118799] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [514.130035] Starting dynamic subtest: pipe-D-plane-2 [514.274457] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [514.562780] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.181s) [515.360869] [128/156] (514s left) kms_psr (fbc-pr-cursor-plane-move) [515.452655] Starting subtest: fbc-pr-cursor-plane-move [515.454534] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [515.524850] [129/156] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [515.615061] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [522.796589] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.182s) [522.942265] [130/156] (507s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [522.995247] Starting subtest: etime-multi-wait-all-for-submit-submitted [523.097040] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s) [523.187269] [131/156] (507s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [523.240645] Starting subtest: yf-tiled-ccs-to-y-tiled [523.242522] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [523.419674] [132/156] (506s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt) [523.508283] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt [523.509920] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [523.598508] [133/156] (506s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [523.715030] Starting subtest: cursorB-vs-flipB-toggle [523.716702] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [523.856967] [134/156] (506s left) drm_mm (drm_mm) [523.891677] Starting subtest: drm_mm [523.936188] Starting dynamic subtest: drm_test_mm_init [524.018905] Dynamic subtest drm_test_mm_init: SUCCESS (0.083s) [524.030274] Starting dynamic subtest: drm_test_mm_debug [524.110144] Dynamic subtest drm_test_mm_debug: SUCCESS (0.090s) [524.121340] Starting dynamic subtest: drm_test_mm_align32 [524.194009] Dynamic subtest drm_test_mm_align32: SUCCESS (0.084s) [524.205793] Starting dynamic subtest: drm_test_mm_align64 [524.289789] Dynamic subtest drm_test_mm_align64: SUCCESS (0.094s) [524.300925] Starting dynamic subtest: drm_test_mm_lowest [524.377594] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.086s) [524.388477] Starting dynamic subtest: drm_test_mm_highest [524.469543] Dynamic subtest drm_test_mm_highest: SUCCESS (0.091s) [524.470520] Subtest drm_mm: SUCCESS (0.577s) [524.610678] [135/156] (505s left) perf_pmu (busy-check-all) [524.654429] Starting subtest: busy-check-all [524.655276] Starting dynamic subtest: rcs0 [525.205427] Dynamic subtest rcs0: SUCCESS (0.551s) [525.220568] Starting dynamic subtest: bcs0 [525.757504] Dynamic subtest bcs0: SUCCESS (0.550s) [525.770422] Starting dynamic subtest: vcs0 [527.734495] Dynamic subtest vcs0: SUCCESS (1.966s) [527.747579] Starting dynamic subtest: vcs1 [529.717898] Dynamic subtest vcs1: SUCCESS (1.980s) [529.728887] Starting dynamic subtest: vecs0 [531.702690] Dynamic subtest vecs0: SUCCESS (1.981s) [531.714487] Starting dynamic subtest: ccs0 [532.249468] Dynamic subtest ccs0: SUCCESS (0.554s) [532.250588] Subtest busy-check-all: SUCCESS (7.596s) [532.349911] [136/156] (498s left) kms_flip (2x-flip-vs-dpms-on-nop) [532.451199] Starting subtest: 2x-flip-vs-dpms-on-nop [532.461708] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [532.550130] [137/156] (498s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [532.640713] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [532.641627] Starting dynamic subtest: pipe-A-default-mode [535.355903] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s) [535.356964] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.715s) [536.213261] [138/156] (494s left) gem_exec_suspend (basic-s3-devices) [536.278020] Starting subtest: basic-S3-devices [536.279001] Starting dynamic subtest: smem [547.702332] Dynamic subtest smem: SUCCESS (11.415s) [547.703598] Subtest basic-S3-devices: SUCCESS (11.417s) [552.936120] [139/156] (482s left) gem_ctx_persistence (engines-mixed) [552.995343] Starting subtest: engines-mixed [552.996794] Starting dynamic subtest: rcs0 [553.053143] Dynamic subtest rcs0: SUCCESS (0.058s) [553.063145] Starting dynamic subtest: bcs0 [553.137493] Dynamic subtest bcs0: SUCCESS (0.083s) [553.151457] Starting dynamic subtest: vcs0 [553.193435] Dynamic subtest vcs0: SUCCESS (0.054s) [553.209071] Starting dynamic subtest: vcs1 [553.248760] Dynamic subtest vcs1: SUCCESS (0.053s) [553.261288] Starting dynamic subtest: vecs0 [553.307545] Dynamic subtest vecs0: SUCCESS (0.057s) [553.321632] Starting dynamic subtest: ccs0 [553.366321] Dynamic subtest ccs0: SUCCESS (0.056s) [553.367551] Subtest engines-mixed: SUCCESS (0.372s) [553.466891] [140/156] (482s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [553.560998] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [553.563856] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [553.660798] [141/156] (482s left) kms_cursor_crc (cursor-sliding-128x42) [553.901927] Starting subtest: cursor-sliding-128x42 [553.948991] Subtest cursor-sliding-128x42: SKIP (0.045s) [554.138530] [142/156] (481s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [554.230977] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [558.777236] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.548s) [559.999209] [143/156] (475s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [560.097167] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [560.099038] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [560.213252] [144/156] (475s left) syncobj_wait (reset-during-wait-for-submit) [560.269104] Starting subtest: reset-during-wait-for-submit [560.371614] Subtest reset-during-wait-for-submit: SUCCESS (0.102s) [560.460486] [145/156] (475s left) kms_lease (lease-invalid-plane) [560.555540] Starting subtest: lease-invalid-plane [560.556504] Starting dynamic subtest: pipe-A-eDP-1 [560.557448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [560.567640] Starting dynamic subtest: pipe-B-eDP-1 [560.568573] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [560.578605] Starting dynamic subtest: pipe-C-eDP-1 [560.579504] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [560.589078] Starting dynamic subtest: pipe-D-eDP-1 [560.590057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [560.590995] Subtest lease-invalid-plane: SUCCESS (0.004s) [560.627870] [146/156] (475s left) kms_flip (basic-plain-flip) [560.717729] Starting subtest: basic-plain-flip [560.718605] Starting dynamic subtest: A-eDP1 [562.404973] Dynamic subtest A-eDP1: SUCCESS (1.687s) [562.418985] Starting dynamic subtest: B-eDP1 [564.048725] Dynamic subtest B-eDP1: SUCCESS (1.642s) [564.062227] Starting dynamic subtest: C-eDP1 [565.775679] Dynamic subtest C-eDP1: SUCCESS (1.724s) [565.789318] Starting dynamic subtest: D-eDP1 [567.416383] Dynamic subtest D-eDP1: SUCCESS (1.640s) [567.419424] Subtest basic-plain-flip: SUCCESS (6.702s) [568.585896] [147/156] (467s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [568.686283] Starting subtest: hdr-2p-primscrn-spr-indfb-move [568.687901] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [568.777313] [148/156] (467s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [568.834626] Starting subtest: invalid-multi-wait-all-unsubmitted [568.835603] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [568.928502] [149/156] (467s left) gem_mmap_offset (clear-via-pagefault) [568.971711] Starting subtest: clear-via-pagefault [568.972606] Starting dynamic subtest: smem0 [603.663564] Dynamic subtest smem0: SUCCESS (34.684s) [603.664574] Subtest clear-via-pagefault: SUCCESS (34.685s) [603.772047] [150/156] (432s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [603.814425] Starting subtest: multi-wait-all-for-submit-available-signaled [603.815518] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [603.906676] [151/156] (432s left) kms_atomic_transition (plane-toggle-modeset-transition) [604.000031] Starting subtest: plane-toggle-modeset-transition [604.000887] Starting dynamic subtest: pipe-A-eDP-1 [616.770538] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.768s) [616.782486] Starting dynamic subtest: pipe-B-eDP-1 [629.234840] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.465s) [629.238593] Subtest plane-toggle-modeset-transition: SUCCESS (25.239s) [630.060697] [152/156] (406s left) gem_exec_fence (syncobj-import) [630.504806] Starting subtest: syncobj-import [630.507337] Subtest syncobj-import: SUCCESS (0.005s) [631.811351] [153/156] (404s left) kms_getfb (getfb2-handle-not-fb) [631.899596] Starting subtest: getfb2-handle-not-fb [631.900578] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [632.005328] [154/156] (404s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [632.096642] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [632.098427] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [632.194058] [155/156] (404s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [632.288895] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [632.290803] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [632.399916] [156/156] (403s left) prime_vgem (basic-write) [632.461403] Starting subtest: basic-write [632.469170] Subtest basic-write: SKIP (0.007s) [632.557678] 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.