[43.957404] Initializing watchdogs [43.957482] /dev/watchdog0 [43.964229] [001/131] (960s left) kms_getfb (getfb-handle-protection) [44.001860] Starting subtest: getfb-handle-protection [44.024848] Subtest getfb-handle-protection: SUCCESS (0.023s) [44.108541] [002/131] (960s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [44.207811] Starting subtest: plane-scaler-unity-scaling-with-rotation [44.208511] Starting dynamic subtest: pipe-A [45.371941] Dynamic subtest pipe-A: SKIP (1.163s) [45.376463] Starting dynamic subtest: pipe-B [46.650269] Dynamic subtest pipe-B: SKIP (1.278s) [46.654892] Starting dynamic subtest: pipe-C [47.931265] Dynamic subtest pipe-C: SKIP (1.279s) [47.936220] Starting dynamic subtest: pipe-D [49.167399] Dynamic subtest pipe-D: SKIP (1.236s) [49.168812] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (4.959s) [49.330408] [003/131] (955s left) kms_cursor_crc (cursor-rapid-movement-512x170) [49.441906] Starting subtest: cursor-rapid-movement-512x170 [49.443425] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [49.505714] [004/131] (955s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [49.651976] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [49.719336] [005/131] (954s left) kms_color (ctm-green-to-red) [49.821865] Starting subtest: ctm-green-to-red [49.822598] Starting dynamic subtest: pipe-A-HDMI-A-1 [50.094089] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.271s) [50.099866] Starting dynamic subtest: pipe-B-HDMI-A-1 [50.370919] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.276s) [50.376865] Starting dynamic subtest: pipe-C-HDMI-A-1 [50.649624] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.277s) [50.654136] Starting dynamic subtest: pipe-D-HDMI-A-1 [50.917368] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.266s) [50.918136] Subtest ctm-green-to-red: SUCCESS (1.095s) [51.028882] [006/131] (953s left) kms_properties (crtc-properties-legacy) [51.129602] Starting subtest: crtc-properties-legacy [51.130365] Starting dynamic subtest: pipe-A-HDMI-A-1 [51.306974] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.176s) [51.313284] Starting dynamic subtest: pipe-B-HDMI-A-1 [51.510574] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.201s) [51.516619] Starting dynamic subtest: pipe-C-HDMI-A-1 [51.722983] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.209s) [51.729019] Starting dynamic subtest: pipe-D-HDMI-A-1 [51.925998] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.201s) [51.926755] Subtest crtc-properties-legacy: SUCCESS (0.797s) [52.021603] [007/131] (952s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [52.116926] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [52.117643] Starting dynamic subtest: pipe-A-HDMI-A-1 [52.123839] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [52.128431] Starting dynamic subtest: pipe-B-HDMI-A-1 [52.135128] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [52.144885] Starting dynamic subtest: pipe-C-HDMI-A-1 [52.151100] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [52.155444] Starting dynamic subtest: pipe-D-HDMI-A-1 [52.161477] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [52.162180] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.012s) [52.333118] [008/131] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [52.434487] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [52.435892] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [52.492234] [009/131] (952s left) gem_mmap_gtt (cpuset-basic-small-copy) [52.531590] Starting subtest: cpuset-basic-small-copy [55.862109] Subtest cpuset-basic-small-copy: SUCCESS (3.331s) [55.901923] [010/131] (948s left) kms_big_fb (linear-64bpp-rotate-270) [56.047062] Starting subtest: linear-64bpp-rotate-270 [56.093331] Subtest linear-64bpp-rotate-270: SKIP (0.045s) [56.189636] [011/131] (948s left) kms_psr2_su (page_flip-xrgb8888) [56.233679] Subtest page_flip-XRGB8888: SKIP (0.000s) [56.252807] [012/131] (948s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [56.346095] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [56.347629] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [56.479896] [013/131] (948s left) syncobj_timeline (invalid-query-illegal-handle) [56.527459] Starting subtest: invalid-query-illegal-handle [56.528247] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [56.563094] [014/131] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [56.658957] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [57.925228] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.267s) [58.055369] [015/131] (946s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [58.099996] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [58.176792] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.065s) [58.205657] [016/131] (946s left) kms_psr (psr-basic) [58.306021] Subtest psr-basic: SKIP (0.000s) [58.325538] [017/131] (946s left) kms_addfb_basic (bad-pitch-63) [58.363569] Starting subtest: bad-pitch-63 [58.364380] Subtest bad-pitch-63: SUCCESS (0.000s) [58.488568] [018/131] (946s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [58.588036] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [58.589530] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [58.651767] [019/131] (946s left) kms_vrr (flip-dpms) [58.747114] Starting subtest: flip-dpms [58.749383] Subtest flip-dpms: SKIP (0.000s) [58.779438] [020/131] (946s left) syncobj_timeline (multi-wait-for-submit-signaled) [58.823110] Starting subtest: multi-wait-for-submit-signaled [58.823909] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [58.870686] [021/131] (945s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [58.966091] Starting subtest: primary-yf-tiled-reflect-x-270 [59.017952] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.051s) [59.081588] [022/131] (945s left) perf_pmu (busy-check-all) [59.130342] Starting subtest: busy-check-all [59.131220] Starting dynamic subtest: rcs0 [59.651360] Dynamic subtest rcs0: SUCCESS (0.520s) [59.661833] Starting dynamic subtest: bcs0 [60.177413] Dynamic subtest bcs0: SUCCESS (0.521s) [60.185513] Starting dynamic subtest: vcs0 [60.700301] Dynamic subtest vcs0: SUCCESS (0.523s) [60.709093] Starting dynamic subtest: vcs1 [61.224104] Dynamic subtest vcs1: SUCCESS (0.522s) [61.232891] Starting dynamic subtest: vecs0 [61.746271] Dynamic subtest vecs0: SUCCESS (0.519s) [61.747415] Subtest busy-check-all: SUCCESS (2.616s) [61.797374] [023/131] (943s left) gem_mmap_gtt (basic-small-bo-tiledy) [61.839091] Starting subtest: basic-small-bo-tiledY [61.914765] Subtest basic-small-bo-tiledY: SUCCESS (0.076s) [61.993061] [024/131] (942s left) i915_pm_rps (engine-order) [62.081269] Starting subtest: engine-order [65.724160] Subtest engine-order: SUCCESS (3.633s) [65.815289] [025/131] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [65.921187] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [65.922688] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [65.990092] [026/131] (938s left) kms_plane_cursor (overlay) [66.084421] Starting subtest: overlay [66.085940] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [67.392825] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.308s) [67.431262] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [68.760147] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.333s) [68.804306] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [70.260170] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.466s) [70.349468] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [71.834072] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.489s) [71.864510] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [73.375433] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.516s) [73.407049] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [74.875679] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.475s) [74.957272] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [76.460539] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.508s) [76.492355] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [77.952512] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.467s) [77.982589] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [79.452667] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.475s) [79.538453] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64 [81.047189] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.515s) [81.078770] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128 [82.539084] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.467s) [82.571178] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256 [84.031205] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.467s) [84.107220] Subtest overlay: SUCCESS (18.023s) [84.192614] [027/131] (920s left) i915_pm_freq_api (freq-reset) [84.235748] Subtest freq-reset: SKIP (0.000s) [84.253389] [028/131] (920s left) fbdev (read) [84.295444] Starting subtest: read [84.952139] Subtest read: SUCCESS (0.648s) [84.976435] [029/131] (919s left) kms_pm_rpm (modeset-lpsp) [86.401877] Starting subtest: modeset-lpsp [87.682376] Subtest modeset-lpsp: SUCCESS (1.281s) [87.777600] [030/131] (917s left) kms_psr (fbc-pr-sprite-mmap-gtt) [87.874263] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [87.898436] [031/131] (917s left) kms_psr (pr-basic) [87.989161] Subtest pr-basic: SKIP (0.000s) [88.010852] [032/131] (916s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [88.114372] Starting subtest: yf-tiled-addfb-size-offset-overflow [88.115838] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [88.180109] [033/131] (916s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [88.276063] Starting subtest: fbcpsr-rgb565-draw-render [88.277493] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s) [88.344516] [034/131] (916s left) gem_exec_create (forked) [88.394767] Starting subtest: forked [88.395555] Starting dynamic subtest: smem [108.486592] Dynamic subtest smem: SUCCESS (20.091s) [108.487384] Subtest forked: SUCCESS (20.092s) [108.652062] [035/131] (896s left) i915_suspend (fence-restore-tiled2untiled) [108.692893] Starting subtest: fence-restore-tiled2untiled [129.002407] Subtest fence-restore-tiled2untiled: SUCCESS (5.220s) [130.076139] [036/131] (891s left) kms_addfb_basic (unused-offsets) [130.123867] Starting subtest: unused-offsets [130.124653] Subtest unused-offsets: SUCCESS (0.000s) [130.251172] [037/131] (890s left) prime_mmap_coherency (write) [130.296396] Starting subtest: write [135.669986] Subtest write: SUCCESS (5.372s) [135.756299] [038/131] (885s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [135.855986] Starting subtest: x-tiled-addfb-size-offset-overflow [135.856765] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [135.916298] [039/131] (885s left) gem_huc_copy (huc-copy) [135.961225] Starting subtest: huc-copy [135.962711] Subtest huc-copy: SKIP (0.000s) [136.053268] [040/131] (885s left) perf (oa-formats) [136.165272] Starting subtest: oa-formats [136.166019] Starting dynamic subtest: 0-rcs0 [136.179120] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [136.179842] Subtest oa-formats: SUCCESS (0.015s) [136.200116] [041/131] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [136.296735] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [137.687071] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.391s) [137.792866] [042/131] (883s left) kms_big_fb (4-tiled-32bpp-rotate-180) [137.894179] Starting subtest: 4-tiled-32bpp-rotate-180 [137.895646] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [137.968394] [043/131] (883s left) gem_exec_reloc (basic-cpu-gtt-active) [138.016030] Starting subtest: basic-cpu-gtt-active [138.144313] Subtest basic-cpu-gtt-active: SUCCESS (0.119s) [138.234761] [044/131] (883s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [138.740209] Starting subtest: syncobj-timeline-multiple-ext-nodes [138.741240] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s) [138.888302] [045/131] (882s left) gem_mmap_offset (bad-extensions) [138.930358] Starting subtest: bad-extensions [138.931064] Subtest bad-extensions: SUCCESS (0.000s) [138.994748] [046/131] (882s left) gem_pxp (reject-modify-context-protection-off-3) [139.102370] Starting subtest: reject-modify-context-protection-off-3 [139.103538] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [140.202938] [047/131] (881s left) kms_concurrent (multi-plane-atomic-lowres) [140.299366] Starting subtest: multi-plane-atomic-lowres [140.301201] Starting dynamic subtest: pipe-A-HDMI-A-1 [140.684441] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.383s) [140.685147] Subtest multi-plane-atomic-lowres: SUCCESS (0.385s) [140.768985] [048/131] (880s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [140.862940] Starting subtest: bad-pixel-format-y-tiled-ccs [140.863684] Starting dynamic subtest: pipe-A-HDMI-A-1 [140.870686] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [140.878956] Starting dynamic subtest: pipe-B-HDMI-A-1 [140.886073] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [140.894648] Starting dynamic subtest: pipe-C-HDMI-A-1 [140.901755] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [140.909729] Starting dynamic subtest: pipe-D-HDMI-A-1 [140.916880] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [140.918303] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s) [141.099208] [049/131] (880s left) gem_softpin (allocator-basic) [141.138866] Starting subtest: allocator-basic [141.204565] Subtest allocator-basic: SUCCESS (0.065s) [141.307426] [050/131] (880s left) prime_mmap (test_forked) [141.349676] Starting subtest: test_forked [141.350429] Starting dynamic subtest: test_forked-smem [141.362987] Dynamic subtest test_forked-smem: SUCCESS (0.013s) [141.363847] Subtest test_forked: SUCCESS (0.014s) [141.438729] [051/131] (880s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [141.532486] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [141.534255] Starting dynamic subtest: pipe-A-valid-mode [141.596244] Dynamic subtest pipe-A-valid-mode: SKIP (0.057s) [141.597723] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.058s) [141.677752] [052/131] (879s left) gem_exec_balancer (full-late-pulse) [141.728676] Starting subtest: full-late-pulse [143.148391] Subtest full-late-pulse: SUCCESS (1.418s) [143.325661] [053/131] (878s left) gem_eio (wait-immediate) [143.374556] Starting subtest: wait-immediate [143.521748] Subtest wait-immediate: SUCCESS (0.145s) [143.620779] [054/131] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [143.715700] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [143.717223] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [143.796649] [055/131] (877s left) gem_exec_schedule (preempt-queue-contexts) [143.853575] Starting subtest: preempt-queue-contexts [143.854404] Starting dynamic subtest: rcs0 [144.130602] Dynamic subtest rcs0: SUCCESS (0.268s) [144.137942] Starting dynamic subtest: bcs0 [144.395787] Dynamic subtest bcs0: SUCCESS (0.264s) [144.402959] Starting dynamic subtest: vcs0 [144.658055] Dynamic subtest vcs0: SUCCESS (0.262s) [144.665661] Starting dynamic subtest: vcs1 [144.913571] Dynamic subtest vcs1: SUCCESS (0.255s) [144.920782] Starting dynamic subtest: vecs0 [145.177184] Dynamic subtest vecs0: SUCCESS (0.263s) [145.177950] Subtest preempt-queue-contexts: SUCCESS (1.316s) [145.456082] [056/131] (876s left) gem_eio (wait-wedge-1us) [145.503053] Starting subtest: wait-wedge-1us [145.763374] Subtest wait-wedge-1us: SUCCESS (0.260s) [145.863495] [057/131] (875s left) api_intel_bb (add-remove-objects) [145.902715] Starting subtest: add-remove-objects [145.908470] Subtest add-remove-objects: SUCCESS (0.006s) [145.991615] [058/131] (875s left) prime_vgem (busy) [146.067142] Starting subtest: busy [146.067942] Starting dynamic subtest: rcs0 [146.116343] Dynamic subtest rcs0: SUCCESS (0.049s) [146.125498] Starting dynamic subtest: bcs0 [146.135636] Dynamic subtest bcs0: SUCCESS (0.018s) [146.144276] Starting dynamic subtest: vcs0 [146.152315] Dynamic subtest vcs0: SUCCESS (0.016s) [146.160877] Starting dynamic subtest: vcs1 [146.168814] Dynamic subtest vcs1: SUCCESS (0.016s) [146.177267] Starting dynamic subtest: vecs0 [146.183973] Dynamic subtest vecs0: SUCCESS (0.014s) [146.184691] Subtest busy: SUCCESS (0.117s) [146.269487] [059/131] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [146.367440] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [147.805441] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.438s) [147.929926] [060/131] (873s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [148.021730] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [148.022418] Starting dynamic subtest: pipe-A-HDMI-A-1 [148.028933] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [148.035867] Starting dynamic subtest: pipe-B-HDMI-A-1 [148.042514] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [148.049314] Starting dynamic subtest: pipe-C-HDMI-A-1 [148.055919] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [148.062644] Starting dynamic subtest: pipe-D-HDMI-A-1 [148.069414] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [148.070766] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [148.255580] [061/131] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [148.350484] Starting subtest: fbcpsr-1p-rte [148.351903] Subtest fbcpsr-1p-rte: SKIP (0.000s) [148.422666] [062/131] (873s left) gem_create (hog-create) [148.468596] Starting subtest: hog-create [148.469364] Starting dynamic subtest: smem0 [180.729260] Dynamic subtest smem0: SUCCESS (32.260s) [180.730301] Subtest hog-create: SUCCESS (32.261s) [180.893808] [063/131] (840s left) dumb_buffer (map-valid) [180.935152] Starting subtest: map-valid [180.935856] Subtest map-valid: SUCCESS (0.000s) [181.010900] [064/131] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [181.108318] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [181.109670] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [181.186417] [065/131] (840s left) gem_ctx_shared (exec-single-timeline) [181.236767] Starting subtest: exec-single-timeline [181.237562] Starting dynamic subtest: rcs0 [182.314527] Dynamic subtest rcs0: SUCCESS (1.068s) [182.322753] Starting dynamic subtest: bcs0 [183.338400] Dynamic subtest bcs0: SUCCESS (1.022s) [183.347434] Starting dynamic subtest: vcs0 [184.362548] Dynamic subtest vcs0: SUCCESS (1.022s) [184.371854] Starting dynamic subtest: vcs1 [185.386513] Dynamic subtest vcs1: SUCCESS (1.021s) [185.395383] Starting dynamic subtest: vecs0 [186.410574] Dynamic subtest vecs0: SUCCESS (1.022s) [186.411544] Subtest exec-single-timeline: SUCCESS (5.164s) [186.560238] [066/131] (835s left) syncobj_wait (multi-wait-all-for-submit-signaled) [186.601770] Starting subtest: multi-wait-all-for-submit-signaled [186.602458] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [186.644799] [067/131] (835s left) api_intel_bb (render) [186.685897] Starting subtest: render [186.686608] Starting dynamic subtest: render-none-512 [186.775848] Dynamic subtest render-none-512: SUCCESS (0.090s) [186.783021] Starting dynamic subtest: render-none-1024 [187.120097] Dynamic subtest render-none-1024: SUCCESS (0.335s) [187.127146] Starting dynamic subtest: render-x-512 [187.190125] Dynamic subtest render-x-512: SUCCESS (0.078s) [187.197245] Starting dynamic subtest: render-x-1024 [187.507012] Dynamic subtest render-x-1024: SUCCESS (0.307s) [187.514390] Starting dynamic subtest: render-y-512 [187.577491] Dynamic subtest render-y-512: SUCCESS (0.078s) [187.584554] Starting dynamic subtest: render-y-1024 [187.893285] Dynamic subtest render-y-1024: SUCCESS (0.306s) [187.894023] Subtest render: SUCCESS (1.200s) [187.975087] [068/131] (833s left) sysfs_timeslice_duration (timeout) [188.021785] Starting subtest: timeout [188.022534] Starting dynamic subtest: vecs0 [188.967514] Dynamic subtest vecs0: SUCCESS (0.946s) [188.976779] Starting dynamic subtest: vcs0 [189.924270] Dynamic subtest vcs0: SUCCESS (0.954s) [189.934647] Starting dynamic subtest: bcs0 [190.900257] Dynamic subtest bcs0: SUCCESS (0.974s) [190.912921] Starting dynamic subtest: rcs0 [191.842969] Dynamic subtest rcs0: SUCCESS (0.941s) [191.854207] Starting dynamic subtest: vcs1 [192.794083] Dynamic subtest vcs1: SUCCESS (0.949s) [192.795080] Subtest timeout: SUCCESS (4.773s) [192.838895] [069/131] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [192.938448] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [192.939853] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [193.009288] [070/131] (828s left) kms_atomic (crtc-invalid-params-fence) [193.102550] Starting subtest: crtc-invalid-params-fence [193.104362] Starting dynamic subtest: pipe-A-HDMI-A-1 [193.299480] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.196s) [193.300209] Subtest crtc-invalid-params-fence: SUCCESS (0.198s) [193.413222] [071/131] (828s left) kms_chamelium_frames (hdmi-crc-fast) [193.564263] Subtest hdmi-crc-fast: SKIP (0.000s) [193.642037] [072/131] (828s left) gem_eio (execbuf) [193.688163] Starting subtest: execbuf [193.717775] Subtest execbuf: SUCCESS (0.029s) [193.811561] [073/131] (828s left) kms_flip (absolute-wf_vblank) [193.903274] Starting subtest: absolute-wf_vblank [193.905195] Starting dynamic subtest: A-HDMI-A1 [201.611697] Dynamic subtest A-HDMI-A1: SUCCESS (7.685s) [201.619856] Starting dynamic subtest: B-HDMI-A1 [209.285440] Dynamic subtest B-HDMI-A1: SUCCESS (7.671s) [209.292250] Starting dynamic subtest: C-HDMI-A1 [216.948021] Dynamic subtest C-HDMI-A1: SUCCESS (7.651s) [216.962551] Starting dynamic subtest: D-HDMI-A1 [224.577529] Dynamic subtest D-HDMI-A1: SUCCESS (7.656s) [224.578346] Subtest absolute-wf_vblank: SUCCESS (30.672s) [224.717951] [074/131] (797s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [224.813454] Starting subtest: fbcpsr-tiling-4 [224.814863] Subtest fbcpsr-tiling-4: SKIP (0.000s) [224.902363] [075/131] (797s left) kms_big_fb (y-tiled-8bpp-rotate-270) [225.004582] Starting subtest: y-tiled-8bpp-rotate-270 [225.084543] Subtest y-tiled-8bpp-rotate-270: SKIP (0.079s) [225.194783] [076/131] (796s left) perf (gen8-unprivileged-single-ctx-counters) [225.277428] Starting subtest: gen8-unprivileged-single-ctx-counters [225.278959] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [225.299637] [077/131] (796s left) gem_exec_store (pages) [225.347201] Starting subtest: pages [225.347987] Starting dynamic subtest: rcs0 [225.410419] Dynamic subtest rcs0: SUCCESS (0.062s) [225.428155] Starting dynamic subtest: bcs0 [225.477127] Dynamic subtest bcs0: SUCCESS (0.065s) [225.494736] Starting dynamic subtest: vcs0 [225.533740] Dynamic subtest vcs0: SUCCESS (0.054s) [225.546151] Starting dynamic subtest: vcs1 [225.608564] Dynamic subtest vcs1: SUCCESS (0.072s) [225.623693] Starting dynamic subtest: vecs0 [225.679662] Dynamic subtest vecs0: SUCCESS (0.068s) [225.680930] Subtest pages: SUCCESS (0.333s) [225.829760] [078/131] (796s left) kms_big_fb (4-tiled-addfb) [225.926956] Starting subtest: 4-tiled-addfb [225.928377] Subtest 4-tiled-addfb: SKIP (0.000s) [226.019961] [079/131] (796s left) kms_flip (flip-vs-panning) [226.112592] Starting subtest: flip-vs-panning [226.114858] Starting dynamic subtest: A-HDMI-A1 [233.794496] Dynamic subtest A-HDMI-A1: SUCCESS (7.680s) [233.810081] Starting dynamic subtest: B-HDMI-A1 [241.469902] Dynamic subtest B-HDMI-A1: SUCCESS (7.672s) [241.484845] Starting dynamic subtest: C-HDMI-A1 [249.138655] Dynamic subtest C-HDMI-A1: SUCCESS (7.667s) [249.154360] Starting dynamic subtest: D-HDMI-A1 [256.817092] Dynamic subtest D-HDMI-A1: SUCCESS (7.676s) [256.819633] Subtest flip-vs-panning: SUCCESS (30.708s) [256.954240] [080/131] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [257.050542] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [257.051966] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [257.139953] [081/131] (764s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [257.232571] Starting subtest: sprite-rotation-90-pos-100-0 [260.868074] Subtest sprite-rotation-90-pos-100-0: SUCCESS (3.635s) [261.065798] [082/131] (761s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [261.164428] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [261.184375] [083/131] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [261.278861] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [261.280307] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [261.358016] [084/131] (760s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [261.455559] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [261.456983] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [261.533772] [085/131] (760s left) kms_flip (nonblocking-read) [261.628251] Starting subtest: nonblocking-read [261.628986] Subtest nonblocking-read: SUCCESS (0.000s) [261.707364] [086/131] (760s left) syncobj_basic (bad-handle-to-fd) [261.747326] Starting subtest: bad-handle-to-fd [261.748032] Subtest bad-handle-to-fd: SUCCESS (0.000s) [261.800621] [087/131] (760s left) kms_cursor_crc (cursor-onscreen-256x85) [261.897784] Starting subtest: cursor-onscreen-256x85 [261.902557] Starting dynamic subtest: pipe-A-HDMI-A-1 [263.100918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.198s) [263.140169] Starting dynamic subtest: pipe-D-HDMI-A-1 [264.279641] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.150s) [264.280331] Subtest cursor-onscreen-256x85: SUCCESS (2.383s) [264.401401] [088/131] (757s left) gem_exec_schedule (u-semaphore-resolve) [264.455864] Starting subtest: u-semaphore-resolve [264.470935] Subtest u-semaphore-resolve: SUCCESS (0.015s) [264.764924] [089/131] (757s left) kms_joiner (invalid-modeset-big-joiner) [264.864272] Starting subtest: invalid-modeset-big-joiner [264.865621] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [264.900523] [090/131] (757s left) kms_pm_dc (dc3co-vpb-simulation) [265.998419] Starting subtest: dc3co-vpb-simulation [265.999880] Subtest dc3co-vpb-simulation: SKIP (0.000s) [266.034573] [091/131] (756s left) gem_exec_flush (basic-wb-rw-default) [266.082918] Starting subtest: basic-wb-rw-default [271.527880] Subtest basic-wb-rw-default: SUCCESS (5.445s) [271.695822] [092/131] (750s left) gem_userptr_blits (set-cache-level) [271.758029] Starting subtest: set-cache-level [271.758768] Subtest set-cache-level: SUCCESS (0.000s) [271.880638] [093/131] (750s left) kms_hdmi_inject (inject-4k) [271.971489] Starting subtest: inject-4k [272.167690] Subtest inject-4k: SUCCESS (0.196s) [272.278690] [094/131] (750s left) kms_dirtyfb (default-dirtyfb-ioctl) [272.374705] Starting subtest: default-dirtyfb-ioctl [272.375432] Starting dynamic subtest: A-HDMI-A-1 [273.595856] Dynamic subtest A-HDMI-A-1: SUCCESS (1.220s) [273.596558] Subtest default-dirtyfb-ioctl: SUCCESS (1.222s) [273.680271] [095/131] (748s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [273.775859] Starting subtest: short-busy-flip-before-cursor-toggle [273.777378] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [273.811859] [096/131] (748s left) gem_exec_fence (parallel) [273.990025] Starting subtest: parallel [273.991019] Starting dynamic subtest: rcs0 [276.148701] Dynamic subtest rcs0: SUCCESS (2.150s) [276.156385] Starting dynamic subtest: bcs0 [278.299461] Dynamic subtest bcs0: SUCCESS (2.150s) [278.307285] Starting dynamic subtest: vcs0 [280.451747] Dynamic subtest vcs0: SUCCESS (2.152s) [280.459279] Starting dynamic subtest: vcs1 [282.600521] Dynamic subtest vcs1: SUCCESS (2.148s) [282.608560] Starting dynamic subtest: vecs0 [284.749060] Dynamic subtest vecs0: SUCCESS (2.148s) [284.749816] Subtest parallel: SUCCESS (10.751s) [285.203331] [097/131] (737s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [285.298650] Starting subtest: cursorA-vs-flipB-atomic-transitions [285.301061] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [285.338715] [098/131] (737s left) gem_eio (kms) [285.439153] Starting subtest: kms [299.105155] Subtest kms: SUCCESS (13.666s) [299.294298] [099/131] (723s left) kms_lease (master-vs-lease) [299.392778] Starting subtest: master-vs-lease [299.393593] Subtest master-vs-lease: SUCCESS (0.001s) [299.432151] [100/131] (723s left) kms_psr (fbc-psr2-sprite-plane-move) [299.522178] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [299.544098] [101/131] (722s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [299.646789] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [299.648169] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [299.719016] [102/131] (722s left) gem_exec_parallel (engines) [299.768798] Starting subtest: engines [299.769536] Starting dynamic subtest: basic [301.332343] Dynamic subtest basic: SUCCESS (1.563s) [301.347141] Starting dynamic subtest: contexts [303.765792] Dynamic subtest contexts: SUCCESS (2.424s) [303.776477] Starting dynamic subtest: fds [307.832892] Dynamic subtest fds: SUCCESS (4.075s) [307.844711] Starting dynamic subtest: userptr [309.490835] Dynamic subtest userptr: SUCCESS (1.657s) [309.491556] Subtest engines: SUCCESS (9.722s) [309.655313] [103/131] (712s left) sysfs_timeslice_duration (duration) [309.701539] Starting subtest: duration [309.702301] Starting dynamic subtest: vecs0 [309.771620] Dynamic subtest vecs0: SUCCESS (0.069s) [309.791306] Starting dynamic subtest: vcs0 [309.870470] Dynamic subtest vcs0: SUCCESS (0.096s) [309.888803] Starting dynamic subtest: bcs0 [309.953413] Dynamic subtest bcs0: SUCCESS (0.081s) [309.972176] Starting dynamic subtest: rcs0 [310.030469] Dynamic subtest rcs0: SUCCESS (0.075s) [310.048555] Starting dynamic subtest: vcs1 [310.117392] Dynamic subtest vcs1: SUCCESS (0.085s) [310.118735] Subtest duration: SUCCESS (0.416s) [310.169385] [104/131] (712s left) gem_exec_reloc (basic-cpu-wc-noreloc) [310.212007] Starting subtest: basic-cpu-wc-noreloc [310.213910] Subtest basic-cpu-wc-noreloc: SUCCESS (0.002s) [310.309462] [105/131] (712s left) gem_pread (self) [310.352911] Starting subtest: self [310.358383] Subtest self: SUCCESS (0.006s) [310.446133] [106/131] (712s left) gem_spin_batch (engines) [310.495942] Starting subtest: engines [310.496738] Starting dynamic subtest: rcs0 [313.847605] Dynamic subtest rcs0: SUCCESS (3.316s) [313.857490] Starting dynamic subtest: bcs0 [317.166372] Dynamic subtest bcs0: SUCCESS (3.317s) [317.176514] Starting dynamic subtest: vcs0 [320.483537] Dynamic subtest vcs0: SUCCESS (3.315s) [320.493552] Starting dynamic subtest: vcs1 [323.801889] Dynamic subtest vcs1: SUCCESS (3.316s) [323.811823] Starting dynamic subtest: vecs0 [327.094805] Dynamic subtest vecs0: SUCCESS (3.317s) [327.095699] Subtest engines: SUCCESS (16.590s) [327.241529] [107/131] (695s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [327.341447] Starting subtest: psr-shrfb-scaledprimary [327.343021] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [327.416082] [108/131] (695s left) vgem_slow (nohang) [327.455226] Starting subtest: nohang [337.795625] Subtest nohang: SUCCESS (10.308s) [337.812652] [109/131] (684s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [337.854024] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [337.961642] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [338.005776] [110/131] (684s left) kms_vblank (invalid) [338.099699] Starting subtest: invalid [338.101506] Starting dynamic subtest: pipe-A-HDMI-A-1 [338.272711] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.171s) [338.273470] Subtest invalid: SUCCESS (0.173s) [338.380388] [111/131] (684s left) kms_chamelium_audio (dp-audio-edid) [338.527173] Subtest dp-audio-edid: SKIP (0.000s) [338.602426] [112/131] (684s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [338.697435] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [338.698835] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [338.782169] [113/131] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [338.878402] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [338.879813] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [338.973924] [114/131] (683s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [339.075328] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [339.092136] [115/131] (683s left) drm_fdinfo (busy-idle) [339.132041] Starting subtest: busy-idle [339.132842] Starting dynamic subtest: rcs0 [339.752928] Dynamic subtest rcs0: SUCCESS (0.620s) [339.764548] Starting dynamic subtest: bcs0 [340.378059] Dynamic subtest bcs0: SUCCESS (0.622s) [340.388496] Starting dynamic subtest: vcs0 [341.000888] Dynamic subtest vcs0: SUCCESS (0.617s) [341.008547] Starting dynamic subtest: vcs1 [341.620939] Dynamic subtest vcs1: SUCCESS (0.623s) [341.631983] Starting dynamic subtest: vecs0 [342.247999] Dynamic subtest vecs0: SUCCESS (0.625s) [342.248919] Subtest busy-idle: SUCCESS (3.116s) [342.296183] [116/131] (680s left) gen9_exec_parse (bb-chained) [342.340878] Subtest bb-chained: SKIP (0.000s) [342.367647] [117/131] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [342.464448] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [343.565408] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.101s) [343.687537] [118/131] (679s left) gem_ctx_isolation (preservation-reset) [343.850993] Starting subtest: preservation-reset [343.852044] Starting dynamic subtest: rcs0 [343.960961] Dynamic subtest rcs0: SUCCESS (0.118s) [343.969818] Starting dynamic subtest: bcs0 [344.131430] Dynamic subtest bcs0: SUCCESS (0.170s) [344.138714] Starting dynamic subtest: vcs0 [344.286788] Dynamic subtest vcs0: SUCCESS (0.155s) [344.295390] Starting dynamic subtest: vcs1 [344.438155] Dynamic subtest vcs1: SUCCESS (0.150s) [344.445663] Starting dynamic subtest: vecs0 [344.579957] Dynamic subtest vecs0: SUCCESS (0.141s) [344.580883] Subtest preservation-reset: SUCCESS (0.739s) [344.710667] [119/131] (678s left) gem_readwrite (read-write) [344.749995] Starting subtest: read-write [344.752699] Subtest read-write: SUCCESS (0.000s) [344.833699] [120/131] (678s left) kms_addfb_basic (invalid-set-prop-any) [344.871370] Starting subtest: invalid-set-prop-any [344.872110] Subtest invalid-set-prop-any: SUCCESS (0.000s) [345.017503] [121/131] (677s left) syncobj_timeline (multi-wait-submitted-signaled) [345.059364] Starting subtest: multi-wait-submitted-signaled [345.060059] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [345.107297] [122/131] (677s left) kms_psr (psr-sprite-plane-move) [345.198930] Subtest psr-sprite-plane-move: SKIP (0.000s) [345.218086] [123/131] (677s left) kms_flip (2x-flip-vs-suspend) [345.309763] Starting subtest: 2x-flip-vs-suspend [345.318513] Subtest 2x-flip-vs-suspend: SKIP (0.009s) [345.365005] [124/131] (677s left) perf (mi-rpc) [345.449966] Starting subtest: mi-rpc [345.451384] Subtest mi-rpc: SKIP (0.000s) [345.472261] [125/131] (677s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [345.564584] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [345.565298] Starting dynamic subtest: pipe-A [345.698865] Dynamic subtest pipe-A: SUCCESS (0.134s) [345.710462] Starting dynamic subtest: pipe-B [345.852190] Dynamic subtest pipe-B: SUCCESS (0.152s) [345.864263] Starting dynamic subtest: pipe-C [345.995815] Dynamic subtest pipe-C: SUCCESS (0.143s) [346.004822] Starting dynamic subtest: pipe-D [346.138470] Dynamic subtest pipe-D: SUCCESS (0.142s) [346.139169] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.575s) [346.308007] [126/131] (676s left) kms_vblank (query-forked-busy) [346.396475] Starting subtest: query-forked-busy [346.398306] Starting dynamic subtest: pipe-A-HDMI-A-1 [347.697395] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.299s) [347.720277] Starting dynamic subtest: pipe-D-HDMI-A-1 [349.014243] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.308s) [349.015552] Subtest query-forked-busy: SUCCESS (2.618s) [349.136333] [127/131] (673s left) gem_fence_thrash (bo-write-verify-y) [349.175779] Starting subtest: bo-write-verify-y [350.305312] Subtest bo-write-verify-y: SUCCESS (1.121s) [350.361710] [128/131] (672s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [350.403732] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [350.404490] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [350.442933] [129/131] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [350.542526] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [350.543959] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [350.632997] [130/131] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [350.727433] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [350.728899] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [350.818776] [131/131] (672s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [350.909502] Starting subtest: cursorB-vs-flipA-atomic-transitions [350.912153] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [350.954820] Closing watchdogs Done.