[59.028084] Initializing watchdogs [59.028127] /dev/watchdog0 [59.041847] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.046167] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.048787] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.051989] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [59.180382] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [59.182742] Starting dynamic subtest: pipe-A-default-mode [60.307080] Dynamic subtest pipe-A-default-mode: SKIP (1.115s) [60.311555] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.117s) [60.464914] [002/133] (959s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [60.554721] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [60.557151] Starting dynamic subtest: pipe-A-eDP-1 [60.581374] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [60.590162] Starting dynamic subtest: pipe-B-eDP-1 [60.610807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [60.617337] Starting dynamic subtest: pipe-C-eDP-1 [60.639250] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [60.645512] Starting dynamic subtest: pipe-D-eDP-1 [60.670726] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [60.675456] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s) [62.835203] [003/133] (956s left) kms_content_protection (uevent-hdcp14) [62.983412] Starting subtest: uevent-hdcp14 [62.987944] Subtest uevent-hdcp14: SKIP (0.000s) [63.110219] [004/133] (956s left) kms_psr (fbc-psr-cursor-plane-onoff) [63.215715] Starting subtest: fbc-psr-cursor-plane-onoff [63.217632] Starting dynamic subtest: eDP-1 [63.221746] Dynamic subtest eDP-1: SKIP (0.000s) [63.225862] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [63.281962] [005/133] (956s left) kms_getfb (getfb-handle-zero) [63.372839] Starting subtest: getfb-handle-zero [63.375196] Subtest getfb-handle-zero: SUCCESS (0.000s) [63.462178] [006/133] (956s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [63.511685] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [63.592865] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.032s) [63.629352] [007/133] (956s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [63.688678] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [63.693437] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [63.880174] [008/133] (955s left) gem_exec_schedule (independent) [63.950250] Starting subtest: independent [63.952632] Starting dynamic subtest: rcs0 [65.878674] Dynamic subtest rcs0: SUCCESS (1.933s) [65.889990] Starting dynamic subtest: vcs0 [68.004970] Dynamic subtest vcs0: SUCCESS (2.121s) [68.014958] Starting dynamic subtest: vcs1 [69.922862] Dynamic subtest vcs1: SUCCESS (1.913s) [69.937172] Starting dynamic subtest: vecs0 [71.909817] Dynamic subtest vecs0: SUCCESS (1.984s) [71.920035] Starting dynamic subtest: ccs0 [73.879303] Dynamic subtest ccs0: SUCCESS (1.967s) [73.882308] Subtest independent: SUCCESS (9.924s) [74.177527] [009/133] (945s left) gem_exec_params (invalid-bsd-ring) [74.249439] Starting subtest: invalid-bsd-ring [74.251729] Subtest invalid-bsd-ring: SUCCESS (0.000s) [74.348387] [010/133] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [74.450226] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [83.036951] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.585s) [83.147713] [011/133] (936s left) gem_reg_read (timestamp-monotonic) [83.202296] Starting subtest: timestamp-monotonic [87.470405] Subtest timestamp-monotonic: SUCCESS (4.266s) [87.547304] [012/133] (932s left) kms_big_fb (y-tiled-32bpp-rotate-270) [87.664220] Starting subtest: y-tiled-32bpp-rotate-270 [87.668754] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [87.762464] [013/133] (932s left) kms_lease (lease-invalid-crtc) [87.854143] Starting subtest: lease-invalid-crtc [87.856468] Starting dynamic subtest: pipe-A-eDP-1 [87.858669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [87.865524] Starting dynamic subtest: pipe-B-eDP-1 [87.867849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [87.874241] Starting dynamic subtest: pipe-C-eDP-1 [87.876113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [87.882740] Starting dynamic subtest: pipe-D-eDP-1 [87.884992] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [87.887224] Subtest lease-invalid-crtc: SUCCESS (0.002s) [87.921258] [014/133] (932s left) gem_render_copy (linear) [87.991652] Starting subtest: linear [87.993847] Starting dynamic subtest: smem [88.030102] Dynamic subtest smem: SUCCESS (0.041s) [88.032357] Subtest linear: SUCCESS (0.041s) [88.244854] [015/133] (931s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [88.353768] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [95.290619] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.938s) [95.400062] [016/133] (924s left) gem_eio (create-ext) [95.637603] Starting subtest: create-ext [95.952059] Subtest create-ext: SUCCESS (0.318s) [96.107551] [017/133] (924s left) core_getstats (basic) [96.160018] Starting subtest: basic [96.162064] Subtest basic: SUCCESS (0.000s) [96.268581] [018/133] (923s left) kms_big_fb (x-tiled-64bpp-rotate-270) [96.369486] Starting subtest: x-tiled-64bpp-rotate-270 [96.389116] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [96.502829] [019/133] (923s left) syncobj_wait (invalid-single-wait-unsubmitted) [96.550020] Starting subtest: invalid-single-wait-unsubmitted [96.551909] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [96.638762] [020/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [96.724146] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [96.727515] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [96.809449] [021/133] (923s left) kms_invalid_mode (zero-hdisplay) [96.901495] Starting subtest: zero-hdisplay [96.904557] Starting dynamic subtest: pipe-A-eDP-1 [97.195671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [97.204429] Starting dynamic subtest: pipe-B-eDP-1 [97.206626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [97.213540] Starting dynamic subtest: pipe-C-eDP-1 [97.215730] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [97.222651] Starting dynamic subtest: pipe-D-eDP-1 [97.224968] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [97.227182] Subtest zero-hdisplay: SUCCESS (0.304s) [98.071929] [022/133] (922s left) kms_flip (2x-flip-vs-modeset-vs-hang) [98.165758] Starting subtest: 2x-flip-vs-modeset-vs-hang [98.174192] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s) [98.248945] [023/133] (922s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [98.352972] Starting subtest: nonblocking-crc-frame-sequence [98.355184] Starting dynamic subtest: pipe-A-eDP-1 [99.122381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s) [99.129939] Starting dynamic subtest: pipe-B-eDP-1 [100.529559] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s) [100.539140] Starting dynamic subtest: pipe-C-eDP-1 [101.867371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.336s) [101.876935] Starting dynamic subtest: pipe-D-eDP-1 [103.206994] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s) [103.209231] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.853s) [104.010522] [024/133] (916s left) i915_drm_fdinfo (isolation) [104.057715] Starting subtest: isolation [104.060123] Starting dynamic subtest: rcs0 [104.078915] Dynamic subtest rcs0: SKIP (0.021s) [104.087547] Starting dynamic subtest: bcs0 [104.092080] Dynamic subtest bcs0: SKIP (0.000s) [104.099092] Starting dynamic subtest: vcs0 [104.103300] Dynamic subtest vcs0: SKIP (0.000s) [104.110298] Starting dynamic subtest: vcs1 [104.114779] Dynamic subtest vcs1: SKIP (0.000s) [104.121687] Starting dynamic subtest: vecs0 [104.126254] Dynamic subtest vecs0: SKIP (0.000s) [104.133398] Starting dynamic subtest: ccs0 [104.137931] Dynamic subtest ccs0: SKIP (0.000s) [104.142482] Subtest isolation: SKIP (0.024s) [104.175008] [025/133] (916s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [104.567337] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [105.407676] [026/133] (915s left) gem_pxp (hw-rejects-pxp-buffer) [105.538974] Starting subtest: hw-rejects-pxp-buffer [105.544053] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [105.650465] [027/133] (914s left) kms_frontbuffer_tracking (fbc-tiling-4) [105.762817] Starting subtest: fbc-tiling-4 [109.920988] Subtest fbc-tiling-4: SUCCESS (4.161s) [111.127258] [028/133] (909s left) gem_fence_thrash (bo-write-verify-threaded-none) [111.167057] Starting subtest: bo-write-verify-threaded-none [111.181684] Subtest bo-write-verify-threaded-none: SKIP (0.013s) [111.240890] [029/133] (909s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [111.327900] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [111.332099] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [111.394242] [030/133] (909s left) gen9_exec_parse (basic-rejected-ctx-param) [111.451093] Subtest basic-rejected-ctx-param: SKIP (0.000s) [111.525714] [031/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [111.627553] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [111.631798] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [111.702094] [032/133] (908s left) kms_psr (pr-dpms) [111.798551] Starting subtest: pr-dpms [111.802777] Subtest pr-dpms: SKIP (0.000s) [111.879639] [033/133] (908s left) i915_selftest (live) [115.108792] Starting subtest: live [115.111115] Starting dynamic subtest: sanitycheck [119.415183] Dynamic subtest sanitycheck: SUCCESS (4.309s) [119.423706] Starting dynamic subtest: uncore [122.117312] Dynamic subtest uncore: SUCCESS (2.701s) [122.125896] Starting dynamic subtest: workarounds [125.157986] Dynamic subtest workarounds: SUCCESS (3.039s) [125.171253] Starting dynamic subtest: gt_engines [128.092045] Dynamic subtest gt_engines: SUCCESS (2.932s) [128.100396] Starting dynamic subtest: gt_timelines [143.906327] Dynamic subtest gt_timelines: SUCCESS (15.813s) [143.914715] Starting dynamic subtest: gt_contexts [148.170817] Dynamic subtest gt_contexts: SUCCESS (4.264s) [148.179795] Starting dynamic subtest: gt_lrc [152.437862] Dynamic subtest gt_lrc: SUCCESS (4.265s) [152.446410] Starting dynamic subtest: gt_mocs [155.371831] Dynamic subtest gt_mocs: SUCCESS (2.932s) [155.380361] Starting dynamic subtest: gt_pm [162.128710] Dynamic subtest gt_pm: SUCCESS (6.756s) [162.142317] Starting dynamic subtest: gt_heartbeat [166.456342] Dynamic subtest gt_heartbeat: SUCCESS (4.326s) [166.465057] Starting dynamic subtest: gt_tlb [175.673074] Dynamic subtest gt_tlb: SUCCESS (9.216s) [175.685501] Starting dynamic subtest: requests [189.141487] Dynamic subtest requests: SUCCESS (13.466s) [189.150347] Starting dynamic subtest: migrate [194.893710] Dynamic subtest migrate: SUCCESS (5.751s) [194.902226] Starting dynamic subtest: active [199.171069] Dynamic subtest active: SUCCESS (4.276s) [199.179429] Starting dynamic subtest: objects [203.793773] Dynamic subtest objects: SUCCESS (4.622s) [203.810452] Starting dynamic subtest: mman [207.337839] Dynamic subtest mman: SUCCESS (3.541s) [207.346630] Starting dynamic subtest: dmabuf [211.671231] Dynamic subtest dmabuf: SUCCESS (4.332s) [211.679658] Starting dynamic subtest: vma [216.025836] Dynamic subtest vma: SUCCESS (4.354s) [216.034505] Starting dynamic subtest: coherency [219.857039] Dynamic subtest coherency: SUCCESS (3.828s) [219.865712] Starting dynamic subtest: gtt [231.555870] Dynamic subtest gtt: SUCCESS (11.697s) [231.564826] Starting dynamic subtest: gem [239.554871] Dynamic subtest gem: SUCCESS (7.998s) [239.562054] Starting dynamic subtest: evict [243.602176] Dynamic subtest evict: SUCCESS (4.045s) [243.610723] Starting dynamic subtest: hugepages [252.371723] Dynamic subtest hugepages: SUCCESS (8.768s) [252.380698] Starting dynamic subtest: gem_contexts [280.847823] Dynamic subtest gem_contexts: SUCCESS (28.474s) [280.856882] Starting dynamic subtest: client [285.196852] Dynamic subtest client: SUCCESS (4.348s) [285.205917] Starting dynamic subtest: gem_migrate [289.457872] Dynamic subtest gem_migrate: SUCCESS (4.260s) [289.466055] Starting dynamic subtest: reset [292.136854] Dynamic subtest reset: SUCCESS (2.678s) [292.145969] Starting dynamic subtest: memory_region [296.430765] Dynamic subtest memory_region: SUCCESS (4.292s) [296.439196] Starting dynamic subtest: hangcheck [309.167223] Dynamic subtest hangcheck: SUCCESS (12.734s) [309.176063] Starting dynamic subtest: execlists [313.908507] Dynamic subtest execlists: SUCCESS (4.738s) [313.917871] Starting dynamic subtest: ring_submission [316.512708] Dynamic subtest ring_submission: SUCCESS (2.601s) [316.520106] Starting dynamic subtest: perf [320.833512] Dynamic subtest perf: SUCCESS (4.318s) [320.842223] Starting dynamic subtest: slpc [332.873312] Dynamic subtest slpc: SUCCESS (12.037s) [332.882261] Starting dynamic subtest: guc [336.860884] Dynamic subtest guc: SUCCESS (3.986s) [336.868916] Starting dynamic subtest: guc_multi_lrc [341.178038] Dynamic subtest guc_multi_lrc: SUCCESS (4.316s) [341.186621] Starting dynamic subtest: guc_hang [345.895997] Dynamic subtest guc_hang: SUCCESS (4.716s) [345.903679] Starting dynamic subtest: late_gt_pm [348.554061] Dynamic subtest late_gt_pm: SUCCESS (2.655s) [348.556847] Subtest live: SUCCESS (233.438s) [348.605617] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [348.609015] [034/133] (672s left) kms_addfb_basic (bo-too-small-due-to-tiling) [350.115809] Starting subtest: bo-too-small-due-to-tiling [350.120140] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [350.209457] [FACT kms_addfb_basic (bo-too-small-due-to-tiling)] new: kernel.kmod_is_loaded.i915: true [350.213299] [035/133] (670s left) gem_exec_store (cachelines) [350.280306] Starting subtest: cachelines [350.282660] Starting dynamic subtest: rcs0 [350.356266] Dynamic subtest rcs0: SUCCESS (0.076s) [350.366132] Starting dynamic subtest: bcs0 [350.414605] Dynamic subtest bcs0: SUCCESS (0.056s) [350.423595] Starting dynamic subtest: vcs0 [350.466149] Dynamic subtest vcs0: SUCCESS (0.051s) [350.475220] Starting dynamic subtest: vcs1 [350.524295] Dynamic subtest vcs1: SUCCESS (0.056s) [350.531347] Starting dynamic subtest: vecs0 [350.577144] Dynamic subtest vecs0: SUCCESS (0.051s) [350.586689] Starting dynamic subtest: ccs0 [350.634194] Dynamic subtest ccs0: SUCCESS (0.055s) [350.636624] Subtest cachelines: SUCCESS (0.355s) [350.813592] [036/133] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [350.911339] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [355.329966] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.422s) [356.505900] [037/133] (664s left) gem_wait (await) [356.575580] Starting subtest: await [356.577798] Starting dynamic subtest: all-engines [357.698090] Dynamic subtest all-engines: SUCCESS (1.125s) [357.713721] Starting dynamic subtest: rcs0 [358.752672] Dynamic subtest rcs0: SUCCESS (1.053s) [358.767614] Starting dynamic subtest: bcs0 [359.809195] Dynamic subtest bcs0: SUCCESS (1.054s) [359.824160] Starting dynamic subtest: vcs0 [360.862059] Dynamic subtest vcs0: SUCCESS (1.051s) [360.876706] Starting dynamic subtest: vcs1 [361.915454] Dynamic subtest vcs1: SUCCESS (1.051s) [361.930326] Starting dynamic subtest: vecs0 [362.968331] Dynamic subtest vecs0: SUCCESS (1.051s) [362.982576] Starting dynamic subtest: ccs0 [364.025826] Dynamic subtest ccs0: SUCCESS (1.055s) [364.028637] Subtest await: SUCCESS (7.454s) [364.216973] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [364.221226] [038/133] (656s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [364.338480] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [364.342836] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [364.424284] [039/133] (656s left) syncobj_wait (wait-all-for-submit-complex) [364.481032] Starting subtest: wait-all-for-submit-complex [364.693968] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [364.780577] [040/133] (656s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [364.830843] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [364.936251] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [365.016765] [041/133] (656s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [365.115088] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [365.119256] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [365.243444] [042/133] (655s left) kms_big_fb (linear-16bpp-rotate-90) [365.347565] Starting subtest: linear-16bpp-rotate-90 [365.366457] Subtest linear-16bpp-rotate-90: SKIP (0.018s) [365.463797] [043/133] (655s left) gem_exec_reloc (basic-write-read-active) [365.525542] Subtest basic-write-read-active: SKIP (0.000s) [365.589533] [044/133] (655s left) gem_create (create-ext-cpu-access-big) [365.755551] Starting subtest: create-ext-cpu-access-big [365.760044] Subtest create-ext-cpu-access-big: SKIP (0.001s) [365.833382] [045/133] (655s left) gem_mmap_wc (bad-size) [365.886044] Subtest bad-size: SKIP (0.000s) [365.941896] [046/133] (655s left) api_intel_allocator (gem-pool) [365.999488] Starting subtest: gem-pool [366.007310] Subtest gem-pool: SUCCESS (0.009s) [366.128643] [047/133] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [366.230965] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [366.235467] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [366.310487] [048/133] (655s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [366.357303] Starting subtest: etime-multi-wait-all-available-unsubmitted [366.464786] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s) [366.539671] [049/133] (654s left) gem_mmap_offset (clear) [366.594694] Starting subtest: clear [366.597797] Starting dynamic subtest: smem0 [392.226267] Dynamic subtest smem0: SUCCESS (25.629s) [392.228432] Subtest clear: SUCCESS (25.630s) [392.370276] [050/133] (629s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [392.508591] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [392.512675] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [392.592984] [051/133] (628s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [392.685279] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [392.687567] Starting dynamic subtest: pipe-A-eDP-1 [392.710891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [392.721369] Starting dynamic subtest: pipe-B-eDP-1 [392.743025] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [392.751218] Starting dynamic subtest: pipe-C-eDP-1 [392.772832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [392.782742] Starting dynamic subtest: pipe-D-eDP-1 [392.805025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [392.809117] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s) [395.075843] [052/133] (626s left) kms_addfb_basic (no-handle) [395.123068] Starting subtest: no-handle [395.125488] Subtest no-handle: SUCCESS (0.000s) [395.248057] [053/133] (626s left) kms_flip (flip-vs-suspend-interruptible) [395.349678] Starting subtest: flip-vs-suspend-interruptible [395.352079] Starting dynamic subtest: A-eDP1 [444.037034] Dynamic subtest A-eDP1: SUCCESS (4.745s) [444.046630] Starting dynamic subtest: B-eDP1 [493.041317] Dynamic subtest B-eDP1: SUCCESS (4.459s) [493.050757] Starting dynamic subtest: C-eDP1 [542.051364] Dynamic subtest C-eDP1: SUCCESS (4.471s) [542.061537] Starting dynamic subtest: D-eDP1 [591.051199] Dynamic subtest D-eDP1: SUCCESS (4.446s) [591.057158] Subtest flip-vs-suspend-interruptible: SUCCESS (18.131s) [592.244001] [054/133] (429s left) i915_pm_rpm (debugfs-read) [594.397265] Starting subtest: debugfs-read [595.554733] Subtest debugfs-read: SUCCESS (1.152s) [595.945212] [055/133] (425s left) gem_exec_balancer (sliced) [596.001799] Starting subtest: sliced [596.007819] Subtest sliced: SKIP (0.000s) [596.307815] [056/133] (425s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [596.381838] Starting subtest: multi-wait-available-unsubmitted-signaled [596.384963] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [596.471869] [057/133] (425s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [596.591000] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [596.596061] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [596.733652] [058/133] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [596.838040] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [603.966715] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.108s) [604.102460] [059/133] (417s left) kms_cursor_crc (cursor-offscreen-256x256) [604.333826] Starting subtest: cursor-offscreen-256x256 [604.340214] Starting dynamic subtest: pipe-A-eDP-1 [606.278721] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [606.305426] Starting dynamic subtest: pipe-D-eDP-1 [608.904744] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s) [608.907016] Subtest cursor-offscreen-256x256: SUCCESS (4.559s) [609.760814] [060/133] (412s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [609.821237] Starting subtest: multi-wait-for-submit-submitted-signaled [609.824095] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [609.936133] [061/133] (411s left) perf (oa-exponents) [610.081569] Starting subtest: oa-exponents [610.083484] Starting dynamic subtest: 0-rcs0 [611.869785] Dynamic subtest 0-rcs0: SUCCESS (1.786s) [611.880278] Starting dynamic subtest: 1-vcs1 [613.704121] Dynamic subtest 1-vcs1: SUCCESS (1.831s) [613.707103] Subtest oa-exponents: SUCCESS (3.619s) [613.753311] [062/133] (408s left) gem_workarounds (reset) [613.815241] Starting subtest: reset [613.990117] Subtest reset: SUCCESS (0.175s) [614.107803] [063/133] (407s left) prime_mmap (test_correct) [614.164778] Starting subtest: test_correct [614.167042] Starting dynamic subtest: test_correct-smem [614.210215] Dynamic subtest test_correct-smem: SUCCESS (0.047s) [614.212871] Subtest test_correct: SUCCESS (0.049s) [614.324516] [064/133] (407s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [614.433019] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [615.501508] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.067s) [615.613032] [065/133] (406s left) kms_vrr (seamless-rr-switch-virtual) [615.708988] Starting subtest: seamless-rr-switch-virtual [615.715818] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [615.778860] [066/133] (406s left) kms_cursor_edge_walk (256x256-right-edge) [615.865463] Starting subtest: 256x256-right-edge [615.867600] Starting dynamic subtest: pipe-A-eDP-1 [619.329213] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s) [619.340207] Starting dynamic subtest: pipe-D-eDP-1 [622.458321] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s) [622.461187] Subtest 256x256-right-edge: SUCCESS (6.589s) [623.273159] [067/133] (398s left) kms_flip (2x-plain-flip-ts-check) [623.368979] Starting subtest: 2x-plain-flip-ts-check [623.393669] Subtest 2x-plain-flip-ts-check: SKIP (0.023s) [623.492715] [068/133] (398s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [623.589655] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [623.594946] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [623.714222] [069/133] (398s left) sw_sync (sync_multi_producer_single_consumer) [623.758356] Starting subtest: sync_multi_producer_single_consumer [624.847103] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [624.915902] [070/133] (397s left) kms_plane_scaling (planes-scaler-unity-scaling) [625.024069] Starting subtest: planes-scaler-unity-scaling [625.027029] Starting dynamic subtest: pipe-A [625.087087] Dynamic subtest pipe-A: SUCCESS (0.064s) [625.099048] Starting dynamic subtest: pipe-B [626.241149] Dynamic subtest pipe-B: SUCCESS (1.140s) [626.252637] Starting dynamic subtest: pipe-C [627.359969] Dynamic subtest pipe-C: SUCCESS (1.107s) [627.370547] Starting dynamic subtest: pipe-D [628.509536] Dynamic subtest pipe-D: SUCCESS (1.139s) [628.512217] Subtest planes-scaler-unity-scaling: SUCCESS (3.454s) [629.683770] [071/133] (392s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [629.791371] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [633.385859] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.580s) [634.614493] [072/133] (387s left) kms_psr (psr2-cursor-mmap-cpu) [634.710693] Starting subtest: psr2-cursor-mmap-cpu [634.713183] Starting dynamic subtest: eDP-1 [636.409948] Dynamic subtest eDP-1: SUCCESS (1.693s) [636.412552] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.694s) [637.281427] [073/133] (385s left) kms_psr (psr-sprite-plane-move) [637.371982] Starting subtest: psr-sprite-plane-move [637.374656] Starting dynamic subtest: eDP-1 [639.125927] Dynamic subtest eDP-1: SUCCESS (1.749s) [639.128806] Subtest psr-sprite-plane-move: SUCCESS (1.750s) [639.946340] [074/133] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [640.058193] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [646.615178] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.552s) [646.729573] [075/133] (375s left) kms_cursor_crc (cursor-random-64x21) [646.932459] Starting subtest: cursor-random-64x21 [646.980469] Subtest cursor-random-64x21: SKIP (0.043s) [647.215551] [076/133] (375s left) perf (disabled-read-error) [647.313540] Starting subtest: disabled-read-error [647.329023] Subtest disabled-read-error: SUCCESS (0.015s) [647.380363] [077/133] (375s left) gem_wait (invalid-flags) [647.437967] Starting subtest: invalid-flags [647.440871] Subtest invalid-flags: SUCCESS (0.000s) [647.656762] [078/133] (374s left) gem_spin_batch (spin-all-new) [647.709150] Starting subtest: spin-all-new [647.724547] Subtest spin-all-new: SUCCESS (0.015s) [649.277518] [079/133] (373s left) kms_async_flips (invalid-async-flip-atomic) [649.376033] Starting subtest: invalid-async-flip-atomic [649.761143] Starting dynamic subtest: pipe-A-eDP-1 [650.607742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.845s) [650.966223] Starting dynamic subtest: pipe-B-eDP-1 [651.751245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s) [652.113709] Starting dynamic subtest: pipe-C-eDP-1 [652.874043] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s) [653.228521] Starting dynamic subtest: pipe-D-eDP-1 [654.017147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.794s) [654.019951] Subtest invalid-async-flip-atomic: SUCCESS (4.637s) [655.172561] [080/133] (367s left) prime_mmap_kms (buffer-sharing) [655.273988] Starting subtest: buffer-sharing [655.712023] Subtest buffer-sharing: SUCCESS (0.437s) [656.501459] [081/133] (366s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [656.588066] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [656.593039] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [656.660232] [082/133] (366s left) syncobj_timeline (invalid-query-illegal-handle) [656.721078] Starting subtest: invalid-query-illegal-handle [656.723697] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [656.818837] [083/133] (366s left) kms_hdr (bpc-switch) [656.924656] Starting subtest: bpc-switch [657.978128] Starting dynamic subtest: pipe-A-eDP-1 [661.473985] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s) [661.476923] Subtest bpc-switch: SUCCESS (4.553s) [661.575709] [084/133] (361s left) gem_exec_fence (invalid-timeline-fence-array) [662.114443] Starting subtest: invalid-timeline-fence-array [662.121209] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [663.332906] [085/133] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [663.447062] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [663.452229] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [663.546433] [086/133] (359s left) kms_prop_blob (blob-prop-core) [663.598045] Starting subtest: blob-prop-core [663.600844] Subtest blob-prop-core: SUCCESS (0.000s) [663.703857] [087/133] (359s left) fbdev (unaligned-write) [663.745200] Starting subtest: unaligned-write [663.873220] Subtest unaligned-write: SUCCESS (0.128s) [663.936563] [088/133] (359s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [664.035578] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [664.040802] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [664.134728] [089/133] (358s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [664.246835] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [664.249348] Starting dynamic subtest: pipe-A-eDP-1 [664.312475] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [664.323216] Starting dynamic subtest: pipe-B-eDP-1 [664.393600] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [664.404053] Starting dynamic subtest: pipe-C-eDP-1 [664.472971] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [664.483845] Starting dynamic subtest: pipe-D-eDP-1 [664.549581] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [664.554503] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s) [666.420315] [090/133] (356s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [666.509075] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [666.515137] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [666.608221] [091/133] (356s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [666.734805] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [666.739891] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [666.805196] [092/133] (356s left) kms_pm_dc (dc5-retention-flops) [667.906911] Starting subtest: dc5-retention-flops [667.911899] Subtest dc5-retention-flops: SKIP (0.000s) [667.977556] [093/133] (355s left) kms_color (ctm-blue-to-red) [668.072120] Starting subtest: ctm-blue-to-red [668.074498] Starting dynamic subtest: pipe-A-eDP-1 [668.764018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s) [668.775134] Starting dynamic subtest: pipe-B-eDP-1 [670.152945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [670.163971] Starting dynamic subtest: pipe-C-eDP-1 [671.493245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [671.504547] Starting dynamic subtest: pipe-D-eDP-1 [672.843020] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s) [672.845945] Subtest ctm-blue-to-red: SUCCESS (4.774s) [673.667556] [094/133] (349s left) kms_chamelium_hpd (dp-hpd-fast) [674.056560] Subtest dp-hpd-fast: SKIP (0.000s) [674.881677] [095/133] (348s left) perf_pmu (busy-start) [674.924033] Starting subtest: busy-start [674.927051] Starting dynamic subtest: rcs0 [677.474735] Dynamic subtest rcs0: SUCCESS (2.552s) [677.489236] Starting dynamic subtest: bcs0 [680.033278] Dynamic subtest bcs0: SUCCESS (2.554s) [680.055201] Starting dynamic subtest: vcs0 [683.210250] Dynamic subtest vcs0: SUCCESS (3.173s) [683.223205] Starting dynamic subtest: vcs1 [687.241379] Dynamic subtest vcs1: SUCCESS (4.027s) [687.254027] Starting dynamic subtest: vecs0 [691.273693] Dynamic subtest vecs0: SUCCESS (4.029s) [691.286466] Starting dynamic subtest: ccs0 [693.824287] Dynamic subtest ccs0: SUCCESS (2.548s) [693.827037] Subtest busy-start: SUCCESS (18.898s) [693.936997] [096/133] (329s left) kms_pm_rpm (system-suspend-idle) [695.466691] Starting subtest: system-suspend-idle [714.577648] Subtest system-suspend-idle: SUCCESS (4.550s) [714.976847] [097/133] (308s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [715.085355] Starting subtest: psr2-primary-plane-update-sf-dmg-area [715.087901] Starting dynamic subtest: pipe-A-eDP-1 [721.030419] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.864s) [721.042698] Starting dynamic subtest: pipe-B-eDP-1 [727.737630] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s) [727.740214] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.527s) [728.612443] [098/133] (294s left) kms_setmode (basic) [728.675581] Starting subtest: basic [729.024417] Starting dynamic subtest: pipe-A-eDP-1 [732.643719] Dynamic subtest pipe-A-eDP-1: FAIL (3.479s) [732.856237] Starting dynamic subtest: pipe-B-eDP-1 [736.476602] Dynamic subtest pipe-B-eDP-1: FAIL (3.465s) [736.638397] Subtest basic: FAIL (7.940s) [737.514807] [099/133] (286s left) kms_psr (fbc-pr-sprite-blt) [737.611509] Starting subtest: fbc-pr-sprite-blt [737.616595] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [737.683377] [100/133] (285s left) kms_flip (flip-vs-panning) [737.783085] Starting subtest: flip-vs-panning [737.785381] Starting dynamic subtest: A-eDP1 [746.522211] Dynamic subtest A-eDP1: SUCCESS (8.739s) [746.548086] Starting dynamic subtest: B-eDP1 [755.262938] Dynamic subtest B-eDP1: SUCCESS (8.740s) [755.275232] Starting dynamic subtest: C-eDP1 [763.984793] Dynamic subtest C-eDP1: SUCCESS (8.720s) [763.995055] Starting dynamic subtest: D-eDP1 [772.708140] Dynamic subtest D-eDP1: SUCCESS (8.720s) [772.713191] Subtest flip-vs-panning: SUCCESS (34.934s) [773.960715] [101/133] (249s left) kms_vblank (ts-continuation-modeset) [774.055471] Starting subtest: ts-continuation-modeset [774.057788] Starting dynamic subtest: pipe-A-eDP-1 [775.516989] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.463s) [775.531774] Starting dynamic subtest: pipe-D-eDP-1 [777.687262] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.168s) [777.689852] Subtest ts-continuation-modeset: SUCCESS (3.634s) [778.499679] [102/133] (245s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [778.551407] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [778.608618] [103/133] (245s left) kms_async_flips (async-flip-hang) [778.701448] Starting subtest: async-flip-hang [779.072246] Starting dynamic subtest: pipe-A-eDP-1 [794.203650] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.126s) [794.593771] Starting dynamic subtest: pipe-B-eDP-1 [810.196578] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.606s) [810.568448] Starting dynamic subtest: pipe-C-eDP-1 [826.189745] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.634s) [826.574391] Starting dynamic subtest: pipe-D-eDP-1 [842.255690] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.691s) [842.259605] Subtest async-flip-hang: SUCCESS (63.556s) [843.424120] [104/133] (180s left) gem_exec_balancer (bonded-semaphore) [843.493223] Starting subtest: bonded-semaphore [843.498618] Subtest bonded-semaphore: SKIP (0.000s) [843.782907] [105/133] (180s left) gem_userptr_blits (sync-overlap) [843.853471] Starting subtest: sync-overlap [843.856142] Subtest sync-overlap: SUCCESS (0.000s) [843.959782] [106/133] (179s left) kms_flip (2x-flip-vs-modeset) [844.051981] Starting subtest: 2x-flip-vs-modeset [844.063626] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [844.142479] [107/133] (179s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [844.238369] Starting subtest: extended-pageflip-modeset-hang-oldfb [844.241071] Starting dynamic subtest: pipe-A [852.145261] Dynamic subtest pipe-A: SUCCESS (7.908s) [852.157470] Starting dynamic subtest: pipe-D [860.732269] Dynamic subtest pipe-D: SUCCESS (8.581s) [860.735024] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.493s) [861.579006] [108/133] (162s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [861.671606] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [861.674484] Starting dynamic subtest: pipe-A-eDP-1 [861.701205] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [861.713067] Starting dynamic subtest: pipe-B-eDP-1 [861.738603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [861.748453] Starting dynamic subtest: pipe-C-eDP-1 [861.773843] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [861.783398] Starting dynamic subtest: pipe-D-eDP-1 [861.808422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [861.813459] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s) [863.863302] [109/133] (160s left) kms_vblank (query-busy) [863.953520] Starting subtest: query-busy [863.956297] Starting dynamic subtest: pipe-A-eDP-1 [865.844443] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s) [865.861207] Starting dynamic subtest: pipe-D-eDP-1 [868.442248] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.598s) [868.444974] Subtest query-busy: SUCCESS (4.491s) [869.237635] [110/133] (154s left) syncobj_timeline (wait-all-snapshot) [869.292604] Starting subtest: wait-all-snapshot [869.374325] Subtest wait-all-snapshot: SUCCESS (0.083s) [869.454964] [111/133] (154s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [869.572186] Starting subtest: cursorA-vs-flipB-atomic [869.576750] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [869.714624] [112/133] (154s left) gem_ctx_persistence (legacy-engines-queued) [869.775604] Starting subtest: legacy-engines-queued [869.778413] Starting dynamic subtest: render [869.850149] Dynamic subtest render: SUCCESS (0.077s) [869.863343] Starting dynamic subtest: bsd1 [871.705228] Dynamic subtest bsd1: SUCCESS (1.851s) [871.719341] Starting dynamic subtest: bsd2 [873.688180] Dynamic subtest bsd2: SUCCESS (1.979s) [873.703048] Starting dynamic subtest: blt [873.718889] Dynamic subtest blt: SUCCESS (0.028s) [873.729602] Starting dynamic subtest: vebox [875.736607] Dynamic subtest vebox: SUCCESS (2.015s) [875.739586] Subtest legacy-engines-queued: SUCCESS (5.964s) [875.832860] [113/133] (148s left) gem_ctx_bad_destroy (double-destroy) [875.885223] Starting subtest: double-destroy [875.887950] Subtest double-destroy: SUCCESS (0.000s) [875.961804] [114/133] (148s left) gem_mmap_wc (read-write-distinct) [876.026074] Subtest read-write-distinct: SKIP (0.000s) [876.082366] [115/133] (148s left) kms_draw_crc (draw-method-pwrite) [876.188992] Starting subtest: draw-method-pwrite [876.191326] Starting dynamic subtest: xrgb8888-untiled [876.743373] Dynamic subtest xrgb8888-untiled: SUCCESS (0.555s) [876.753608] Starting dynamic subtest: rgb565-untiled [877.209617] Dynamic subtest rgb565-untiled: SUCCESS (0.465s) [877.219341] Starting dynamic subtest: xrgb2101010-untiled [877.754485] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [877.767796] Starting dynamic subtest: xbgr16161616f-untiled [878.520833] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s) [878.530847] Starting dynamic subtest: xrgb8888-xtiled [880.265924] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.744s) [880.275737] Starting dynamic subtest: rgb565-xtiled [881.332427] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s) [881.344601] Starting dynamic subtest: xrgb2101010-xtiled [883.067645] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.733s) [883.077683] Starting dynamic subtest: xbgr16161616f-xtiled [886.633587] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.565s) [886.644595] Starting dynamic subtest: xrgb8888-4tiled [887.711866] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s) [887.722220] Starting dynamic subtest: rgb565-4tiled [888.278759] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s) [888.288907] Starting dynamic subtest: xrgb2101010-4tiled [889.358396] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s) [889.369305] Starting dynamic subtest: xbgr16161616f-4tiled [892.267999] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.908s) [892.270467] Subtest draw-method-pwrite: SUCCESS (16.078s) [892.388377] [116/133] (131s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [892.498322] Starting subtest: fbc-indfb-scaledprimary [895.427239] Subtest fbc-indfb-scaledprimary: SUCCESS (2.935s) [896.564922] [117/133] (127s left) gem_exec_schedule (u-submit-early-slice) [896.647286] Starting subtest: u-submit-early-slice [896.650109] Starting dynamic subtest: rcs0 [896.677330] Dynamic subtest rcs0: SUCCESS (0.044s) [896.689247] Starting dynamic subtest: bcs0 [896.713436] Dynamic subtest bcs0: SUCCESS (0.036s) [896.723073] Starting dynamic subtest: vcs0 [896.760380] Dynamic subtest vcs0: SUCCESS (0.046s) [896.770437] Starting dynamic subtest: vcs1 [896.799593] Dynamic subtest vcs1: SUCCESS (0.038s) [896.810505] Starting dynamic subtest: vecs0 [896.838914] Dynamic subtest vecs0: SUCCESS (0.038s) [896.851195] Starting dynamic subtest: ccs0 [896.877372] Dynamic subtest ccs0: SUCCESS (0.038s) [896.880338] Subtest u-submit-early-slice: SUCCESS (0.245s) [897.815890] [118/133] (126s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [897.878498] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [897.947990] [119/133] (126s left) gem_exec_whisper (basic-queues-priority-all) [898.004123] Starting subtest: basic-queues-priority-all [920.166636] Subtest basic-queues-priority-all: SUCCESS (22.155s) [920.354794] [120/133] (104s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [920.460381] Starting subtest: psr-indfb-scaledprimary [926.178459] Subtest psr-indfb-scaledprimary: SUCCESS (5.721s) [926.294876] [121/133] ( 98s left) gem_exec_reloc (basic-active) [926.359726] Subtest basic-active: SKIP (0.000s) [926.430111] [122/133] ( 98s left) kms_rotation_crc (primary-rotation-90) [926.519857] Starting subtest: primary-rotation-90 [926.524473] Subtest primary-rotation-90: SKIP (0.001s) [926.597840] [123/133] ( 97s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [926.719640] Starting subtest: short-flip-before-cursor-atomic-transitions [927.681233] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.960s) [928.485362] [124/133] ( 96s left) sysfs_preempt_timeout (invalid) [928.550485] Starting subtest: invalid [928.553314] Starting dynamic subtest: vecs0 [928.556120] Dynamic subtest vecs0: SUCCESS (0.000s) [928.567429] Starting dynamic subtest: ccs0 [928.569538] Dynamic subtest ccs0: SUCCESS (0.000s) [928.578840] Starting dynamic subtest: vcs0 [928.581180] Dynamic subtest vcs0: SUCCESS (0.000s) [928.590392] Starting dynamic subtest: bcs0 [928.593074] Dynamic subtest bcs0: SUCCESS (0.000s) [928.602604] Starting dynamic subtest: rcs0 [928.605350] Dynamic subtest rcs0: SUCCESS (0.000s) [928.615056] Starting dynamic subtest: vcs1 [928.617364] Dynamic subtest vcs1: SUCCESS (0.000s) [928.619591] Subtest invalid: SUCCESS (0.005s) [928.658144] [125/133] ( 95s left) kms_big_fb (4-tiled-16bpp-rotate-270) [928.748202] Starting subtest: 4-tiled-16bpp-rotate-270 [928.767456] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s) [928.881494] [126/133] ( 95s left) kms_dp_aux_dev [929.229422] [127/133] ( 95s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [929.327673] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [929.333124] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [929.422288] [128/133] ( 95s left) kms_chamelium_audio (dp-audio) [929.801373] Subtest dp-audio: SKIP (0.000s) [930.592450] [129/133] ( 94s left) dmabuf_sync_file (export-basic) [930.641460] Starting subtest: export-basic [930.644345] Subtest export-basic: SUCCESS (0.001s) [930.702305] [130/133] ( 94s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [930.792869] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [930.798380] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [930.874315] [131/133] ( 94s left) gem_sync (basic-store-each) [930.941832] Starting subtest: basic-store-each [933.287634] Subtest basic-store-each: SUCCESS (2.359s) [933.477425] [132/133] ( 91s left) i915_drm_fdinfo (virtual-busy-hang-all) [933.522368] Starting subtest: virtual-busy-hang-all [933.527543] Subtest virtual-busy-hang-all: SKIP (0.000s) [933.600953] [133/133] ( 91s left) gem_ctx_param (invalid-set-ringsize) [933.659887] Starting subtest: invalid-set-ringsize [933.662321] Subtest invalid-set-ringsize: SUCCESS (0.000s) [933.739221] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_content_protection results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_getfb results: parsing output: 5/ for test: sriov_basic results: parsing output: 6/ for test: gem_render_copy results: parsing output: 7/ for test: gem_exec_schedule results: parsing output: 8/ for test: gem_exec_params results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_reg_read results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_lease results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_eio results: parsing output: 16/ for test: core_getstats results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_invalid_mode results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_pipe_crc_basic results: parsing output: 23/ for test: i915_drm_fdinfo results: parsing output: 24/ for test: kms_chamelium_edid results: parsing output: 25/ for test: gem_pxp results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_fence_thrash results: parsing output: 28/ for test: kms_plane results: parsing output: 29/ for test: gen9_exec_parse results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: i915_selftest results: parsing output: 33/ for test: kms_addfb_basic results: parsing output: 34/ for test: gem_exec_store results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_wait results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: gem_create results: parsing output: 44/ for test: gem_mmap_wc results: parsing output: 45/ for test: api_intel_allocator results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_mmap_offset results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: kms_addfb_basic results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: i915_pm_rpm results: parsing output: 54/ for test: gem_exec_balancer results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: gem_workarounds results: parsing output: 62/ for test: prime_mmap results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_vrr results: parsing output: 65/ for test: kms_cursor_edge_walk results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: sw_sync results: parsing output: 69/ for test: kms_plane_scaling results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: perf results: parsing output: 76/ for test: gem_wait results: parsing output: 77/ for test: gem_spin_batch results: parsing output: 78/ for test: kms_async_flips results: parsing output: 79/ for test: prime_mmap_kms results: parsing output: 80/ for test: kms_plane results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_hdr results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_prop_blob results: parsing output: 86/ for test: fbdev results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: kms_psr2_sf results: parsing output: 91/ for test: kms_pm_dc results: parsing output: 92/ for test: kms_color results: parsing output: 93/ for test: kms_chamelium_hpd results: parsing output: 94/ for test: perf_pmu results: parsing output: 95/ for test: kms_pm_rpm results: parsing output: 96/ for test: kms_psr2_sf results: parsing output: 97/ for test: kms_setmode results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_flip results: parsing output: 100/ for test: kms_vblank results: parsing output: 101/ for test: kms_pipe_b_c_ivb results: parsing output: 102/ for test: kms_async_flips results: parsing output: 103/ for test: gem_exec_balancer results: parsing output: 104/ for test: gem_userptr_blits results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_busy results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: kms_vblank results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_cursor_legacy results: parsing output: 111/ for test: gem_ctx_persistence results: parsing output: 112/ for test: gem_ctx_bad_destroy results: parsing output: 113/ for test: gem_mmap_wc results: parsing output: 114/ for test: kms_draw_crc results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_exec_schedule results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: gem_exec_whisper results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: kms_rotation_crc results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: sysfs_preempt_timeout results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_dp_aux_dev results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_chamelium_audio results: parsing output: 128/ for test: dmabuf_sync_file results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_sync results: parsing output: 131/ for test: i915_drm_fdinfo results: parsing output: 132/ for test: gem_ctx_param Done.